[65.025115] Initializing watchdogs
[65.025195]   /dev/watchdog0
[65.054751] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.069770] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.074337] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.077712] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[66.652166] Starting subtest: dp-mst-lic-type-0-hdcp14
[66.655153] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[66.873602] [002/133] (958s left) core_getversion (all-cards)
[66.938033] Starting subtest: all-cards
[66.955230] Subtest all-cards: SUCCESS (0.020s)
[67.017716] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[68.497130] Starting subtest: legacy-dpms
[68.498571] Starting dynamic subtest: pipe-A-HDMI-A-4
[74.698991] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.215s)
[74.700650] Subtest legacy-dpms: SUCCESS (6.217s)
[74.889056] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[76.374245] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[76.381830] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[76.544992] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[78.040407] Starting subtest: plane-primary-toggle-with-vblank-wait
[78.042103] Starting dynamic subtest: pipe-A-HDMI-A-4
[78.260942] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.219s)
[78.412481] Starting dynamic subtest: pipe-B-HDMI-A-4
[78.647405] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.247s)
[78.705362] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.665s)
[78.937723] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[80.457517] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[80.460576] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[80.716402] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[82.202813] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[82.267173] [008/133] (943s left) perf (invalid-oa-exponent)
[82.435265] Starting subtest: invalid-oa-exponent
[82.463851] Subtest invalid-oa-exponent: SUCCESS (0.027s)
[82.535101] [009/133] (943s left) gem_eio (create-ext)
[82.670963] Starting subtest: create-ext
[82.846833] Subtest create-ext: SUCCESS (0.176s)
[84.433239] [010/133] (941s left) kms_color (invalid-degamma-lut-sizes)
[85.936692] Starting subtest: invalid-degamma-lut-sizes
[85.938337] Starting dynamic subtest: pipe-A
[85.986041] Dynamic subtest pipe-A: SUCCESS (0.051s)
[85.995224] Starting dynamic subtest: pipe-B
[85.996890] Dynamic subtest pipe-B: SUCCESS (0.001s)
[86.006311] Starting dynamic subtest: pipe-C
[86.008123] Dynamic subtest pipe-C: SUCCESS (0.001s)
[86.017185] Starting dynamic subtest: pipe-D
[86.018862] Dynamic subtest pipe-D: SUCCESS (0.001s)
[86.020583] Subtest invalid-degamma-lut-sizes: SUCCESS (0.054s)
[86.182099] [011/133] (940s left) gem_softpin (allocator-basic)
[86.229708] Starting subtest: allocator-basic
[86.497218] Subtest allocator-basic: SUCCESS (0.264s)
[86.676139] [012/133] (939s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[88.164054] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[88.235740] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[89.745829] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[90.885513] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.137s)
[91.063393] [014/133] (935s left) kms_psr (pr-primary-render)
[92.555421] Subtest pr-primary-render: SKIP (0.000s)
[92.619331] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[94.112741] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[94.116232] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[94.371835] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[95.859959] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[95.920445] [017/133] (931s left) gem_ccs (ctrl-surf-copy)
[95.973053] Starting subtest: ctrl-surf-copy
[95.976951] Subtest ctrl-surf-copy: SKIP (0.000s)
[96.110926] [018/133] (930s left) perf (invalid-oa-metric-set-id)
[96.257863] Starting subtest: invalid-oa-metric-set-id
[96.278669] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[96.349599] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[97.841574] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[97.844444] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[98.082642] [020/133] (929s left) gem_pxp (create-regular-buffer)
[100.650163] Starting subtest: create-regular-buffer
[100.653203] Subtest create-regular-buffer: SKIP (0.000s)
[100.796343] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[100.931092] Starting subtest: in-flight-contexts-10ms
[114.872705] Subtest in-flight-contexts-10ms: SUCCESS (13.942s)
[116.547735] [022/133] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[118.040831] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[118.044183] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[118.281946] [023/133] (909s left) gem_exec_schedule (u-fairslice-all)
[118.357810] Starting subtest: u-fairslice-all
[120.435839] Subtest u-fairslice-all: SUCCESS (2.078s)
[120.949839] [024/133] (906s left) core_getstats (basic)
[120.994049] Starting subtest: basic
[120.995624] Subtest basic: SUCCESS (0.000s)
[121.184105] [025/133] (906s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[122.667561] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[122.668962] Starting dynamic subtest: pipe-A-HDMI-A-4
[122.683415] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[122.693212] Starting dynamic subtest: pipe-B-HDMI-A-4
[122.708164] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[122.717711] Starting dynamic subtest: pipe-C-HDMI-A-4
[122.732693] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[122.742201] Starting dynamic subtest: pipe-D-HDMI-A-4
[122.757894] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[122.761101] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[122.952312] [026/133] (904s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[124.440351] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[124.441926] Starting dynamic subtest: pipe-A-HDMI-A-4
[124.457603] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[124.467239] Starting dynamic subtest: pipe-B-HDMI-A-4
[124.483183] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[124.492970] Starting dynamic subtest: pipe-C-HDMI-A-4
[124.509439] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[124.518920] Starting dynamic subtest: pipe-D-HDMI-A-4
[124.533308] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[124.535886] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[124.709687] [027/133] (903s left) sw_sync (alloc_fence)
[124.752621] Starting subtest: alloc_fence
[124.754220] Subtest alloc_fence: SUCCESS (0.000s)
[124.895580] [028/133] (903s left) i915_pm_rps (basic-api)
[124.947131] Starting subtest: basic-api
[124.950227] Subtest basic-api: SKIP (0.000s)
[125.071569] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[126.556181] Starting subtest: cursorB-vs-flipA-toggle
[126.559131] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[126.737704] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[128.418943] Starting subtest: cursor-rapid-movement-128x42
[128.426469] Starting dynamic subtest: pipe-A-HDMI-A-4
[128.866151] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.440s)
[128.897904] Starting dynamic subtest: pipe-D-HDMI-A-4
[129.193478] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.304s)
[129.194905] Subtest cursor-rapid-movement-128x42: SUCCESS (0.774s)
[129.635405] [031/133] (898s left) kms_dp_link_training (non-uhbr-sst)
[131.122198] Starting subtest: non-uhbr-sst
[131.128134] Subtest non-uhbr-sst: SKIP (0.000s)
[131.323133] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[132.815981] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[132.819333] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.065578] [033/133] (895s left) gem_exec_parallel (engines)
[133.119580] Starting subtest: engines
[133.123396] Starting dynamic subtest: basic
[134.659576] Dynamic subtest basic: SUCCESS (1.540s)
[134.671457] Starting dynamic subtest: contexts
[138.829229] Dynamic subtest contexts: SUCCESS (4.166s)
[138.839224] Starting dynamic subtest: fds
[143.715335] Dynamic subtest fds: SUCCESS (4.886s)
[143.725601] Starting dynamic subtest: userptr
[145.278865] Dynamic subtest userptr: SUCCESS (1.566s)
[145.280296] Subtest engines: SUCCESS (12.159s)
[145.602450] [034/133] (883s left) gem_eio (in-flight-immediate)
[145.805199] Starting subtest: in-flight-immediate
[150.366336] Subtest in-flight-immediate: SUCCESS (4.561s)
[151.949876] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[151.953824] [035/133] (876s left) prime_mmap (test_forked)
[152.013127] Starting subtest: test_forked
[152.014819] Starting dynamic subtest: test_forked-smem
[152.085211] Dynamic subtest test_forked-smem: SUCCESS (0.073s)
[152.095619] Starting dynamic subtest: test_forked-lmem0
[152.160202] Dynamic subtest test_forked-lmem0: SUCCESS (0.075s)
[152.161933] Subtest test_forked: SUCCESS (0.149s)
[152.385744] [036/133] (876s left) kms_dsc (dsc-with-formats)
[153.870532] Starting subtest: dsc-with-formats
[153.900855] Subtest dsc-with-formats: SKIP (0.002s)
[154.023196] [037/133] (874s left) prime_busy (hang)
[154.086998] Starting subtest: hang
[154.089017] Starting dynamic subtest: rcs0
[180.405926] Dynamic subtest rcs0: SUCCESS (26.318s)
[180.416168] Starting dynamic subtest: bcs0
[187.553942] Dynamic subtest bcs0: SUCCESS (7.148s)
[187.564137] Starting dynamic subtest: vcs0
[194.595428] Dynamic subtest vcs0: SUCCESS (7.040s)
[194.605606] Starting dynamic subtest: vcs1
[201.569726] Dynamic subtest vcs1: SUCCESS (6.975s)
[201.579980] Starting dynamic subtest: vecs0
[208.546367] Dynamic subtest vecs0: SUCCESS (6.974s)
[208.547901] Subtest hang: SUCCESS (54.459s)
[208.733072] [038/133] (820s left) kms_vblank (wait-idle)
[210.219189] Starting subtest: wait-idle
[210.220937] Starting dynamic subtest: pipe-A-HDMI-A-4
[212.551238] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.333s)
[212.563944] Starting dynamic subtest: pipe-D-HDMI-A-4
[214.743958] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.188s)
[214.745578] Subtest wait-idle: SUCCESS (4.527s)
[214.951857] [039/133] (814s left) kms_pm_rpm (package-g7)
[219.062988] Starting subtest: package-g7
[219.066860] Subtest package-g7: SKIP (0.000s)
[220.052057] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[221.550115] Starting subtest: flip-vs-cursor-varying-size
[236.059464] Subtest flip-vs-cursor-varying-size: SUCCESS (14.508s)
[236.292267] [041/133] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[237.785849] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[237.789198] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[238.045911] [042/133] (791s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[238.114441] Starting subtest: single-wait-all-for-submit-signaled
[238.115992] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[238.272213] [043/133] (791s left) perf (gen12-group-exclusive-stream-ctx-handle)
[238.420095] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[238.446233] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[238.521241] [044/133] (791s left) gem_wait (busy)
[238.583323] Starting subtest: busy
[238.584940] Starting dynamic subtest: all-engines
[239.179861] Dynamic subtest all-engines: SUCCESS (0.598s)
[239.191795] Starting dynamic subtest: rcs0
[239.718403] Dynamic subtest rcs0: SUCCESS (0.538s)
[239.728791] Starting dynamic subtest: bcs0
[240.257465] Dynamic subtest bcs0: SUCCESS (0.539s)
[240.267735] Starting dynamic subtest: vcs0
[240.797446] Dynamic subtest vcs0: SUCCESS (0.539s)
[240.807677] Starting dynamic subtest: vcs1
[241.336452] Dynamic subtest vcs1: SUCCESS (0.538s)
[241.346931] Starting dynamic subtest: vecs0
[241.875479] Dynamic subtest vecs0: SUCCESS (0.538s)
[241.877118] Subtest busy: SUCCESS (3.294s)
[242.176901] [045/133] (787s left) gen9_exec_parse (bb-secure)
[242.228655] Subtest bb-secure: SKIP (0.000s)
[242.305207] [046/133] (787s left) kms_cursor_edge_walk (128x128-right-edge)
[243.792596] Starting subtest: 128x128-right-edge
[243.794147] Starting dynamic subtest: pipe-A-HDMI-A-4
[247.135432] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.340s)
[247.147818] Starting dynamic subtest: pipe-D-HDMI-A-4
[250.374120] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.236s)
[250.375989] Subtest 128x128-right-edge: SUCCESS (6.581s)
[250.588426] [047/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[252.082497] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[252.086116] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.339222] [048/133] (777s left) prime_mmap (test_forked_cpu_write)
[252.385821] Starting subtest: test_forked_cpu_write
[252.387678] Starting dynamic subtest: test_forked_cpu_write-smem
[252.396388] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[252.406943] Starting dynamic subtest: test_forked_cpu_write-lmem0
[252.408680] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[252.410346] Subtest test_forked_cpu_write: SUCCESS (0.023s)
[252.609542] [049/133] (777s left) kms_addfb_basic (small-bo)
[254.094772] Starting subtest: small-bo
[254.096434] Subtest small-bo: SUCCESS (0.000s)
[254.361232] [050/133] (775s left) kms_chamelium_audio (dp-audio)
[255.896756] Subtest dp-audio: SKIP (0.000s)
[256.010452] [051/133] (774s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[257.534858] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[257.645801] [052/133] (772s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[259.138263] Starting subtest: psr-shrfb-scaledprimary
[259.141676] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[259.380169] [053/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[260.865453] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[260.869330] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[261.084571] [054/133] (769s left) perf (i915-ref-count)
[261.244282] Starting subtest: i915-ref-count
[261.286552] Subtest i915-ref-count: SUCCESS (0.039s)
[261.361730] [055/133] (769s left) kms_joiner (invalid-modeset-force-big-joiner)
[262.848297] Starting subtest: invalid-modeset-force-big-joiner
[262.851895] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[263.032032] [056/133] (767s left) kms_cursor_crc (cursor-alpha-opaque)
[264.517720] Starting subtest: cursor-alpha-opaque
[264.519331] Starting dynamic subtest: pipe-A-HDMI-A-4
[265.138058] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.619s)
[265.150461] Starting dynamic subtest: pipe-D-HDMI-A-4
[265.563846] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.423s)
[265.565343] Subtest cursor-alpha-opaque: SUCCESS (1.046s)
[266.308038] [057/133] (764s left) kms_legacy_colorkey (basic)
[267.795124] Starting subtest: basic
[267.796813] Starting dynamic subtest: pipe-A
[267.891709] Dynamic subtest pipe-A: SUCCESS (0.098s)
[267.910901] Starting dynamic subtest: pipe-B
[267.912536] Dynamic subtest pipe-B: SUCCESS (0.001s)
[267.942804] Starting dynamic subtest: pipe-C
[267.944959] Dynamic subtest pipe-C: SUCCESS (0.001s)
[267.985618] Starting dynamic subtest: pipe-D
[267.987768] Dynamic subtest pipe-D: SUCCESS (0.001s)
[267.989968] Subtest basic: SUCCESS (0.106s)
[268.080457] [058/133] (762s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[269.587030] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[269.590945] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[269.845836] [059/133] (761s left) kms_addfb_basic (bad-pitch-32)
[269.892827] Starting subtest: bad-pitch-32
[269.894471] Subtest bad-pitch-32: SUCCESS (0.000s)
[271.597939] [060/133] (759s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[271.651274] Starting subtest: x-tiled-to-vebox-y-tiled
[271.653042] Starting dynamic subtest: smem
[271.731497] Dynamic subtest smem: SUCCESS (0.080s)
[271.742174] Starting dynamic subtest: lmem0
[272.489158] Dynamic subtest lmem0: SUCCESS (0.753s)
[272.491045] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.835s)
[272.796238] [061/133] (758s left) gem_exec_reloc (basic-range)
[272.846923] Subtest basic-range: SKIP (0.000s)
[272.954614] [062/133] (758s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[274.458948] Starting subtest: yf-tiled-64bpp-rotate-0
[274.462992] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[274.697728] [063/133] (756s left) syncobj_wait (wait-all-for-submit-snapshot)
[274.755884] Starting subtest: wait-all-for-submit-snapshot
[274.827858] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[274.997872] [064/133] (756s left) kms_async_flips (invalid-async-flip)
[276.484155] Starting subtest: invalid-async-flip
[276.710044] Starting dynamic subtest: pipe-A-HDMI-A-4
[277.124130] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.414s)
[277.304888] Starting dynamic subtest: pipe-B-HDMI-A-4
[277.397579] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.099s)
[277.568787] Starting dynamic subtest: pipe-C-HDMI-A-4
[277.672875] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.113s)
[277.829248] Starting dynamic subtest: pipe-D-HDMI-A-4
[277.931323] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.111s)
[277.932950] Subtest invalid-async-flip: SUCCESS (1.449s)
[278.353922] [065/133] (753s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[279.843334] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[279.851580] Starting dynamic subtest: A-HDMI-A4
[280.551394] Dynamic subtest A-HDMI-A4: SUCCESS (0.699s)
[280.561801] Starting dynamic subtest: B-HDMI-A4
[281.175733] Dynamic subtest B-HDMI-A4: SUCCESS (0.625s)
[281.186112] Starting dynamic subtest: C-HDMI-A4
[281.834889] Dynamic subtest C-HDMI-A4: SUCCESS (0.656s)
[281.845646] Starting dynamic subtest: D-HDMI-A4
[282.455482] Dynamic subtest D-HDMI-A4: SUCCESS (0.621s)
[282.456914] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.613s)
[282.657577] [066/133] (749s left) kms_frontbuffer_tracking (fbc-suspend)
[284.155240] Starting subtest: fbc-suspend
[330.281636] Subtest fbc-suspend: SUCCESS (22.634s)
[333.559218] [067/133] (701s left) syncobj_timeline (invalid-transfer-bad-pad)
[333.607222] Starting subtest: invalid-transfer-bad-pad
[333.609185] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[333.784715] [068/133] (701s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[335.358390] Starting subtest: 4-tiled-64bpp-rotate-90
[335.361857] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[335.634251] [069/133] (699s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[335.686916] Starting subtest: saturated-hostile-nopreempt
[335.688473] Starting dynamic subtest: rcs0
[336.514519] Dynamic subtest rcs0: SUCCESS (0.798s)
[336.531199] Starting dynamic subtest: bcs0
[337.307169] Dynamic subtest bcs0: SUCCESS (0.765s)
[337.322307] Starting dynamic subtest: vcs0
[338.120360] Dynamic subtest vcs0: SUCCESS (0.787s)
[338.133481] Starting dynamic subtest: vcs1
[338.899820] Dynamic subtest vcs1: SUCCESS (0.758s)
[338.913230] Starting dynamic subtest: vecs0
[339.696992] Dynamic subtest vecs0: SUCCESS (0.776s)
[339.698705] Subtest saturated-hostile-nopreempt: SUCCESS (3.895s)
[339.879248] [070/133] (695s left) gem_exec_big (single)
[339.932055] Starting subtest: single
[347.357641] Subtest single: SUCCESS (7.322s)
[348.254470] [071/133] (687s left) gem_exec_fence (submit67)
[348.477852] Starting subtest: submit67
[348.480780] Subtest submit67: SKIP (0.000s)
[349.147976] [072/133] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[350.654261] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[350.657071] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[350.851755] [073/133] (684s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[352.364544] Starting subtest: fbc-rgb101010-draw-mmap-wc
[352.369681] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[352.567006] [074/133] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[354.065787] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[354.068630] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.300182] [075/133] (681s left) i915_drm_fdinfo (busy-idle)
[354.350050] Starting subtest: busy-idle
[354.351428] Starting dynamic subtest: rcs0
[354.354152] Dynamic subtest rcs0: SKIP (0.001s)
[354.370066] Starting dynamic subtest: bcs0
[354.373127] Dynamic subtest bcs0: SKIP (0.001s)
[354.386026] Starting dynamic subtest: vcs0
[354.389142] Dynamic subtest vcs0: SKIP (0.000s)
[354.402039] Starting dynamic subtest: vcs1
[354.405145] Dynamic subtest vcs1: SKIP (0.000s)
[354.417522] Starting dynamic subtest: vecs0
[354.420685] Dynamic subtest vecs0: SKIP (0.001s)
[354.423824] Subtest busy-idle: SKIP (0.009s)
[354.492514] [076/133] (681s left) kms_psr (psr2-primary-page-flip)
[355.986079] Subtest psr2-primary-page-flip: SKIP (0.000s)
[356.062208] [077/133] (679s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[357.554488] Starting subtest: cursorA-vs-flipB-atomic
[357.557342] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[357.757206] [078/133] (678s left) kms_prop_blob (blob-prop-lifetime)
[357.803459] Starting subtest: blob-prop-lifetime
[357.804793] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[357.994056] [079/133] (678s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[359.484493] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[359.486167] Starting dynamic subtest: pipe-A
[362.145205] Dynamic subtest pipe-A: SUCCESS (2.656s)
[362.158655] Starting dynamic subtest: pipe-B
[364.706413] Dynamic subtest pipe-B: SUCCESS (2.556s)
[364.727162] Starting dynamic subtest: pipe-C
[364.997570] Dynamic subtest pipe-C: SUCCESS (0.289s)
[365.015065] Starting dynamic subtest: pipe-D
[365.289414] Dynamic subtest pipe-D: SUCCESS (0.289s)
[365.291166] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.797s)
[365.551919] [080/133] (670s left) kms_pipe_crc_basic (hang-read-crc)
[367.042247] Starting subtest: hang-read-crc
[367.046553] Starting dynamic subtest: pipe-A-HDMI-A-4
[368.528140] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.482s)
[368.541416] Starting dynamic subtest: pipe-B-HDMI-A-4
[369.765481] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.234s)
[369.778591] Starting dynamic subtest: pipe-C-HDMI-A-4
[371.018347] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.251s)
[371.034381] Starting dynamic subtest: pipe-D-HDMI-A-4
[372.252720] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.230s)
[372.254402] Subtest hang-read-crc: SUCCESS (5.209s)
[372.477644] [081/133] (663s left) kms_selftest (drm_format)
[372.542165] Starting subtest: drm_format
[372.561772] Starting dynamic subtest: drm_test_format_block_width_invalid
[372.644649] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.081s)
[372.657532] Starting dynamic subtest: drm_test_format_block_width_one_plane
[372.729087] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.080s)
[372.780019] Starting dynamic subtest: drm_test_format_block_width_two_plane
[372.812313] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.077s)
[372.829247] Starting dynamic subtest: drm_test_format_block_width_three_plane
[372.885104] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.069s)
[372.930238] Starting dynamic subtest: drm_test_format_block_width_tiled
[372.964958] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.076s)
[372.987135] Starting dynamic subtest: drm_test_format_block_height_invalid
[373.033091] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.065s)
[373.054096] Starting dynamic subtest: drm_test_format_block_height_one_plane
[373.117089] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.079s)
[373.157616] Starting dynamic subtest: drm_test_format_block_height_two_plane
[373.200330] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.080s)
[373.228715] Starting dynamic subtest: drm_test_format_block_height_three_plane
[373.292833] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.087s)
[373.340455] Starting dynamic subtest: drm_test_format_block_height_tiled
[373.375544] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.077s)
[373.395661] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[373.456396] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.077s)
[373.504970] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[373.547379] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.084s)
[373.563508] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[373.634697] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.082s)
[373.648052] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[373.714157] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.076s)
[373.761779] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[373.800673] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.082s)
[373.829637] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[373.879207] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.074s)
[373.922236] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[373.956469] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.072s)
[373.978078] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[374.057337] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.096s)
[374.061455] Subtest drm_format: SUCCESS (1.514s)
[374.314677] [082/133] (662s left) gem_close_race (multigpu-basic-process)
[374.387354] Starting subtest: multigpu-basic-process
[374.390756] Subtest multigpu-basic-process: SKIP (0.000s)
[374.686785] [083/133] (661s left) gem_set_tiling_vs_gtt
[374.815997] [084/133] (661s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[376.300708] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[376.302412] Starting dynamic subtest: pipe-A
[376.457484] Dynamic subtest pipe-A: SUCCESS (0.157s)
[376.478153] Starting dynamic subtest: pipe-B
[376.617446] Dynamic subtest pipe-B: SUCCESS (0.158s)
[376.630326] Starting dynamic subtest: pipe-C
[376.758411] Dynamic subtest pipe-C: SUCCESS (0.139s)
[376.771531] Starting dynamic subtest: pipe-D
[376.898768] Dynamic subtest pipe-D: SUCCESS (0.139s)
[376.900080] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.600s)
[377.147596] [085/133] (659s left) kms_addfb_basic (basic-y-tiled-legacy)
[377.196434] Starting subtest: basic-y-tiled-legacy
[377.199271] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[378.891426] [086/133] (657s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[380.401157] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[381.675294] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.273s)
[381.953920] [087/133] (654s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[382.005761] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[382.007237] Starting dynamic subtest: smem
[382.106521] Dynamic subtest smem: SUCCESS (0.100s)
[382.119470] Starting dynamic subtest: lmem0
[383.219988] Dynamic subtest lmem0: SUCCESS (1.111s)
[383.221419] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.214s)
[383.555634] [088/133] (653s left) gem_caching (writes)
[383.607106] Starting subtest: writes
[388.672948] Subtest writes: SUCCESS (5.064s)
[388.850945] [089/133] (648s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[388.903538] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[389.008984] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[389.197389] [090/133] (647s left) kms_flip (wf_vblank-ts-check)
[390.685335] Starting subtest: wf_vblank-ts-check
[390.692948] Starting dynamic subtest: A-HDMI-A4
[398.713608] Dynamic subtest A-HDMI-A4: SUCCESS (8.017s)
[398.731256] Starting dynamic subtest: B-HDMI-A4
[406.681387] Dynamic subtest B-HDMI-A4: SUCCESS (7.962s)
[406.695117] Starting dynamic subtest: C-HDMI-A4
[414.652560] Dynamic subtest C-HDMI-A4: SUCCESS (7.966s)
[414.668214] Starting dynamic subtest: D-HDMI-A4
[422.633496] Dynamic subtest D-HDMI-A4: SUCCESS (7.966s)
[422.635075] Subtest wf_vblank-ts-check: SUCCESS (31.927s)
[422.902285] [091/133] (614s left) gem_lmem_evict (dontneed-evict-race)
[427.502726] Starting subtest: dontneed-evict-race
[429.546042] Subtest dontneed-evict-race: SUCCESS (2.078s)
[431.384821] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[431.386265] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[431.389146] [092/133] (605s left) gem_mmap_gtt (medium-copy-odd)
[434.739607] Subtest medium-copy-odd: SKIP (0.000s)
[434.816252] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[434.819850] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[434.824046] [093/133] (602s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[436.311884] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[436.320420] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[436.470992] [094/133] (600s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[437.965206] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[437.966625] Starting dynamic subtest: pipe-A-HDMI-A-4
[438.004255] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[438.015613] Starting dynamic subtest: pipe-B-HDMI-A-4
[438.053347] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[438.064277] Starting dynamic subtest: pipe-C-HDMI-A-4
[438.107171] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[438.118521] Starting dynamic subtest: pipe-D-HDMI-A-4
[438.174147] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[438.177315] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.021s)
[438.296982] [095/133] (599s left) gem_exec_suspend (basic-s0)
[438.356777] Starting subtest: basic-S0
[438.358211] Starting dynamic subtest: smem
[458.717182] Dynamic subtest smem: SUCCESS (5.261s)
[458.729165] Starting dynamic subtest: lmem0
[478.752026] Dynamic subtest lmem0: SUCCESS (4.854s)
[478.754121] Subtest basic-S0: SUCCESS (10.119s)
[484.081966] [096/133] (558s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[485.559283] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[485.562441] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[485.764203] [097/133] (556s left) gem_mmap_offset (bad-extensions)
[485.809807] Starting subtest: bad-extensions
[485.811481] Subtest bad-extensions: SUCCESS (0.000s)
[486.023497] [098/133] (556s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[487.472818] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[487.476005] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[487.677168] [099/133] (555s left) gem_mmap_gtt (cpuset-big-copy-odd)
[487.724670] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[487.791453] [100/133] (555s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[489.265385] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[489.268723] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[489.481708] [101/133] (553s left) kms_psr (fbc-psr2-sprite-render)
[490.974924] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[491.061736] [102/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[492.531224] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[492.533839] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[492.799123] [103/133] (550s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[494.269056] Starting subtest: crc-primary-basic-y-tiled-ccs
[494.270843] Starting dynamic subtest: pipe-A-HDMI-A-4
[494.291326] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[494.303244] Starting dynamic subtest: pipe-B-HDMI-A-4
[494.328140] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[494.339441] Starting dynamic subtest: pipe-C-HDMI-A-4
[494.354780] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[494.366296] Starting dynamic subtest: pipe-D-HDMI-A-4
[494.383952] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[494.387055] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[494.591177] [104/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[496.073244] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[496.075983] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[496.313288] [105/133] (547s left) api_intel_bb (add-remove-objects)
[496.357569] Starting subtest: add-remove-objects
[496.380759] Subtest add-remove-objects: SUCCESS (0.024s)
[496.621561] [106/133] (547s left) sysfs_heartbeat_interval (nopreempt)
[496.673594] Starting subtest: nopreempt
[496.675127] Starting dynamic subtest: vecs0
[500.775529] Dynamic subtest vecs0: SUCCESS (4.125s)
[500.788949] Starting dynamic subtest: vcs0
[504.772933] Dynamic subtest vcs0: SUCCESS (4.010s)
[504.785702] Starting dynamic subtest: bcs0
[508.818588] Dynamic subtest bcs0: SUCCESS (4.054s)
[508.831230] Starting dynamic subtest: rcs0
[512.927467] Dynamic subtest rcs0: SUCCESS (4.115s)
[512.942210] Starting dynamic subtest: vcs1
[516.954964] Dynamic subtest vcs1: SUCCESS (4.026s)
[516.956686] Subtest nopreempt: SUCCESS (20.339s)
[517.177966] [107/133] (526s left) kms_getfb (getfb2-into-addfb2)
[518.670170] Starting subtest: getfb2-into-addfb2
[518.671690] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[518.930929] [108/133] (525s left) gem_close (basic)
[518.982583] Starting subtest: basic
[518.984201] Subtest basic: SUCCESS (0.000s)
[519.157425] [109/133] (524s left) gem_exec_schedule (preemptive-hang)
[519.330729] Starting subtest: preemptive-hang
[519.332391] Starting dynamic subtest: rcs0
[528.840049] Dynamic subtest rcs0: SUCCESS (9.511s)
[528.852837] Starting dynamic subtest: bcs0
[537.861279] Dynamic subtest bcs0: SUCCESS (9.020s)
[537.874152] Starting dynamic subtest: vcs0
[546.830350] Dynamic subtest vcs0: SUCCESS (8.970s)
[546.843227] Starting dynamic subtest: vcs1
[555.854419] Dynamic subtest vcs1: SUCCESS (9.025s)
[555.867451] Starting dynamic subtest: vecs0
[564.869416] Dynamic subtest vecs0: SUCCESS (9.018s)
[564.871099] Subtest preemptive-hang: SUCCESS (45.552s)
[565.221647] [110/133] (478s left) i915_drm_fdinfo (virtual-busy-idle)
[565.271865] Starting subtest: virtual-busy-idle
[565.275538] Subtest virtual-busy-idle: SKIP (0.000s)
[565.419023] [111/133] (478s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[566.910644] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[566.913775] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[567.168033] [112/133] (477s left) gem_linear_blits (interruptible)
[567.416025] Starting subtest: interruptible
[575.921058] Subtest interruptible: SUCCESS (8.505s)
[576.132898] [113/133] (468s left) gem_ctx_persistence (engines-mixed)
[576.246812] Starting subtest: engines-mixed
[576.248282] Starting dynamic subtest: rcs0
[576.322339] Dynamic subtest rcs0: SUCCESS (0.085s)
[576.341684] Starting dynamic subtest: bcs0
[576.380474] Dynamic subtest bcs0: SUCCESS (0.056s)
[576.419609] Starting dynamic subtest: vcs0
[576.449384] Dynamic subtest vcs0: SUCCESS (0.066s)
[576.475094] Starting dynamic subtest: vcs1
[576.519854] Dynamic subtest vcs1: SUCCESS (0.068s)
[576.561358] Starting dynamic subtest: vecs0
[576.599393] Dynamic subtest vecs0: SUCCESS (0.075s)
[576.601058] Subtest engines-mixed: SUCCESS (0.364s)
[576.824507] [114/133] (467s left) perf_pmu (init-wait)
[576.874770] Starting subtest: init-wait
[576.876329] Starting dynamic subtest: rcs0
[576.877881] Dynamic subtest rcs0: SUCCESS (0.002s)
[576.890780] Starting dynamic subtest: bcs0
[576.892360] Dynamic subtest bcs0: SUCCESS (0.001s)
[576.905459] Starting dynamic subtest: vcs0
[576.907280] Dynamic subtest vcs0: SUCCESS (0.001s)
[576.920202] Starting dynamic subtest: vcs1
[576.921914] Dynamic subtest vcs1: SUCCESS (0.001s)
[576.934414] Starting dynamic subtest: vecs0
[576.936160] Dynamic subtest vecs0: SUCCESS (0.001s)
[576.937798] Subtest init-wait: SUCCESS (0.011s)
[577.009220] [115/133] (467s left) gem_exec_reloc (basic-gtt-cpu-active)
[577.064770] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[577.176780] [116/133] (467s left) kms_pm_lpsp (screens-disabled)
[579.681313] Starting subtest: screens-disabled
[579.684649] Subtest screens-disabled: SKIP (0.000s)
[579.889454] [117/133] (464s left) kms_flip (flip-vs-expired-vblank-interruptible)
[581.384247] Starting subtest: flip-vs-expired-vblank-interruptible
[581.390890] Starting dynamic subtest: A-HDMI-A4
[589.179659] Dynamic subtest A-HDMI-A4: SUCCESS (7.784s)
[589.204674] Starting dynamic subtest: B-HDMI-A4
[596.846153] Dynamic subtest B-HDMI-A4: SUCCESS (7.654s)
[596.859351] Starting dynamic subtest: C-HDMI-A4
[604.499185] Dynamic subtest C-HDMI-A4: SUCCESS (7.650s)
[604.541735] Starting dynamic subtest: D-HDMI-A4
[612.181840] Dynamic subtest D-HDMI-A4: SUCCESS (7.674s)
[612.183373] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.793s)
[612.459403] [118/133] (432s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[613.969813] Starting subtest: psr-1p-primscrn-cur-indfb-move
[613.975193] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[614.228615] [119/133] (430s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[615.716610] Starting subtest: plane-all-modeset-transition-internal-panels
[615.719535] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[615.866160] [120/133] (429s left) gem_userptr_blits (stress-mm)
[615.950941] Starting subtest: stress-mm
[621.320217] Subtest stress-mm: SUCCESS (5.369s)
[621.566896] [121/133] (423s left) syncobj_eventfd (invalid-bad-flags)
[621.628820] Starting subtest: invalid-bad-flags
[621.630446] Subtest invalid-bad-flags: SUCCESS (0.000s)
[621.796440] [122/133] (423s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[621.842957] Starting subtest: framebuffer-vs-set-tiling
[621.846276] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[623.548691] [123/133] (421s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[625.038669] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[625.041401] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[625.281915] [124/133] (420s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[625.329686] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[625.331179] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[625.523551] [125/133] (420s left) kms_flip (2x-modeset-vs-vblank-race)
[627.007580] Starting subtest: 2x-modeset-vs-vblank-race
[627.026272] Subtest 2x-modeset-vs-vblank-race: SKIP (0.018s)
[627.259793] [126/133] (418s left) i915_query (query-regions-garbage-items)
[627.305589] Starting subtest: query-regions-garbage-items
[627.307369] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[627.435519] [127/133] (418s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[627.483497] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[627.568939] [128/133] (418s left) gem_exec_balancer (full-late)
[627.624939] Starting subtest: full-late
[629.975768] Subtest full-late: SUCCESS (2.351s)
[630.451460] [129/133] (415s left) gem_exec_reloc (basic-write-wc)
[630.504514] Subtest basic-write-wc: SKIP (0.000s)
[630.603864] [130/133] (415s left) kms_force_connector_basic (force-load-detect)
[630.732905] Starting subtest: force-load-detect
[630.735639] Subtest force-load-detect: SKIP (0.000s)
[631.724420] [131/133] (414s left) kms_chamelium_hpd (hdmi-hpd-fast)
[633.280796] Subtest hdmi-hpd-fast: SKIP (0.000s)
[633.457501] [132/133] (413s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[634.977563] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[634.979052] Starting dynamic subtest: pipe-A-valid-mode
[635.772707] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.794s)
[635.776445] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.796s)
[636.021893] [133/133] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[637.513869] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[637.516644] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[637.757623] 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.