[66.281125] Initializing watchdogs
[66.281203]   /dev/watchdog0
[66.310845] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.324598] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.329967] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.333178] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[67.892095] Starting subtest: dp-mst-lic-type-0-hdcp14
[67.895111] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[68.143418] [002/133] (958s left) core_getversion (all-cards)
[68.187729] Starting subtest: all-cards
[68.206291] Subtest all-cards: SUCCESS (0.020s)
[68.272953] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[69.758905] Starting subtest: legacy-dpms
[69.760637] Starting dynamic subtest: pipe-A-HDMI-A-4
[75.938901] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.175s)
[75.940269] Subtest legacy-dpms: SUCCESS (6.177s)
[76.146296] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[77.630991] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[77.639505] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[77.822987] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[79.310167] Starting subtest: plane-primary-toggle-with-vblank-wait
[79.311523] Starting dynamic subtest: pipe-A-HDMI-A-4
[79.528401] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.216s)
[79.670412] Starting dynamic subtest: pipe-B-HDMI-A-4
[79.898189] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.238s)
[79.955967] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.645s)
[80.146264] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[81.656963] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[81.659943] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[81.899422] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[83.385079] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[83.460421] [008/133] (944s left) perf (invalid-oa-exponent)
[83.633592] Starting subtest: invalid-oa-exponent
[83.660792] Subtest invalid-oa-exponent: SUCCESS (0.026s)
[83.731155] [009/133] (943s left) gem_eio (create-ext)
[83.870263] Starting subtest: create-ext
[84.044695] Subtest create-ext: SUCCESS (0.176s)
[85.619919] [010/133] (942s left) kms_color (invalid-degamma-lut-sizes)
[87.123188] Starting subtest: invalid-degamma-lut-sizes
[87.124651] Starting dynamic subtest: pipe-A
[87.165107] Dynamic subtest pipe-A: SUCCESS (0.042s)
[87.174110] Starting dynamic subtest: pipe-B
[87.175582] Dynamic subtest pipe-B: SUCCESS (0.001s)
[87.184372] Starting dynamic subtest: pipe-C
[87.185860] Dynamic subtest pipe-C: SUCCESS (0.001s)
[87.194703] Starting dynamic subtest: pipe-D
[87.196152] Dynamic subtest pipe-D: SUCCESS (0.001s)
[87.197669] Subtest invalid-degamma-lut-sizes: SUCCESS (0.045s)
[87.352715] [011/133] (940s left) gem_softpin (allocator-basic)
[87.401545] Starting subtest: allocator-basic
[87.669843] Subtest allocator-basic: SUCCESS (0.265s)
[87.905161] [012/133] (939s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[89.400425] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[89.462605] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[90.970350] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[92.110942] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.139s)
[92.336774] [014/133] (935s left) kms_psr (pr-primary-render)
[93.824561] Subtest pr-primary-render: SKIP (0.000s)
[93.892508] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[95.386320] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[95.389676] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.604345] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[97.092672] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[97.160425] [017/133] (931s left) gem_ccs (ctrl-surf-copy)
[97.211146] Starting subtest: ctrl-surf-copy
[97.214096] Subtest ctrl-surf-copy: SKIP (0.000s)
[97.352807] [018/133] (930s left) perf (invalid-oa-metric-set-id)
[97.471139] Starting subtest: invalid-oa-metric-set-id
[97.490958] Subtest invalid-oa-metric-set-id: SUCCESS (0.019s)
[97.563209] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[99.064349] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[99.067382] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[99.275425] [020/133] (929s left) gem_pxp (create-regular-buffer)
[101.843237] Starting subtest: create-regular-buffer
[101.846613] Subtest create-regular-buffer: SKIP (0.000s)
[101.987223] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[102.122093] Starting subtest: in-flight-contexts-10ms
[115.898183] Subtest in-flight-contexts-10ms: SUCCESS (13.776s)
[117.551100] [022/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[119.040824] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[119.043487] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[119.286766] [023/133] (909s left) gem_exec_schedule (u-fairslice-all)
[119.345265] Starting subtest: u-fairslice-all
[121.421665] Subtest u-fairslice-all: SUCCESS (2.076s)
[121.877866] [024/133] (907s left) core_getstats (basic)
[121.924867] Starting subtest: basic
[121.926487] Subtest basic: SUCCESS (0.000s)
[122.085022] [025/133] (906s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[123.569550] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[123.571172] Starting dynamic subtest: pipe-A-HDMI-A-4
[123.586884] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[123.597109] Starting dynamic subtest: pipe-B-HDMI-A-4
[123.613847] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[123.623528] Starting dynamic subtest: pipe-C-HDMI-A-4
[123.640245] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[123.649976] Starting dynamic subtest: pipe-D-HDMI-A-4
[123.663606] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[123.666181] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[123.833376] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[125.316765] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[125.318529] Starting dynamic subtest: pipe-A-HDMI-A-4
[125.336212] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[125.356216] Starting dynamic subtest: pipe-B-HDMI-A-4
[125.370369] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[125.379580] Starting dynamic subtest: pipe-C-HDMI-A-4
[125.396105] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[125.405737] Starting dynamic subtest: pipe-D-HDMI-A-4
[125.419969] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[125.422886] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[125.577418] [027/133] (903s left) sw_sync (alloc_fence)
[125.622804] Starting subtest: alloc_fence
[125.627352] Subtest alloc_fence: SUCCESS (0.000s)
[125.759169] [028/133] (903s left) i915_pm_rps (basic-api)
[125.811217] Starting subtest: basic-api
[125.814844] Subtest basic-api: SKIP (0.000s)
[125.988958] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[127.473543] Starting subtest: cursorB-vs-flipA-toggle
[127.476802] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[127.648497] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[129.328162] Starting subtest: cursor-rapid-movement-128x42
[129.334976] Starting dynamic subtest: pipe-A-HDMI-A-4
[129.767957] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.433s)
[129.798045] Starting dynamic subtest: pipe-D-HDMI-A-4
[130.109653] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.319s)
[130.111092] Subtest cursor-rapid-movement-128x42: SUCCESS (0.781s)
[130.586420] [031/133] (898s left) kms_dp_link_training (non-uhbr-sst)
[132.069906] Starting subtest: non-uhbr-sst
[132.076329] Subtest non-uhbr-sst: SKIP (0.000s)
[132.247450] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[133.749766] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[133.752803] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.990957] [033/133] (895s left) gem_exec_parallel (engines)
[134.046668] Starting subtest: engines
[134.048260] Starting dynamic subtest: basic
[135.671092] Dynamic subtest basic: SUCCESS (1.624s)
[135.681454] Starting dynamic subtest: contexts
[140.272941] Dynamic subtest contexts: SUCCESS (4.598s)
[140.283406] Starting dynamic subtest: fds
[144.710580] Dynamic subtest fds: SUCCESS (4.441s)
[144.720467] Starting dynamic subtest: userptr
[146.275973] Dynamic subtest userptr: SUCCESS (1.565s)
[146.277661] Subtest engines: SUCCESS (12.230s)
[146.654128] [034/133] (883s left) gem_eio (in-flight-immediate)
[146.858157] Starting subtest: in-flight-immediate
[151.437641] Subtest in-flight-immediate: SUCCESS (4.580s)
[153.099417] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[153.105149] [035/133] (876s left) prime_mmap (test_forked)
[153.149897] Starting subtest: test_forked
[153.151437] Starting dynamic subtest: test_forked-smem
[153.221926] Dynamic subtest test_forked-smem: SUCCESS (0.072s)
[153.232122] Starting dynamic subtest: test_forked-lmem0
[153.295823] Dynamic subtest test_forked-lmem0: SUCCESS (0.073s)
[153.297384] Subtest test_forked: SUCCESS (0.147s)
[153.516761] [036/133] (876s left) kms_dsc (dsc-with-formats)
[154.998996] Starting subtest: dsc-with-formats
[155.024886] Subtest dsc-with-formats: SKIP (0.002s)
[155.158123] [037/133] (875s left) prime_busy (hang)
[155.213977] Starting subtest: hang
[155.215731] Starting dynamic subtest: rcs0
[181.431433] Dynamic subtest rcs0: SUCCESS (26.216s)
[181.441900] Starting dynamic subtest: bcs0
[188.581202] Dynamic subtest bcs0: SUCCESS (7.148s)
[188.591630] Starting dynamic subtest: vcs0
[195.557332] Dynamic subtest vcs0: SUCCESS (6.976s)
[195.567927] Starting dynamic subtest: vcs1
[202.595341] Dynamic subtest vcs1: SUCCESS (7.039s)
[202.605947] Starting dynamic subtest: vecs0
[209.569485] Dynamic subtest vecs0: SUCCESS (6.974s)
[209.571573] Subtest hang: SUCCESS (54.356s)
[209.801957] [038/133] (820s left) kms_vblank (wait-idle)
[211.286500] Starting subtest: wait-idle
[211.288360] Starting dynamic subtest: pipe-A-HDMI-A-4
[213.617860] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.330s)
[213.631636] Starting dynamic subtest: pipe-D-HDMI-A-4
[215.812521] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.188s)
[215.813919] Subtest wait-idle: SUCCESS (4.524s)
[216.009743] [039/133] (814s left) kms_pm_rpm (package-g7)
[220.025083] Starting subtest: package-g7
[220.030701] Subtest package-g7: SKIP (0.000s)
[221.010891] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[222.508428] Starting subtest: flip-vs-cursor-varying-size
[237.001894] Subtest flip-vs-cursor-varying-size: SUCCESS (14.494s)
[237.206555] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[238.699928] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[238.703547] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[238.936062] [042/133] (791s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[238.981294] Starting subtest: single-wait-all-for-submit-signaled
[238.982607] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[239.165019] [043/133] (791s left) perf (gen12-group-exclusive-stream-ctx-handle)
[239.334573] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[239.361159] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[239.433499] [044/133] (791s left) gem_wait (busy)
[239.494513] Starting subtest: busy
[239.496054] Starting dynamic subtest: all-engines
[240.071796] Dynamic subtest all-engines: SUCCESS (0.577s)
[240.082402] Starting dynamic subtest: rcs0
[240.610303] Dynamic subtest rcs0: SUCCESS (0.538s)
[240.620715] Starting dynamic subtest: bcs0
[241.149333] Dynamic subtest bcs0: SUCCESS (0.539s)
[241.159563] Starting dynamic subtest: vcs0
[241.688217] Dynamic subtest vcs0: SUCCESS (0.538s)
[241.698550] Starting dynamic subtest: vcs1
[242.226319] Dynamic subtest vcs1: SUCCESS (0.538s)
[242.236787] Starting dynamic subtest: vecs0
[242.764364] Dynamic subtest vecs0: SUCCESS (0.538s)
[242.765984] Subtest busy: SUCCESS (3.270s)
[243.092348] [045/133] (787s left) gen9_exec_parse (bb-secure)
[243.147727] Subtest bb-secure: SKIP (0.000s)
[243.214889] [046/133] (787s left) kms_cursor_edge_walk (128x128-right-edge)
[244.698756] Starting subtest: 128x128-right-edge
[244.700390] Starting dynamic subtest: pipe-A-HDMI-A-4
[248.020986] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.322s)
[248.031781] Starting dynamic subtest: pipe-D-HDMI-A-4
[251.234098] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.211s)
[251.235438] Subtest 128x128-right-edge: SUCCESS (6.537s)
[251.460262] [047/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[252.949992] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[252.952974] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.179697] [048/133] (777s left) prime_mmap (test_forked_cpu_write)
[253.225740] Starting subtest: test_forked_cpu_write
[253.227237] Starting dynamic subtest: test_forked_cpu_write-smem
[253.235246] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[253.245816] Starting dynamic subtest: test_forked_cpu_write-lmem0
[253.247381] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[253.248922] Subtest test_forked_cpu_write: SUCCESS (0.023s)
[253.449905] [049/133] (777s left) kms_addfb_basic (small-bo)
[254.935384] Starting subtest: small-bo
[254.936814] Subtest small-bo: SUCCESS (0.000s)
[255.198953] [050/133] (776s left) kms_chamelium_audio (dp-audio)
[256.734243] Subtest dp-audio: SKIP (0.000s)
[256.843317] [051/133] (774s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.369937] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[258.479969] [052/133] (773s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[259.970935] Starting subtest: psr-shrfb-scaledprimary
[259.973973] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[260.210571] [053/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[261.727809] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[261.730967] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[261.932937] [054/133] (769s left) perf (i915-ref-count)
[262.067543] Starting subtest: i915-ref-count
[262.101877] Subtest i915-ref-count: SUCCESS (0.033s)
[262.178849] [055/133] (769s left) kms_joiner (invalid-modeset-force-big-joiner)
[263.664925] Starting subtest: invalid-modeset-force-big-joiner
[263.668090] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[263.847252] [056/133] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[265.336357] Starting subtest: cursor-alpha-opaque
[265.337776] Starting dynamic subtest: pipe-A-HDMI-A-4
[265.940460] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.603s)
[265.951096] Starting dynamic subtest: pipe-D-HDMI-A-4
[266.395827] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.454s)
[266.397667] Subtest cursor-alpha-opaque: SUCCESS (1.061s)
[267.128606] [057/133] (764s left) kms_legacy_colorkey (basic)
[268.612435] Starting subtest: basic
[268.613957] Starting dynamic subtest: pipe-A
[268.701996] Dynamic subtest pipe-A: SUCCESS (0.090s)
[268.721334] Starting dynamic subtest: pipe-B
[268.723160] Dynamic subtest pipe-B: SUCCESS (0.001s)
[268.754192] Starting dynamic subtest: pipe-C
[268.756646] Dynamic subtest pipe-C: SUCCESS (0.001s)
[268.795117] Starting dynamic subtest: pipe-D
[268.797478] Dynamic subtest pipe-D: SUCCESS (0.001s)
[268.799830] Subtest basic: SUCCESS (0.097s)
[268.893614] [058/133] (763s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[270.396789] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[270.399833] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[270.654562] [059/133] (761s left) kms_addfb_basic (bad-pitch-32)
[270.700165] Starting subtest: bad-pitch-32
[270.701788] Subtest bad-pitch-32: SUCCESS (0.000s)
[272.385609] [060/133] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[272.438227] Starting subtest: x-tiled-to-vebox-y-tiled
[272.439765] Starting dynamic subtest: smem
[272.519179] Dynamic subtest smem: SUCCESS (0.081s)
[272.529608] Starting dynamic subtest: lmem0
[273.278362] Dynamic subtest lmem0: SUCCESS (0.755s)
[273.280126] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.837s)
[273.588664] [061/133] (758s left) gem_exec_reloc (basic-range)
[273.639827] Subtest basic-range: SKIP (0.000s)
[273.763617] [062/133] (758s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[275.265770] Starting subtest: yf-tiled-64bpp-rotate-0
[275.269161] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[275.521297] [063/133] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[275.568667] Starting subtest: wait-all-for-submit-snapshot
[275.648114] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[275.800735] [064/133] (757s left) kms_async_flips (invalid-async-flip)
[277.283437] Starting subtest: invalid-async-flip
[277.540036] Starting dynamic subtest: pipe-A-HDMI-A-4
[277.966733] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.427s)
[278.147338] Starting dynamic subtest: pipe-B-HDMI-A-4
[278.233892] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.095s)
[278.407659] Starting dynamic subtest: pipe-C-HDMI-A-4
[278.507206] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.108s)
[278.658757] Starting dynamic subtest: pipe-D-HDMI-A-4
[278.755469] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.106s)
[278.756761] Subtest invalid-async-flip: SUCCESS (1.473s)
[279.095819] [065/133] (753s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[280.584677] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[280.592841] Starting dynamic subtest: A-HDMI-A4
[281.280755] Dynamic subtest A-HDMI-A4: SUCCESS (0.687s)
[281.291380] Starting dynamic subtest: B-HDMI-A4
[281.935392] Dynamic subtest B-HDMI-A4: SUCCESS (0.653s)
[281.945802] Starting dynamic subtest: C-HDMI-A4
[282.595179] Dynamic subtest C-HDMI-A4: SUCCESS (0.658s)
[282.605832] Starting dynamic subtest: D-HDMI-A4
[283.272528] Dynamic subtest D-HDMI-A4: SUCCESS (0.676s)
[283.274135] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.687s)
[283.495687] [066/133] (749s left) kms_frontbuffer_tracking (fbc-suspend)
[284.992686] Starting subtest: fbc-suspend
[331.201689] Subtest fbc-suspend: SUCCESS (22.599s)
[335.443959] [067/133] (701s left) syncobj_timeline (invalid-transfer-bad-pad)
[335.493931] Starting subtest: invalid-transfer-bad-pad
[335.495282] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[335.662848] [068/133] (701s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[337.818622] Starting subtest: 4-tiled-64bpp-rotate-90
[337.822257] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[338.052525] [069/133] (699s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[338.103083] Starting subtest: saturated-hostile-nopreempt
[338.104546] Starting dynamic subtest: rcs0
[338.924365] Dynamic subtest rcs0: SUCCESS (0.821s)
[338.941615] Starting dynamic subtest: bcs0
[339.707381] Dynamic subtest bcs0: SUCCESS (0.781s)
[339.723197] Starting dynamic subtest: vcs0
[340.497209] Dynamic subtest vcs0: SUCCESS (0.787s)
[340.512858] Starting dynamic subtest: vcs1
[341.298129] Dynamic subtest vcs1: SUCCESS (0.798s)
[341.313363] Starting dynamic subtest: vecs0
[342.094926] Dynamic subtest vecs0: SUCCESS (0.794s)
[342.096669] Subtest saturated-hostile-nopreempt: SUCCESS (3.993s)
[342.298850] [070/133] (695s left) gem_exec_big (single)
[342.363490] Starting subtest: single
[349.652799] Subtest single: SUCCESS (7.291s)
[350.558455] [071/133] (686s left) gem_exec_fence (submit67)
[350.775474] Starting subtest: submit67
[350.778085] Subtest submit67: SKIP (0.000s)
[351.367005] [072/133] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[352.860504] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[352.863785] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[353.085476] [073/133] (684s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[354.577254] Starting subtest: fbc-rgb101010-draw-mmap-wc
[354.583429] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[354.814853] [074/133] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[356.304400] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[356.307418] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.560537] [075/133] (681s left) i915_drm_fdinfo (busy-idle)
[356.609259] Starting subtest: busy-idle
[356.610827] Starting dynamic subtest: rcs0
[356.616849] Dynamic subtest rcs0: SKIP (0.000s)
[356.630474] Starting dynamic subtest: bcs0
[356.633811] Dynamic subtest bcs0: SKIP (0.000s)
[356.647437] Starting dynamic subtest: vcs0
[356.650922] Dynamic subtest vcs0: SKIP (0.000s)
[356.664381] Starting dynamic subtest: vcs1
[356.668127] Dynamic subtest vcs1: SKIP (0.013s)
[356.681004] Starting dynamic subtest: vecs0
[356.684577] Dynamic subtest vecs0: SKIP (0.000s)
[356.688490] Subtest busy-idle: SKIP (0.022s)
[356.753969] [076/133] (681s left) kms_psr (psr2-primary-page-flip)
[358.242000] Subtest psr2-primary-page-flip: SKIP (0.000s)
[358.318806] [077/133] (679s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[359.809634] Starting subtest: cursorA-vs-flipB-atomic
[359.814797] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[360.005891] [078/133] (678s left) kms_prop_blob (blob-prop-lifetime)
[360.053856] Starting subtest: blob-prop-lifetime
[360.055344] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[360.223988] [079/133] (678s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[361.708369] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[361.709769] Starting dynamic subtest: pipe-A
[364.352225] Dynamic subtest pipe-A: SUCCESS (2.644s)
[364.373209] Starting dynamic subtest: pipe-B
[366.941904] Dynamic subtest pipe-B: SUCCESS (2.588s)
[366.959105] Starting dynamic subtest: pipe-C
[367.231778] Dynamic subtest pipe-C: SUCCESS (0.288s)
[367.252136] Starting dynamic subtest: pipe-D
[367.523004] Dynamic subtest pipe-D: SUCCESS (0.289s)
[367.524753] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.816s)
[367.782623] [080/133] (670s left) kms_pipe_crc_basic (hang-read-crc)
[369.271618] Starting subtest: hang-read-crc
[369.273090] Starting dynamic subtest: pipe-A-HDMI-A-4
[370.747010] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.475s)
[370.762837] Starting dynamic subtest: pipe-B-HDMI-A-4
[371.921020] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.172s)
[371.939505] Starting dynamic subtest: pipe-C-HDMI-A-4
[373.187529] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.261s)
[373.201020] Starting dynamic subtest: pipe-D-HDMI-A-4
[374.377416] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.188s)
[374.379047] Subtest hang-read-crc: SUCCESS (5.107s)
[374.626189] [081/133] (663s left) kms_selftest (drm_format)
[374.705483] Starting subtest: drm_format
[374.821128] Starting dynamic subtest: drm_test_format_block_width_invalid
[374.916405] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.095s)
[374.933601] Starting dynamic subtest: drm_test_format_block_width_one_plane
[374.996091] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.073s)
[375.037728] Starting dynamic subtest: drm_test_format_block_width_two_plane
[375.084914] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[375.118553] Starting dynamic subtest: drm_test_format_block_width_three_plane
[375.150711] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.063s)
[375.170826] Starting dynamic subtest: drm_test_format_block_width_tiled
[375.236745] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.081s)
[375.285628] Starting dynamic subtest: drm_test_format_block_height_invalid
[375.324304] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.082s)
[375.347730] Starting dynamic subtest: drm_test_format_block_height_one_plane
[375.409964] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.081s)
[375.456938] Starting dynamic subtest: drm_test_format_block_height_two_plane
[375.490220] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.074s)
[375.511014] Starting dynamic subtest: drm_test_format_block_height_three_plane
[375.579525] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.087s)
[375.595263] Starting dynamic subtest: drm_test_format_block_height_tiled
[375.672966] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.090s)
[375.724340] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[375.769808] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.090s)
[375.801265] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[375.867733] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.092s)
[375.881226] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[375.960006] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.087s)
[376.010217] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[376.052311] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.087s)
[376.075987] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[376.128416] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.072s)
[376.176466] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[376.207018] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.072s)
[376.224432] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[376.292392] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.081s)
[376.344769] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[376.380034] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.081s)
[376.382144] Subtest drm_format: SUCCESS (1.673s)
[376.631160] [082/133] (661s left) gem_close_race (multigpu-basic-process)
[376.708762] Starting subtest: multigpu-basic-process
[376.711844] Subtest multigpu-basic-process: SKIP (0.000s)
[377.050348] [083/133] (661s left) gem_set_tiling_vs_gtt
[377.173251] [084/133] (661s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[378.662528] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[378.664271] Starting dynamic subtest: pipe-A
[378.815855] Dynamic subtest pipe-A: SUCCESS (0.156s)
[378.836551] Starting dynamic subtest: pipe-B
[378.974125] Dynamic subtest pipe-B: SUCCESS (0.156s)
[378.987371] Starting dynamic subtest: pipe-C
[379.114778] Dynamic subtest pipe-C: SUCCESS (0.139s)
[379.128190] Starting dynamic subtest: pipe-D
[379.255925] Dynamic subtest pipe-D: SUCCESS (0.140s)
[379.257839] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.597s)
[379.552267] [085/133] (659s left) kms_addfb_basic (basic-y-tiled-legacy)
[379.598778] Starting subtest: basic-y-tiled-legacy
[379.601591] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[381.295649] [086/133] (657s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[382.806731] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[384.130570] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.324s)
[384.370070] [087/133] (654s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[384.422584] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[384.423918] Starting dynamic subtest: smem
[384.522509] Dynamic subtest smem: SUCCESS (0.099s)
[384.537788] Starting dynamic subtest: lmem0
[385.632574] Dynamic subtest lmem0: SUCCESS (1.108s)
[385.633963] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.210s)
[385.920140] [088/133] (653s left) gem_caching (writes)
[385.971347] Starting subtest: writes
[390.955437] Subtest writes: SUCCESS (4.984s)
[391.194173] [089/133] (648s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[391.243865] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[391.346545] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[391.540421] [090/133] (647s left) kms_flip (wf_vblank-ts-check)
[393.025796] Starting subtest: wf_vblank-ts-check
[393.032603] Starting dynamic subtest: A-HDMI-A4
[401.041097] Dynamic subtest A-HDMI-A4: SUCCESS (8.008s)
[401.059791] Starting dynamic subtest: B-HDMI-A4
[409.001382] Dynamic subtest B-HDMI-A4: SUCCESS (7.958s)
[409.018990] Starting dynamic subtest: C-HDMI-A4
[417.128610] Dynamic subtest C-HDMI-A4: SUCCESS (8.125s)
[417.144659] Starting dynamic subtest: D-HDMI-A4
[425.090737] Dynamic subtest D-HDMI-A4: SUCCESS (7.960s)
[425.092475] Subtest wf_vblank-ts-check: SUCCESS (32.067s)
[425.386016] [091/133] (614s left) gem_lmem_evict (dontneed-evict-race)
[429.811983] Starting subtest: dontneed-evict-race
[431.894802] Subtest dontneed-evict-race: SUCCESS (2.082s)
[434.174728] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[434.175856] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[434.178768] [092/133] (605s left) gem_mmap_gtt (medium-copy-odd)
[437.422524] Subtest medium-copy-odd: SKIP (0.000s)
[437.498345] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[437.501498] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[437.505523] [093/133] (602s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[438.995574] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[439.014805] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[439.183752] [094/133] (600s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[440.677326] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[440.678993] Starting dynamic subtest: pipe-A-HDMI-A-4
[440.713145] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[440.724808] Starting dynamic subtest: pipe-B-HDMI-A-4
[440.762146] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[440.773346] Starting dynamic subtest: pipe-C-HDMI-A-4
[440.810937] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[440.822169] Starting dynamic subtest: pipe-D-HDMI-A-4
[440.864495] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[440.867796] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.021s)
[440.942785] [095/133] (598s left) gem_exec_suspend (basic-s0)
[441.005176] Starting subtest: basic-S0
[441.006721] Starting dynamic subtest: smem
[461.045795] Dynamic subtest smem: SUCCESS (5.241s)
[461.058199] Starting dynamic subtest: lmem0
[481.018697] Dynamic subtest lmem0: SUCCESS (4.847s)
[481.020406] Subtest basic-S0: SUCCESS (10.091s)
[493.331136] [096/133] (558s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[494.855384] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[494.858787] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[495.078876] [097/133] (556s left) gem_mmap_offset (bad-extensions)
[495.125427] Starting subtest: bad-extensions
[495.127055] Subtest bad-extensions: SUCCESS (0.000s)
[495.340341] [098/133] (556s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[496.834973] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[496.840974] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[497.035092] [099/133] (555s left) gem_mmap_gtt (cpuset-big-copy-odd)
[497.083800] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[497.160451] [100/133] (555s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[498.671915] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[498.675142] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[498.925295] [101/133] (553s left) kms_psr (fbc-psr2-sprite-render)
[500.414871] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[500.498138] [102/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[501.995812] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[501.998995] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[502.242344] [103/133] (550s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[503.731576] Starting subtest: crc-primary-basic-y-tiled-ccs
[503.733016] Starting dynamic subtest: pipe-A-HDMI-A-4
[503.747128] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[503.759522] Starting dynamic subtest: pipe-B-HDMI-A-4
[503.774465] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[503.786368] Starting dynamic subtest: pipe-C-HDMI-A-4
[503.801409] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[503.813607] Starting dynamic subtest: pipe-D-HDMI-A-4
[503.829960] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[503.833099] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[504.025176] [104/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[505.524483] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[505.527570] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[505.767516] [105/133] (547s left) api_intel_bb (add-remove-objects)
[505.815083] Starting subtest: add-remove-objects
[505.839726] Subtest add-remove-objects: SUCCESS (0.025s)
[506.071204] [106/133] (546s left) sysfs_heartbeat_interval (nopreempt)
[506.122076] Starting subtest: nopreempt
[506.123716] Starting dynamic subtest: vecs0
[510.211813] Dynamic subtest vecs0: SUCCESS (4.079s)
[510.226588] Starting dynamic subtest: vcs0
[514.214947] Dynamic subtest vcs0: SUCCESS (3.996s)
[514.229355] Starting dynamic subtest: bcs0
[518.230999] Dynamic subtest bcs0: SUCCESS (4.009s)
[518.244585] Starting dynamic subtest: rcs0
[522.284678] Dynamic subtest rcs0: SUCCESS (4.049s)
[522.298783] Starting dynamic subtest: vcs1
[526.296863] Dynamic subtest vcs1: SUCCESS (4.009s)
[526.298477] Subtest nopreempt: SUCCESS (20.152s)
[526.531778] [107/133] (526s left) kms_getfb (getfb2-into-addfb2)
[528.017626] Starting subtest: getfb2-into-addfb2
[528.019126] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[528.298481] [108/133] (524s left) gem_close (basic)
[528.351549] Starting subtest: basic
[528.353009] Subtest basic: SUCCESS (0.000s)
[528.584441] [109/133] (524s left) gem_exec_schedule (preemptive-hang)
[528.755040] Starting subtest: preemptive-hang
[528.756642] Starting dynamic subtest: rcs0
[537.624654] Dynamic subtest rcs0: SUCCESS (8.870s)
[537.641384] Starting dynamic subtest: bcs0
[546.581566] Dynamic subtest bcs0: SUCCESS (8.954s)
[546.595321] Starting dynamic subtest: vcs0
[555.613659] Dynamic subtest vcs0: SUCCESS (9.030s)
[555.626729] Starting dynamic subtest: vcs1
[564.637250] Dynamic subtest vcs1: SUCCESS (9.019s)
[564.650263] Starting dynamic subtest: vecs0
[573.589366] Dynamic subtest vecs0: SUCCESS (8.947s)
[573.590763] Subtest preemptive-hang: SUCCESS (44.829s)
[573.950235] [110/133] (479s left) i915_drm_fdinfo (virtual-busy-idle)
[573.997985] Starting subtest: virtual-busy-idle
[574.001038] Subtest virtual-busy-idle: SKIP (0.000s)
[574.142680] [111/133] (479s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[575.650398] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[575.653356] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[575.896264] [112/133] (477s left) gem_linear_blits (interruptible)
[576.138324] Starting subtest: interruptible
[584.621701] Subtest interruptible: SUCCESS (8.477s)
[584.823164] [113/133] (468s left) gem_ctx_persistence (engines-mixed)
[584.921404] Starting subtest: engines-mixed
[584.923016] Starting dynamic subtest: rcs0
[584.996727] Dynamic subtest rcs0: SUCCESS (0.075s)
[585.013989] Starting dynamic subtest: bcs0
[585.060452] Dynamic subtest bcs0: SUCCESS (0.061s)
[585.110047] Starting dynamic subtest: vcs0
[585.162958] Dynamic subtest vcs0: SUCCESS (0.098s)
[585.197460] Starting dynamic subtest: vcs1
[585.223048] Dynamic subtest vcs1: SUCCESS (0.057s)
[585.247418] Starting dynamic subtest: vecs0
[585.274847] Dynamic subtest vecs0: SUCCESS (0.050s)
[585.276879] Subtest engines-mixed: SUCCESS (0.355s)
[585.504484] [114/133] (468s left) perf_pmu (init-wait)
[585.555317] Starting subtest: init-wait
[585.556629] Starting dynamic subtest: rcs0
[585.557932] Dynamic subtest rcs0: SUCCESS (0.002s)
[585.571198] Starting dynamic subtest: bcs0
[585.572634] Dynamic subtest bcs0: SUCCESS (0.001s)
[585.585649] Starting dynamic subtest: vcs0
[585.587239] Dynamic subtest vcs0: SUCCESS (0.001s)
[585.599967] Starting dynamic subtest: vcs1
[585.601438] Dynamic subtest vcs1: SUCCESS (0.001s)
[585.614582] Starting dynamic subtest: vecs0
[585.616064] Dynamic subtest vecs0: SUCCESS (0.001s)
[585.617641] Subtest init-wait: SUCCESS (0.011s)
[585.732050] [115/133] (468s left) gem_exec_reloc (basic-gtt-cpu-active)
[585.786634] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[585.897785] [116/133] (468s left) kms_pm_lpsp (screens-disabled)
[588.400049] Starting subtest: screens-disabled
[588.403712] Subtest screens-disabled: SKIP (0.000s)
[588.560394] [117/133] (465s left) kms_flip (flip-vs-expired-vblank-interruptible)
[590.067445] Starting subtest: flip-vs-expired-vblank-interruptible
[590.076014] Starting dynamic subtest: A-HDMI-A4
[597.827912] Dynamic subtest A-HDMI-A4: SUCCESS (7.756s)
[597.847151] Starting dynamic subtest: B-HDMI-A4
[605.503991] Dynamic subtest B-HDMI-A4: SUCCESS (7.677s)
[605.520559] Starting dynamic subtest: C-HDMI-A4
[613.181279] Dynamic subtest C-HDMI-A4: SUCCESS (7.676s)
[613.205843] Starting dynamic subtest: D-HDMI-A4
[620.856003] Dynamic subtest D-HDMI-A4: SUCCESS (7.667s)
[620.857714] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.798s)
[621.088304] [118/133] (433s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[622.578603] Starting subtest: psr-1p-primscrn-cur-indfb-move
[622.581181] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[622.834420] [119/133] (431s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[624.320651] Starting subtest: plane-all-modeset-transition-internal-panels
[624.324075] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[624.512643] [120/133] (429s left) gem_userptr_blits (stress-mm)
[624.574917] Starting subtest: stress-mm
[629.946663] Subtest stress-mm: SUCCESS (5.369s)
[630.159300] [121/133] (424s left) syncobj_eventfd (invalid-bad-flags)
[630.215530] Starting subtest: invalid-bad-flags
[630.216920] Subtest invalid-bad-flags: SUCCESS (0.000s)
[630.376449] [122/133] (424s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[630.425462] Starting subtest: framebuffer-vs-set-tiling
[630.428347] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[632.137762] [123/133] (422s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[633.629486] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[633.632994] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[633.883211] [124/133] (421s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[633.948180] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[633.960024] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[634.153077] [125/133] (420s left) kms_flip (2x-modeset-vs-vblank-race)
[635.638561] Starting subtest: 2x-modeset-vs-vblank-race
[635.656279] Subtest 2x-modeset-vs-vblank-race: SKIP (0.017s)
[635.830165] [126/133] (419s left) i915_query (query-regions-garbage-items)
[635.879129] Starting subtest: query-regions-garbage-items
[635.883059] Subtest query-regions-garbage-items: SUCCESS (0.001s)
[636.082378] [127/133] (419s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[636.129981] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[636.228935] [128/133] (419s left) gem_exec_balancer (full-late)
[636.292931] Starting subtest: full-late
[638.540669] Subtest full-late: SUCCESS (2.247s)
[639.050000] [129/133] (416s left) gem_exec_reloc (basic-write-wc)
[639.100552] Subtest basic-write-wc: SKIP (0.000s)
[639.192929] [130/133] (416s left) kms_force_connector_basic (force-load-detect)
[639.322382] Starting subtest: force-load-detect
[639.325419] Subtest force-load-detect: SKIP (0.000s)
[640.295790] [131/133] (415s left) kms_chamelium_hpd (hdmi-hpd-fast)
[641.822130] Subtest hdmi-hpd-fast: SKIP (0.000s)
[641.934928] [132/133] (413s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[643.421786] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[643.423290] Starting dynamic subtest: pipe-A-valid-mode
[644.220983] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.798s)
[644.223044] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.800s)
[644.429454] [133/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[645.920583] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[645.923864] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[646.153838] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.