[68.329771] Initializing watchdogs
[68.329852]   /dev/watchdog0
[68.360573] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.375673] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.380655] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.383938] [001/133] (960s left) sw_sync (timeline_closed)
[68.437493] Starting subtest: timeline_closed
[68.439074] Subtest timeline_closed: SUCCESS (0.000s)
[68.531686] [002/133] (960s left) gem_busy (close-race)
[68.594102] Starting subtest: close-race
[90.572388] Subtest close-race: SUCCESS (21.997s)
[91.209048] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[91.212620] [003/133] (937s left) i915_query (query-topology-garbage-items)
[91.310577] Starting subtest: query-topology-garbage-items
[91.311866] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[91.417196] [004/133] (937s left) gem_userptr_blits (dmabuf-unsync)
[91.475767] Subtest dmabuf-unsync: SKIP (0.000s)
[91.657717] [005/133] (937s left) perf (gen8-unprivileged-single-ctx-counters)
[91.848579] Starting subtest: gen8-unprivileged-single-ctx-counters
[91.853729] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[91.916666] [006/133] (937s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[93.413090] Starting subtest: flip-vs-dpms-off-vs-modeset
[93.418875] Starting dynamic subtest: A-HDMI-A4
[94.171032] Dynamic subtest A-HDMI-A4: SUCCESS (0.751s)
[94.180790] Starting dynamic subtest: B-HDMI-A4
[94.853944] Dynamic subtest B-HDMI-A4: SUCCESS (0.680s)
[94.863897] Starting dynamic subtest: C-HDMI-A4
[95.553570] Dynamic subtest C-HDMI-A4: SUCCESS (0.700s)
[95.563678] Starting dynamic subtest: D-HDMI-A4
[96.257887] Dynamic subtest D-HDMI-A4: SUCCESS (0.705s)
[96.259507] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.845s)
[96.446156] [007/133] (932s left) kms_feature_discovery (chamelium)
[97.958724] Starting subtest: chamelium
[97.961922] Subtest chamelium: SKIP (0.000s)
[98.068805] [008/133] (931s left) kms_atomic_transition (plane-all-modeset-transition)
[99.562568] Starting subtest: plane-all-modeset-transition
[99.564157] Starting dynamic subtest: pipe-A-HDMI-A-4
[111.227250] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.658s)
[111.279747] Starting dynamic subtest: pipe-B-HDMI-A-4
[119.272814] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (8.001s)
[119.288952] Subtest plane-all-modeset-transition: SUCCESS (19.725s)
[119.452073] [009/133] (910s left) gem_tiled_partial_pwrite_pread (reads)
[119.504615] Subtest reads: SKIP (0.000s)
[119.579684] [010/133] (909s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[121.062541] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[121.103243] Starting dynamic subtest: pipe-A-plane-0
[121.689789] Dynamic subtest pipe-A-plane-0: SUCCESS (0.586s)
[121.725466] Starting dynamic subtest: pipe-A-plane-3
[122.036664] Dynamic subtest pipe-A-plane-3: SUCCESS (0.346s)
[122.048129] Starting dynamic subtest: pipe-A-plane-5
[122.369523] Dynamic subtest pipe-A-plane-5: SUCCESS (0.333s)
[122.544903] Starting dynamic subtest: pipe-B-plane-0
[122.938274] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[122.952383] Starting dynamic subtest: pipe-B-plane-3
[123.303811] Dynamic subtest pipe-B-plane-3: SUCCESS (0.364s)
[123.332458] Starting dynamic subtest: pipe-B-plane-5
[123.653882] Dynamic subtest pipe-B-plane-5: SUCCESS (0.349s)
[123.743939] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (2.681s)
[123.920855] [011/133] (905s left) gem_mmap_offset (oob-read)
[123.968426] Starting subtest: oob-read
[123.969929] Subtest oob-read: SUCCESS (0.000s)
[124.151577] [012/133] (905s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[125.637875] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[125.639826] Starting dynamic subtest: pipe-A-HDMI-A-4
[125.667869] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[125.677639] Starting dynamic subtest: pipe-B-HDMI-A-4
[125.692726] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[125.702418] Starting dynamic subtest: pipe-C-HDMI-A-4
[125.718100] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[125.727911] Starting dynamic subtest: pipe-D-HDMI-A-4
[125.745872] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[125.749137] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[125.866701] [013/133] (903s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[125.915137] Starting subtest: multi-wait-available-submitted-signaled
[125.916900] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[126.063658] [014/133] (903s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[127.553944] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[127.631824] [015/133] (902s left) gem_mmap_wc (read)
[127.682488] Subtest read: SKIP (0.000s)
[127.763337] [016/133] (902s left) kms_big_fb (linear-16bpp-rotate-180)
[129.274150] Starting subtest: linear-16bpp-rotate-180
[131.289933] Subtest linear-16bpp-rotate-180: SUCCESS (2.012s)
[131.512515] [017/133] (898s left) kms_psr (fbc-psr2-sprite-render)
[133.001881] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[133.079616] [018/133] (897s left) gem_eio (in-flight-external)
[133.273834] Starting subtest: in-flight-external
[134.882857] Subtest in-flight-external: SUCCESS (1.613s)
[136.443366] [019/133] (893s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[138.156510] Starting subtest: cursor-rapid-movement-256x256
[138.166329] Starting dynamic subtest: pipe-A-HDMI-A-4
[138.592418] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.428s)
[138.625422] Starting dynamic subtest: pipe-D-HDMI-A-4
[138.919426] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.303s)
[138.921015] Subtest cursor-rapid-movement-256x256: SUCCESS (0.761s)
[139.303749] [020/133] (890s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[140.802095] Starting subtest: extended-modeset-hang-oldfb-with-reset
[140.805185] Starting dynamic subtest: pipe-A
[151.278838] Dynamic subtest pipe-A: SUCCESS (10.474s)
[151.291140] Starting dynamic subtest: pipe-D
[162.012619] Dynamic subtest pipe-D: SUCCESS (10.730s)
[162.013934] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.211s)
[162.204717] [021/133] (868s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[163.691487] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[163.692913] Starting dynamic subtest: pipe-A-HDMI-A-4
[163.706984] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[163.717898] Starting dynamic subtest: pipe-B-HDMI-A-4
[163.732457] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[163.742955] Starting dynamic subtest: pipe-C-HDMI-A-4
[163.757955] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[163.768609] Starting dynamic subtest: pipe-D-HDMI-A-4
[163.784094] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[163.787220] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[163.932802] [022/133] (866s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[165.427187] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[165.430185] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[165.621444] [023/133] (864s left) kms_big_fb (yf-tiled-addfb)
[167.126766] Starting subtest: yf-tiled-addfb
[167.130238] Subtest yf-tiled-addfb: SKIP (0.000s)
[167.279656] [024/133] (863s left) gem_close_race (multigpu-basic-threads)
[167.394501] Starting subtest: multigpu-basic-threads
[167.398438] Subtest multigpu-basic-threads: SKIP (0.000s)
[167.706790] [025/133] (863s left) api_intel_allocator (two-level-inception-interruptible)
[167.776117] Starting subtest: two-level-inception-interruptible
[173.232538] Subtest two-level-inception-interruptible: SUCCESS (5.454s)
[173.435332] [026/133] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[174.931494] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[174.936802] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[175.114653] [027/133] (855s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[176.600637] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[176.602241] Starting dynamic subtest: pipe-A-HDMI-A-4
[176.618110] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[176.629028] Starting dynamic subtest: pipe-B-HDMI-A-4
[176.647774] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[176.658291] Starting dynamic subtest: pipe-C-HDMI-A-4
[176.674698] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[176.685439] Starting dynamic subtest: pipe-D-HDMI-A-4
[176.699191] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[176.701708] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[176.844727] [028/133] (854s left) gem_mmap_wc (copy)
[176.893240] Subtest copy: SKIP (0.000s)
[176.974023] [029/133] (854s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[178.461375] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[178.464099] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[178.594575] [030/133] (852s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[180.109552] Starting subtest: x-tiled-16bpp-rotate-90
[180.215950] Subtest x-tiled-16bpp-rotate-90: SKIP (0.103s)
[180.384473] [031/133] (850s left) kms_cursor_crc (cursor-sliding-256x85)
[182.113210] Starting subtest: cursor-sliding-256x85
[182.120723] Starting dynamic subtest: pipe-A-HDMI-A-4
[186.568590] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.448s)
[186.600369] Starting dynamic subtest: pipe-D-HDMI-A-4
[190.894101] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.303s)
[190.895803] Subtest cursor-sliding-256x85: SUCCESS (8.781s)
[191.205509] [032/133] (840s left) gem_exec_fence (syncobj-invalid-flags)
[191.651444] Starting subtest: syncobj-invalid-flags
[191.653110] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[192.165381] [033/133] (839s left) kms_flip (dpms-vs-vblank-race-interruptible)
[193.652812] Starting subtest: dpms-vs-vblank-race-interruptible
[193.660913] Starting dynamic subtest: A-HDMI-A4
[196.669978] Dynamic subtest A-HDMI-A4: SUCCESS (3.008s)
[196.680897] Starting dynamic subtest: B-HDMI-A4
[199.613583] Dynamic subtest B-HDMI-A4: SUCCESS (2.942s)
[199.624531] Starting dynamic subtest: C-HDMI-A4
[202.548205] Dynamic subtest C-HDMI-A4: SUCCESS (2.932s)
[202.559119] Starting dynamic subtest: D-HDMI-A4
[205.474968] Dynamic subtest D-HDMI-A4: SUCCESS (2.924s)
[205.476401] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.821s)
[205.660653] [034/133] (825s left) kms_addfb_basic (basic-y-tiled-legacy)
[205.747230] Starting subtest: basic-y-tiled-legacy
[205.751466] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[207.374862] [035/133] (824s left) gem_lmem_swapping (heavy-verify-multi)
[211.651743] Starting subtest: heavy-verify-multi
[211.653567] Starting dynamic subtest: lmem0
[227.642540] Dynamic subtest lmem0: SUCCESS (15.985s)
[227.644220] Subtest heavy-verify-multi: SUCCESS (15.987s)
[228.926268] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[228.927443] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[228.930572] [036/133] (802s left) api_intel_bb (misplaced-blitter)
[232.208751] Starting subtest: misplaced-blitter
[232.250629] Subtest misplaced-blitter: SUCCESS (0.034s)
[232.353868] [FACT api_intel_bb (misplaced-blitter)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[232.357418] [FACT api_intel_bb (misplaced-blitter)] new: kernel.kmod_is_loaded.i915: true
[232.361698] [037/133] (799s left) kms_vblank (query-idle-hang)
[233.852210] Starting subtest: query-idle-hang
[233.853900] Starting dynamic subtest: pipe-A-HDMI-A-4
[260.448444] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.594s)
[260.463359] Starting dynamic subtest: pipe-D-HDMI-A-4
[285.458726] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.004s)
[285.460257] Subtest query-idle-hang: SUCCESS (51.608s)
[285.638995] [038/133] (746s left) kms_fbcon_fbt (psr-suspend)
[285.689964] Starting subtest: psr-suspend
[285.693457] Subtest psr-suspend: SKIP (0.000s)
[285.909907] [039/133] (746s left) kms_cursor_crc (cursor-offscreen-128x42)
[287.601609] Starting subtest: cursor-offscreen-128x42
[287.609523] Starting dynamic subtest: pipe-A-HDMI-A-4
[290.125047] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.517s)
[290.158728] Starting dynamic subtest: pipe-D-HDMI-A-4
[292.554549] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.405s)
[292.558486] Subtest cursor-offscreen-128x42: SUCCESS (4.953s)
[292.945676] [040/133] (739s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[294.433956] Starting subtest: bad-pixel-format-y-tiled-ccs
[294.436388] Starting dynamic subtest: pipe-A-HDMI-A-4
[294.458640] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[294.468663] Starting dynamic subtest: pipe-B-HDMI-A-4
[294.481591] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[294.490993] Starting dynamic subtest: pipe-C-HDMI-A-4
[294.504375] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[294.513950] Starting dynamic subtest: pipe-D-HDMI-A-4
[294.527764] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[294.530507] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.011s)
[294.673312] [041/133] (737s left) kms_atomic_interruptible (universal-setplane-cursor)
[296.162259] Starting subtest: universal-setplane-cursor
[296.163748] Starting dynamic subtest: pipe-A-HDMI-A-4
[302.369260] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.206s)
[302.370830] Subtest universal-setplane-cursor: SUCCESS (6.209s)
[302.534373] [042/133] (729s left) gem_lmem_swapping (verify-ccs)
[306.699830] Starting subtest: verify-ccs
[306.701739] Starting dynamic subtest: lmem0
[306.705302] Dynamic subtest lmem0: SKIP (0.000s)
[306.710809] Subtest verify-ccs: SKIP (0.002s)
[310.513543] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[310.514940] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[310.517743] [043/133] (721s left) gem_workarounds (reset-context)
[313.821721] Starting subtest: reset-context
[313.943262] Subtest reset-context: SUCCESS (0.121s)
[314.062368] [FACT gem_workarounds (reset-context)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[314.065753] [FACT gem_workarounds (reset-context)] new: kernel.kmod_is_loaded.i915: true
[314.069791] [044/133] (718s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[315.603188] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[315.716911] [045/133] (716s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[315.768588] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[315.772172] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[315.881180] [046/133] (716s left) gem_exec_reloc (basic-write-wc-noreloc)
[315.933908] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[316.028597] [047/133] (716s left) gem_userptr_blits (coherency-unsync)
[316.084620] Subtest coherency-unsync: SKIP (0.000s)
[316.273110] [048/133] (716s left) kms_universal_plane (universal-plane-functional)
[317.761931] Starting subtest: universal-plane-functional
[317.763714] Starting dynamic subtest: pipe-A-HDMI-A-4
[319.898604] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.136s)
[319.909313] Starting dynamic subtest: pipe-B-HDMI-A-4
[321.890819] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.989s)
[321.902774] Starting dynamic subtest: pipe-C-HDMI-A-4
[323.909467] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.014s)
[323.920531] Starting dynamic subtest: pipe-D-HDMI-A-4
[325.868608] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.959s)
[325.870433] Subtest universal-plane-functional: SUCCESS (8.110s)
[326.045669] [049/133] (706s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[327.558108] Starting subtest: 4-tiled-32bpp-rotate-180
[327.561325] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[327.735817] [050/133] (705s left) gem_ctx_persistence (engines-persistence)
[327.792112] Starting subtest: engines-persistence
[327.793791] Starting dynamic subtest: rcs0
[328.564308] Dynamic subtest rcs0: SUCCESS (0.771s)
[328.579816] Starting dynamic subtest: bcs0
[329.322968] Dynamic subtest bcs0: SUCCESS (0.756s)
[329.337980] Starting dynamic subtest: vcs0
[330.074938] Dynamic subtest vcs0: SUCCESS (0.750s)
[330.086621] Starting dynamic subtest: vcs1
[330.862259] Dynamic subtest vcs1: SUCCESS (0.785s)
[330.876756] Starting dynamic subtest: vecs0
[331.627599] Dynamic subtest vecs0: SUCCESS (0.764s)
[331.629014] Subtest engines-persistence: SUCCESS (3.837s)
[331.836522] [051/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[333.330267] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[333.333554] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[333.502394] [052/133] (699s left) kms_color (ctm-negative)
[334.991007] Starting subtest: ctm-negative
[334.992662] Starting dynamic subtest: pipe-A-HDMI-A-4
[335.667817] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.676s)
[335.678701] Starting dynamic subtest: pipe-B-HDMI-A-4
[336.197075] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.527s)
[336.208483] Starting dynamic subtest: pipe-C-HDMI-A-4
[336.737692] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.538s)
[336.749139] Starting dynamic subtest: pipe-D-HDMI-A-4
[337.230611] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.493s)
[337.232239] Subtest ctm-negative: SUCCESS (2.241s)
[337.414617] [053/133] (695s left) gem_exec_capture (capture)
[337.471931] Starting subtest: capture
[337.473314] Starting dynamic subtest: rcs0-smem
[338.357427] Dynamic subtest rcs0-smem: SUCCESS (0.885s)
[338.368581] Starting dynamic subtest: rcs0-lmem0
[339.723399] Dynamic subtest rcs0-lmem0: SUCCESS (1.365s)
[339.733935] Starting dynamic subtest: bcs0-smem
[340.585574] Dynamic subtest bcs0-smem: SUCCESS (0.861s)
[340.596346] Starting dynamic subtest: bcs0-lmem0
[341.950442] Dynamic subtest bcs0-lmem0: SUCCESS (1.363s)
[341.961102] Starting dynamic subtest: vcs0-smem
[342.813594] Dynamic subtest vcs0-smem: SUCCESS (0.861s)
[342.824346] Starting dynamic subtest: vcs0-lmem0
[344.173635] Dynamic subtest vcs0-lmem0: SUCCESS (1.359s)
[344.184317] Starting dynamic subtest: vcs1-smem
[345.189824] Dynamic subtest vcs1-smem: SUCCESS (1.014s)
[345.200563] Starting dynamic subtest: vcs1-lmem0
[346.045714] Dynamic subtest vcs1-lmem0: SUCCESS (0.855s)
[346.056427] Starting dynamic subtest: vecs0-smem
[346.966689] Dynamic subtest vecs0-smem: FAIL (0.882s)
[346.977105] Starting dynamic subtest: vecs0-lmem0
[348.348220] Dynamic subtest vecs0-lmem0: FAIL (1.371s)
[348.349817] Subtest capture: FAIL (10.830s)
[348.451905] [054/133] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[349.943784] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[349.947043] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[350.118820] [055/133] (683s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[350.178666] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[350.180381] Starting dynamic subtest: smem
[350.279016] Dynamic subtest smem: SUCCESS (0.100s)
[350.289625] Starting dynamic subtest: lmem0
[351.392735] Dynamic subtest lmem0: SUCCESS (1.109s)
[351.394243] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (1.212s)
[351.668657] [056/133] (681s left) perf (blocking)
[351.841517] Starting subtest: blocking
[351.842980] Starting dynamic subtest: 0-rcs0
[361.877061] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[361.878613] Subtest blocking: SUCCESS (10.035s)
[361.953756] [057/133] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[363.445866] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[363.448885] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[363.627525] [058/133] (669s left) gem_exec_whisper (basic-normal)
[363.687715] Starting subtest: basic-normal
[365.653615] Subtest basic-normal: SUCCESS (1.964s)
[365.880711] [059/133] (667s left) prime_busy (before-wait)
[365.935662] Starting subtest: before-wait
[365.940558] Starting dynamic subtest: rcs0
[365.987248] Dynamic subtest rcs0: SUCCESS (0.047s)
[365.998773] Starting dynamic subtest: bcs0
[366.026655] Dynamic subtest bcs0: SUCCESS (0.038s)
[366.038844] Starting dynamic subtest: vcs0
[366.066226] Dynamic subtest vcs0: SUCCESS (0.038s)
[366.085759] Starting dynamic subtest: vcs1
[366.107427] Dynamic subtest vcs1: SUCCESS (0.039s)
[366.127051] Starting dynamic subtest: vecs0
[366.148417] Dynamic subtest vecs0: SUCCESS (0.039s)
[366.260763] Subtest before-wait: SUCCESS (0.324s)
[366.442705] [060/133] (667s left) gem_exec_balancer (bonded-sync)
[366.505182] Starting subtest: bonded-sync
[366.508923] Subtest bonded-sync: SKIP (0.000s)
[366.928837] [061/133] (666s left) gem_mmap_wc (write-read)
[366.998230] Subtest write-read: SKIP (0.000s)
[367.103803] [062/133] (666s left) sysfs_preempt_timeout (timeout)
[367.155447] Starting subtest: timeout
[367.156884] Starting dynamic subtest: vecs0
[368.731383] Dynamic subtest vecs0: SUCCESS (1.573s)
[368.742703] Starting dynamic subtest: vcs0
[370.273411] Dynamic subtest vcs0: SUCCESS (1.540s)
[370.285051] Starting dynamic subtest: bcs0
[371.794710] Dynamic subtest bcs0: SUCCESS (1.519s)
[371.806399] Starting dynamic subtest: rcs0
[373.295886] Dynamic subtest rcs0: SUCCESS (1.500s)
[373.307171] Starting dynamic subtest: vcs1
[374.766119] Dynamic subtest vcs1: SUCCESS (1.468s)
[374.767880] Subtest timeout: SUCCESS (7.611s)
[374.935753] [063/133] (658s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[376.428298] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[376.431447] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[376.609522] [064/133] (657s left) gem_spin_batch (spin-each)
[376.670216] Starting subtest: spin-each
[379.959204] Subtest spin-each: SUCCESS (3.289s)
[380.299647] [065/133] (653s left) dmabuf_sync_file (export-multiwait)
[380.365365] Starting subtest: export-multiwait
[380.367173] Subtest export-multiwait: SUCCESS (0.000s)
[380.479766] [066/133] (653s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[380.528263] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[380.530121] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[380.674330] [067/133] (653s left) gem_pread (exhaustion)
[380.726234] Subtest exhaustion: SKIP (0.000s)
[380.808909] [068/133] (653s left) kms_chamelium_hpd (vga-hpd-fast)
[382.340132] Subtest vga-hpd-fast: SKIP (0.000s)
[382.452148] [069/133] (651s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[383.946514] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[383.949737] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[384.136424] [070/133] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[385.628932] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[385.632101] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[385.817407] [071/133] (648s left) kms_vrr (flipline)
[387.303093] Starting subtest: flipline
[387.308154] Subtest flipline: SKIP (0.000s)
[387.428833] [072/133] (647s left) kms_setmode (invalid-clone-exclusive-crtc)
[387.487277] Starting subtest: invalid-clone-exclusive-crtc
[387.492988] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[387.606788] [073/133] (647s left) i915_hangman (detector)
[387.674028] Starting subtest: detector
[387.675961] Starting dynamic subtest: rcs0
[397.090757] Dynamic subtest rcs0: SUCCESS (9.419s)
[397.104401] Starting dynamic subtest: bcs0
[407.127059] Dynamic subtest bcs0: SUCCESS (10.035s)
[407.144374] Starting dynamic subtest: vcs0
[417.117975] Dynamic subtest vcs0: SUCCESS (9.988s)
[417.143978] Starting dynamic subtest: vcs1
[427.101244] Dynamic subtest vcs1: SUCCESS (9.980s)
[427.118819] Starting dynamic subtest: vecs0
[437.126130] Dynamic subtest vecs0: SUCCESS (10.022s)
[437.127937] Subtest detector: SUCCESS (49.456s)
[437.285965] [074/133] (597s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[438.773050] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[438.776183] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[438.893585] [075/133] (596s left) gem_exec_reloc (basic-wc-noreloc)
[438.954161] Subtest basic-wc-noreloc: SKIP (0.000s)
[439.068793] [076/133] (595s left) i915_query (query-topology-matches-eu-total)
[439.119900] Starting subtest: query-topology-matches-eu-total
[439.122033] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[439.242817] [077/133] (595s left) kms_setmode (invalid-clone-single-crtc)
[439.293122] Starting subtest: invalid-clone-single-crtc
[439.299245] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[439.495019] [078/133] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[440.987052] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[440.990418] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[441.172223] [079/133] (594s left) kms_atomic (atomic-invalid-params)
[442.661274] Starting subtest: atomic-invalid-params
[442.665856] Starting dynamic subtest: pipe-A-HDMI-A-4
[443.039702] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.376s)
[443.041312] Subtest atomic-invalid-params: SUCCESS (0.379s)
[443.206607] [080/133] (592s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[444.692143] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[444.695331] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[444.814443] [081/133] (590s left) prime_mmap (test_aperture_limit)
[444.872968] Starting subtest: test_aperture_limit
[444.874648] Starting dynamic subtest: test_aperture_limit-smem
[444.894162] Dynamic subtest test_aperture_limit-smem: SKIP (0.021s)
[444.897902] Subtest test_aperture_limit: SKIP (0.022s)
[445.008253] [082/133] (590s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[445.071962] Starting subtest: map-fixed-invalidate-overlap-busy
[445.074587] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[445.282435] [083/133] (590s left) kms_psr (fbc-psr2-cursor-plane-move)
[446.768300] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[446.851789] [084/133] (588s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[448.340165] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[448.341662] Starting dynamic subtest: pipe-A-HDMI-A-4
[448.380146] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[448.391703] Starting dynamic subtest: pipe-B-HDMI-A-4
[448.436013] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[448.447014] Starting dynamic subtest: pipe-C-HDMI-A-4
[448.495293] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[448.506364] Starting dynamic subtest: pipe-D-HDMI-A-4
[448.549575] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[448.552930] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.022s)
[448.629638] [085/133] (587s left) gem_exec_schedule (submit-early-slice)
[448.693539] Starting subtest: submit-early-slice
[448.695144] Starting dynamic subtest: rcs0
[448.755268] Dynamic subtest rcs0: SUCCESS (0.061s)
[448.766858] Starting dynamic subtest: bcs0
[448.799917] Dynamic subtest bcs0: SUCCESS (0.043s)
[448.811278] Starting dynamic subtest: vcs0
[448.845545] Dynamic subtest vcs0: SUCCESS (0.044s)
[448.857126] Starting dynamic subtest: vcs1
[448.892361] Dynamic subtest vcs1: SUCCESS (0.045s)
[448.904027] Starting dynamic subtest: vecs0
[448.936505] Dynamic subtest vecs0: SUCCESS (0.043s)
[448.938230] Subtest submit-early-slice: SUCCESS (0.244s)
[449.347650] [086/133] (586s left) gem_exec_fence (syncobj-unused-fence)
[449.743818] Starting subtest: syncobj-unused-fence
[449.762607] Subtest syncobj-unused-fence: SUCCESS (0.019s)
[450.225622] [087/133] (585s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[451.718670] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[451.722148] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[451.913618] [088/133] (584s left) gem_wait (write-wait)
[451.990681] Starting subtest: write-wait
[451.992233] Starting dynamic subtest: all-engines
[453.098902] Dynamic subtest all-engines: SUCCESS (1.110s)
[453.116383] Starting dynamic subtest: rcs0
[454.160528] Dynamic subtest rcs0: SUCCESS (1.059s)
[454.176810] Starting dynamic subtest: bcs0
[455.223115] Dynamic subtest bcs0: SUCCESS (1.059s)
[455.245712] Starting dynamic subtest: vcs0
[456.291209] Dynamic subtest vcs0: SUCCESS (1.060s)
[456.314786] Starting dynamic subtest: vcs1
[457.359145] Dynamic subtest vcs1: SUCCESS (1.060s)
[457.407602] Starting dynamic subtest: vecs0
[458.439261] Dynamic subtest vecs0: SUCCESS (1.072s)
[458.448857] Subtest write-wait: SUCCESS (6.454s)
[458.797165] [089/133] (577s left) kms_getfb (getfb-handle-valid)
[460.282963] Starting subtest: getfb-handle-valid
[460.284358] Subtest getfb-handle-valid: SUCCESS (0.000s)
[460.473231] [090/133] (575s left) kms_psr (pr-cursor-mmap-gtt)
[461.960232] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[462.032262] [091/133] (574s left) syncobj_wait (wait-for-submit-complex)
[462.083057] Starting subtest: wait-for-submit-complex
[462.142870] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[462.299510] [092/133] (574s left) gem_basic (multigpu-create-close)
[462.348575] Starting subtest: multigpu-create-close
[462.351948] Subtest multigpu-create-close: SKIP (0.000s)
[462.474716] [093/133] (574s left) kms_pm_rpm (pc8-residency)
[466.000693] Starting subtest: pc8-residency
[466.006206] Subtest pc8-residency: SKIP (0.000s)
[466.957712] [094/133] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[468.459884] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[468.462643] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[468.634093] [095/133] (568s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[470.143849] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[470.729113] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.588s)
[470.973191] [096/133] (565s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[472.465522] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[472.470374] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[472.637224] [097/133] (564s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[474.124287] Starting subtest: compare-crc-sanitycheck-xr24
[474.125960] Starting dynamic subtest: pipe-A-HDMI-A-4
[474.682250] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.542s)
[474.693930] Starting dynamic subtest: pipe-B-HDMI-A-4
[475.069578] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.399s)
[475.085096] Starting dynamic subtest: pipe-C-HDMI-A-4
[475.505022] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.429s)
[475.518335] Starting dynamic subtest: pipe-D-HDMI-A-4
[475.885648] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.378s)
[475.887065] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.761s)
[476.061757] [098/133] (560s left) gem_render_copy (yf-tiled-ccs-to-linear)
[476.117117] Starting subtest: yf-tiled-ccs-to-linear
[476.118563] Starting dynamic subtest: smem
[476.207322] Dynamic subtest smem: SUCCESS (0.089s)
[476.219119] Starting dynamic subtest: lmem0
[476.517654] Dynamic subtest lmem0: SUCCESS (0.305s)
[476.519241] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.398s)
[476.864999] [099/133] (560s left) kms_pm_backlight (fade-with-dpms)
[478.351434] Subtest fade-with-dpms: SKIP (0.000s)
[478.436694] [100/133] (558s left) i915_pm_rpm (gem-pread)
[481.959798] Starting subtest: gem-pread
[483.211628] Subtest gem-pread: SUCCESS (1.258s)
[484.064773] [101/133] (553s left) i915_drm_fdinfo (virtual-busy)
[484.120105] Starting subtest: virtual-busy
[484.123272] Subtest virtual-busy: SKIP (0.000s)
[484.224785] [102/133] (553s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[485.712803] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[485.787985] [103/133] (551s left) kms_lease (cursor-implicit-plane)
[487.273771] Starting subtest: cursor-implicit-plane
[487.277816] Starting dynamic subtest: pipe-A-HDMI-A-4
[487.686812] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.409s)
[487.703151] Starting dynamic subtest: pipe-B-HDMI-A-4
[487.905798] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.212s)
[487.920592] Starting dynamic subtest: pipe-C-HDMI-A-4
[488.133279] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.227s)
[488.146027] Starting dynamic subtest: pipe-D-HDMI-A-4
[488.351497] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.215s)
[488.353621] Subtest cursor-implicit-plane: SUCCESS (1.077s)
[488.527314] [104/133] (548s left) syncobj_timeline (wait-any-complex)
[488.577038] Starting subtest: wait-any-complex
[488.637896] Subtest wait-any-complex: SUCCESS (0.063s)
[488.798490] [105/133] (548s left) gem_ctx_persistence (legacy-engines-mixed-process)
[488.853139] Starting subtest: legacy-engines-mixed-process
[488.854899] Starting dynamic subtest: render
[490.861664] Dynamic subtest render: SUCCESS (2.010s)
[490.876264] Starting dynamic subtest: bsd1
[492.843513] Dynamic subtest bsd1: SUCCESS (1.980s)
[492.857538] Starting dynamic subtest: bsd2
[494.904725] Dynamic subtest bsd2: SUCCESS (2.059s)
[494.919416] Starting dynamic subtest: blt
[496.875608] Dynamic subtest blt: SUCCESS (1.968s)
[496.890236] Starting dynamic subtest: vebox
[498.857669] Dynamic subtest vebox: SUCCESS (1.980s)
[498.859258] Subtest legacy-engines-mixed-process: SUCCESS (10.008s)
[499.034587] [106/133] (538s left) kms_flip (plain-flip-ts-check)
[500.523157] Starting subtest: plain-flip-ts-check
[500.534838] Starting dynamic subtest: A-HDMI-A4
[508.562946] Dynamic subtest A-HDMI-A4: SUCCESS (8.031s)
[508.586187] Starting dynamic subtest: B-HDMI-A4
[516.523111] Dynamic subtest B-HDMI-A4: SUCCESS (7.952s)
[516.537531] Starting dynamic subtest: C-HDMI-A4
[524.484969] Dynamic subtest C-HDMI-A4: SUCCESS (7.960s)
[524.499118] Starting dynamic subtest: D-HDMI-A4
[532.446634] Dynamic subtest D-HDMI-A4: SUCCESS (7.959s)
[532.452408] Subtest plain-flip-ts-check: SUCCESS (31.927s)
[532.650993] [107/133] (505s left) kms_invalid_mode (bad-vsync-start)
[534.140838] Starting subtest: bad-vsync-start
[534.142585] Starting dynamic subtest: pipe-A-HDMI-A-4
[534.189982] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.049s)
[534.205032] Starting dynamic subtest: pipe-B-HDMI-A-4
[534.207058] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[534.220696] Starting dynamic subtest: pipe-C-HDMI-A-4
[534.222428] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[534.234362] Starting dynamic subtest: pipe-D-HDMI-A-4
[534.236100] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[534.237845] Subtest bad-vsync-start: SUCCESS (0.062s)
[534.376053] [108/133] (503s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[535.863571] Starting subtest: basic-flip-before-cursor-varying-size
[536.855051] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.992s)
[537.034978] [109/133] (500s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[538.523078] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[553.687865] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (15.168s)
[553.863206] [110/133] (484s left) gem_softpin (overlap)
[553.923551] Starting subtest: overlap
[557.614157] Subtest overlap: SUCCESS (3.690s)
[557.797851] [111/133] (480s left) kms_psr (psr2-sprite-mmap-gtt)
[559.283235] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[559.361066] [112/133] (478s left) kms_frontbuffer_tracking (psr-suspend)
[560.851049] Starting subtest: psr-suspend
[560.853724] Subtest psr-suspend: SKIP (0.000s)
[561.009197] [113/133] (477s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[562.502096] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[562.578044] [114/133] (475s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[564.083928] Starting subtest: y-tiled-16bpp-rotate-270
[565.832092] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.744s)
[566.050626] [115/133] (472s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[566.098989] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[566.199223] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[566.391040] [116/133] (472s left) kms_flip (modeset-vs-vblank-race)
[567.879355] Starting subtest: modeset-vs-vblank-race
[567.885354] Starting dynamic subtest: A-HDMI-A4
[570.979567] Dynamic subtest A-HDMI-A4: SUCCESS (3.094s)
[570.994444] Starting dynamic subtest: B-HDMI-A4
[574.001589] Dynamic subtest B-HDMI-A4: SUCCESS (3.020s)
[574.015514] Starting dynamic subtest: C-HDMI-A4
[576.983085] Dynamic subtest C-HDMI-A4: SUCCESS (2.980s)
[576.995169] Starting dynamic subtest: D-HDMI-A4
[579.998418] Dynamic subtest D-HDMI-A4: SUCCESS (3.014s)
[580.000033] Subtest modeset-vs-vblank-race: SUCCESS (12.123s)
[580.224017] [117/133] (458s left) gem_exec_schedule (smoketest-all)
[580.346282] Starting subtest: smoketest-all
[612.647547] Subtest smoketest-all: SUCCESS (32.289s)
[613.110018] [118/133] (425s left) gem_mmap_gtt (basic-small-copy-odd)
[613.160911] Subtest basic-small-copy-odd: SKIP (0.000s)
[613.267920] [119/133] (425s left) gen9_exec_parse (bb-start-cmd)
[613.322333] Subtest bb-start-cmd: SKIP (0.000s)
[613.401252] [120/133] (425s left) gem_mmap_gtt (basic)
[613.451229] Subtest basic: SKIP (0.000s)
[613.537682] [121/133] (425s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[613.586665] Starting subtest: etime-single-wait-available-unsubmitted
[613.691253] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.100s)
[613.909622] [122/133] (425s left) gem_exec_alignment (forked)
[613.963945] Starting subtest: forked
[649.954191] Subtest forked: SUCCESS (35.988s)
[650.085668] [123/133] (389s left) kms_getfb (getfb2-handle-zero)
[651.639450] Starting subtest: getfb2-handle-zero
[651.641102] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[651.827573] [124/133] (387s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[653.313134] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[653.324502] Starting dynamic subtest: pipe-A
[653.419649] Dynamic subtest pipe-A: SUCCESS (0.106s)
[653.432026] Starting dynamic subtest: pipe-B
[653.559783] Dynamic subtest pipe-B: SUCCESS (0.139s)
[653.572563] Starting dynamic subtest: pipe-C
[653.701601] Dynamic subtest pipe-C: SUCCESS (0.138s)
[653.713725] Starting dynamic subtest: pipe-D
[653.838816] Dynamic subtest pipe-D: SUCCESS (0.138s)
[653.840607] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.527s)
[654.029629] [125/133] (385s left) kms_content_protection (uevent)
[655.583304] Starting subtest: uevent
[655.597426] Subtest uevent: SKIP (0.005s)
[655.780140] [126/133] (383s left) kms_plane_multiple (2x-tiling-x)
[657.274525] Starting subtest: 2x-tiling-x
[657.277937] Subtest 2x-tiling-x: SKIP (0.000s)
[657.423833] [127/133] (382s left) gem_exec_schedule (preempt-contexts)
[657.517828] Starting subtest: preempt-contexts
[657.519264] Starting dynamic subtest: rcs0
[657.606565] Dynamic subtest rcs0: SUCCESS (0.088s)
[657.620646] Starting dynamic subtest: bcs0
[657.675342] Dynamic subtest bcs0: SUCCESS (0.067s)
[657.689606] Starting dynamic subtest: vcs0
[657.743961] Dynamic subtest vcs0: SUCCESS (0.067s)
[657.756288] Starting dynamic subtest: vcs1
[657.813199] Dynamic subtest vcs1: SUCCESS (0.068s)
[657.827850] Starting dynamic subtest: vecs0
[657.881746] Dynamic subtest vecs0: SUCCESS (0.067s)
[657.883606] Subtest preempt-contexts: SUCCESS (0.364s)
[658.317604] [128/133] (381s left) perf_pmu (most-busy-check-all)
[658.368496] Starting subtest: most-busy-check-all
[658.370241] Starting dynamic subtest: rcs0
[658.947176] Dynamic subtest rcs0: SUCCESS (0.578s)
[658.974220] Starting dynamic subtest: bcs0
[659.498935] Dynamic subtest bcs0: SUCCESS (0.548s)
[659.516641] Starting dynamic subtest: vcs0
[660.050836] Dynamic subtest vcs0: SUCCESS (0.546s)
[660.068717] Starting dynamic subtest: vcs1
[660.603949] Dynamic subtest vcs1: SUCCESS (0.547s)
[660.621826] Starting dynamic subtest: vecs0
[661.156891] Dynamic subtest vecs0: SUCCESS (0.547s)
[661.163029] Subtest most-busy-check-all: SUCCESS (2.792s)
[661.288989] [129/133] (378s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[662.777111] Starting subtest: multiplane-rotation-cropping-top
[710.445555] Subtest multiplane-rotation-cropping-top: SUCCESS (47.671s)
[710.608274] [130/133] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[712.108275] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[712.111446] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[712.363711] [131/133] (327s left) syncobj_wait (signal)
[712.427111] Starting subtest: signal
[712.433643] Subtest signal: SUCCESS (0.000s)
[712.576789] [132/133] (327s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[714.115179] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[714.118711] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[714.241589] [133/133] (325s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[715.743770] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[715.746947] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[715.921927] Closing watchdogs
results: parsing output: 0/ for test: sw_sync
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_atomic_transition
results: parsing output: 8/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_mmap_wc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_fbcon_fbt
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_workarounds
results: parsing output: 43/ for test: kms_chamelium_edid
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_universal_plane
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_color
results: parsing output: 52/ for test: gem_exec_capture
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: prime_busy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: sysfs_preempt_timeout
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: dmabuf_sync_file
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_pread
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vrr
results: parsing output: 71/ for test: kms_setmode
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: i915_query
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: prime_mmap
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_basic
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_pipe_crc_basic
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_pm_backlight
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_alignment
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.