[70.610909] Initializing watchdogs
[70.610977]   /dev/watchdog0
[70.631227] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[70.642617] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[70.646593] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.648884] [001/133] (960s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[71.313180] Starting subtest: syncobj-stationary-timeline-chain-engines
[71.482171] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.169s)
[71.842389] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[71.844096] [002/133] (959s left) gem_ctx_bad_destroy (invalid-default-ctx)
[71.924394] Starting subtest: invalid-default-ctx
[71.925334] Subtest invalid-default-ctx: SUCCESS (0.000s)
[72.047700] [003/133] (959s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[73.572050] Starting subtest: cursorB-vs-flipA-varying-size
[73.575029] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[73.682374] [004/133] (957s left) kms_psr (psr2-cursor-mmap-cpu)
[75.220455] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[75.281818] [005/133] (956s left) syncobj_timeline (invalid-signal-illegal-handle)
[75.366530] Starting subtest: invalid-signal-illegal-handle
[75.367485] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[75.507190] [006/133] (955s left) gem_ctx_param (invalid-set-no-zeromap)
[75.589378] Starting subtest: invalid-set-no-zeromap
[75.590332] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[75.732676] [007/133] (955s left) kms_hdr (bpc-switch-dpms)
[77.242976] Starting subtest: bpc-switch-dpms
[77.245716] Subtest bpc-switch-dpms: SKIP (0.000s)
[77.400074] [008/133] (954s left) kms_flip (dpms-vs-vblank-race)
[78.948096] Starting subtest: dpms-vs-vblank-race
[78.953168] Starting dynamic subtest: A-HDMI-A3
[82.106554] Dynamic subtest A-HDMI-A3: SUCCESS (3.147s)
[82.116179] Starting dynamic subtest: B-HDMI-A3
[85.113058] Dynamic subtest B-HDMI-A3: SUCCESS (3.011s)
[85.121943] Starting dynamic subtest: C-HDMI-A3
[88.102682] Dynamic subtest C-HDMI-A3: SUCCESS (2.990s)
[88.113178] Starting dynamic subtest: D-HDMI-A3
[91.119141] Dynamic subtest D-HDMI-A3: SUCCESS (3.015s)
[91.120151] Subtest dpms-vs-vblank-race: SUCCESS (12.171s)
[91.329658] [009/133] (940s left) tools_test (tools_test)
[91.388338] Starting subtest: tools_test
[91.461479] Subtest tools_test: SUCCESS (0.079s)
[91.546594] [010/133] (940s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[93.061585] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[93.063231] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[93.198478] [011/133] (938s left) gem_exec_params (batch-first)
[93.313790] Starting subtest: batch-first
[93.346997] Subtest batch-first: SUCCESS (0.033s)
[93.509227] [012/133] (938s left) gem_userptr_blits (create-destroy-sync)
[93.605863] Starting subtest: create-destroy-sync
[98.621689] Subtest create-destroy-sync: SUCCESS (5.015s)
[98.801330] [013/133] (933s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[100.313935] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[100.314951] Starting dynamic subtest: pipe-A-HDMI-A-3
[100.323841] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[100.331895] Starting dynamic subtest: pipe-B-HDMI-A-3
[100.340700] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[100.348560] Starting dynamic subtest: pipe-C-HDMI-A-3
[100.357012] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[100.364594] Starting dynamic subtest: pipe-D-HDMI-A-3
[100.374940] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[100.376741] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[100.578638] [014/133] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[102.096356] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[102.098259] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[102.225119] [015/133] (929s left) perf_pmu (busy-idle-no-semaphores)
[102.323039] Starting subtest: busy-idle-no-semaphores
[102.324109] Starting dynamic subtest: rcs0
[103.010597] Dynamic subtest rcs0: SUCCESS (0.686s)
[103.025800] Starting dynamic subtest: bcs0
[103.669625] Dynamic subtest bcs0: SUCCESS (0.656s)
[103.685976] Starting dynamic subtest: vcs0
[104.325113] Dynamic subtest vcs0: SUCCESS (0.652s)
[104.341015] Starting dynamic subtest: vcs1
[104.980588] Dynamic subtest vcs1: SUCCESS (0.652s)
[104.996908] Starting dynamic subtest: vecs0
[105.636725] Dynamic subtest vecs0: SUCCESS (0.653s)
[105.652910] Starting dynamic subtest: vecs1
[106.292036] Dynamic subtest vecs1: SUCCESS (0.652s)
[106.308581] Starting dynamic subtest: ccs0
[106.946027] Dynamic subtest ccs0: SUCCESS (0.651s)
[106.947860] Subtest busy-idle-no-semaphores: SUCCESS (4.624s)
[107.127904] [016/133] (925s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[108.639425] Starting subtest: bad-aux-stride-y-tiled-ccs
[108.640297] Starting dynamic subtest: pipe-A-HDMI-A-3
[108.648678] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[108.657386] Starting dynamic subtest: pipe-B-HDMI-A-3
[108.666101] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[108.674702] Starting dynamic subtest: pipe-C-HDMI-A-3
[108.683129] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[108.691425] Starting dynamic subtest: pipe-D-HDMI-A-3
[108.700606] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[108.702563] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[108.911554] [017/133] (923s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[110.424174] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[110.490298] [018/133] (921s left) gem_exec_balancer (bonded-semaphore)
[110.587189] Starting subtest: bonded-semaphore
[110.589360] Subtest bonded-semaphore: SKIP (0.000s)
[111.005950] [019/133] (921s left) sw_sync (alloc_timeline)
[111.055209] Starting subtest: alloc_timeline
[111.056146] Subtest alloc_timeline: SUCCESS (0.000s)
[111.136830] [020/133] (921s left) gen7_exec_parse (oacontrol-tracking)
[111.228162] Subtest oacontrol-tracking: SKIP (0.000s)
[111.300033] [021/133] (921s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[112.811877] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[112.812741] Starting dynamic subtest: pipe-A-HDMI-A-3
[112.820836] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[112.829422] Starting dynamic subtest: pipe-B-HDMI-A-3
[112.838430] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[112.847128] Starting dynamic subtest: pipe-C-HDMI-A-3
[112.855762] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[112.864190] Starting dynamic subtest: pipe-D-HDMI-A-3
[112.874195] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[112.875954] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[113.047846] [022/133] (919s left) kms_lease (lease-invalid-plane)
[114.560994] Starting subtest: lease-invalid-plane
[114.561983] Starting dynamic subtest: pipe-A-HDMI-A-3
[114.562937] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.000s)
[114.571931] Starting dynamic subtest: pipe-B-HDMI-A-3
[114.573143] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.000s)
[114.581810] Starting dynamic subtest: pipe-C-HDMI-A-3
[114.583054] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.000s)
[114.591658] Starting dynamic subtest: pipe-D-HDMI-A-3
[114.592804] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.000s)
[114.594056] Subtest lease-invalid-plane: SUCCESS (0.006s)
[114.716512] [023/133] (917s left) gem_lmem_swapping (verify-ccs)
[119.149338] Starting subtest: verify-ccs
[119.153102] Starting dynamic subtest: lmem0
[158.898054] Dynamic subtest lmem0: SUCCESS (39.748s)
[158.899058] Subtest verify-ccs: SUCCESS (39.749s)
[160.559642] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[160.560602] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[160.562518] [024/133] (872s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[165.473176] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[165.474969] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[165.688894] [FACT kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[165.693120] [FACT kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)] new: kernel.kmod_is_loaded.i915: true
[165.697262] [025/133] (867s left) kms_psr (fbc-psr2-sprite-plane-move)
[167.216388] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[167.280785] [026/133] (865s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[168.811392] Starting subtest: primary-yf-tiled-reflect-x-0
[168.922112] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.110s)
[169.098726] [027/133] (863s left) kms_dp_link_training (non-uhbr-sst)
[170.611920] Starting subtest: non-uhbr-sst
[170.615267] Subtest non-uhbr-sst: SKIP (0.000s)
[170.705176] [028/133] (862s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[170.811019] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[170.813137] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[171.069187] [029/133] (861s left) kms_chamelium_audio (dp-audio-edid)
[172.629056] Subtest dp-audio-edid: SKIP (0.000s)
[172.727841] [030/133] (860s left) gem_pread (self)
[172.812032] Subtest self: SKIP (0.000s)
[172.898338] [031/133] (860s left) syncobj_timeline (single-wait-available-submitted)
[172.981626] Starting subtest: single-wait-available-submitted
[172.982549] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[173.139465] [032/133] (860s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[174.671341] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[174.673167] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[174.887326] [033/133] (858s left) gem_ctx_persistence (many-contexts)
[174.984052] Starting subtest: many-contexts
[212.666549] Subtest many-contexts: SUCCESS (37.682s)
[212.779052] [034/133] (820s left) syncobj_wait (invalid-signal-illegal-handle)
[212.862285] Starting subtest: invalid-signal-illegal-handle
[212.863211] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[213.050123] [035/133] (820s left) gem_exec_params (no-blt)
[213.134536] Starting subtest: no-blt
[213.136695] Subtest no-blt: SUCCESS (0.001s)
[213.262877] [036/133] (820s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[214.778985] Starting subtest: fbc-2p-pri-indfb-multidraw
[214.780779] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[215.006041] [037/133] (818s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[216.522256] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[216.572862] [038/133] (817s left) gem_exec_reloc (basic-write-wc-active)
[216.660689] Subtest basic-write-wc-active: SKIP (0.000s)
[216.748712] [039/133] (817s left) syncobj_timeline (etime-multi-wait-all-submitted)
[216.830373] Starting subtest: etime-multi-wait-all-submitted
[216.934560] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[217.076803] [040/133] (816s left) gem_exec_store (cachelines)
[217.170301] Starting subtest: cachelines
[217.171278] Starting dynamic subtest: rcs0
[217.258195] Dynamic subtest rcs0: SUCCESS (0.087s)
[217.267995] Starting dynamic subtest: bcs0
[217.314714] Dynamic subtest bcs0: SUCCESS (0.055s)
[217.328271] Starting dynamic subtest: vcs0
[217.367910] Dynamic subtest vcs0: SUCCESS (0.051s)
[217.384967] Starting dynamic subtest: vcs1
[217.425767] Dynamic subtest vcs1: SUCCESS (0.056s)
[217.464464] Starting dynamic subtest: vecs0
[217.499889] Dynamic subtest vecs0: SUCCESS (0.071s)
[217.519032] Starting dynamic subtest: vecs1
[217.556914] Dynamic subtest vecs1: SUCCESS (0.055s)
[217.598224] Starting dynamic subtest: ccs0
[217.633917] Dynamic subtest ccs0: SUCCESS (0.074s)
[217.635286] Subtest cachelines: SUCCESS (0.464s)
[217.932223] [041/133] (816s left) kms_fbcon_fbt (fbc-suspend)
[218.010246] Starting subtest: fbc-suspend
[270.338883] Subtest fbc-suspend: SUCCESS (21.072s)
[275.434222] [042/133] (763s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[276.996148] Starting subtest: flip-vs-cursor-crc-legacy
[277.588517] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.575s)
[277.864297] [043/133] (761s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[279.416714] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[279.418460] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[279.544203] [044/133] (759s left) kms_cursor_crc (cursor-random-256x85)
[281.371032] Starting subtest: cursor-random-256x85
[281.376187] Starting dynamic subtest: pipe-A-HDMI-A-3
[285.994333] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.559s)
[286.027464] Starting dynamic subtest: pipe-D-HDMI-A-3
[290.384864] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.335s)
[290.385811] Subtest cursor-random-256x85: SUCCESS (8.922s)
[290.651902] [045/133] (748s left) sw_sync (sync_multi_consumer_producer)
[290.702000] Starting subtest: sync_multi_consumer_producer
[290.944588] Subtest sync_multi_consumer_producer: SUCCESS (0.241s)
[291.022962] [046/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[292.544497] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[292.546233] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[292.689163] [047/133] (746s left) syncobj_wait (wait-any-complex)
[292.794933] Starting subtest: wait-any-complex
[292.858053] Subtest wait-any-complex: SUCCESS (0.062s)
[292.997679] [048/133] (746s left) gem_render_copy_redux (normal)
[293.087820] Starting subtest: normal
[293.814718] Subtest normal: SUCCESS (0.725s)
[293.971889] [049/133] (745s left) gen7_exec_parse (basic-allocation)
[294.057586] Subtest basic-allocation: SKIP (0.000s)
[294.131944] [050/133] (745s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[295.660107] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[295.661728] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[295.800253] [051/133] (743s left) kms_addfb_basic (legacy-format)
[295.906196] Starting subtest: legacy-format
[295.938748] Subtest legacy-format: SUCCESS (0.032s)
[297.479519] [052/133] (742s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[299.002274] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[299.003870] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[299.150171] [053/133] (740s left) kms_selftest (drm_dp_mst_helper)
[299.226994] Starting subtest: drm_dp_mst_helper
[299.261577] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[299.335306] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.074s)
[299.369503] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[299.446490] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.108s)
[299.481684] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[299.532862] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.083s)
[299.535795] Subtest drm_dp_mst_helper: SUCCESS (0.306s)
[299.748095] [054/133] (740s left) kms_invalid_mode (zero-clock)
[301.264492] Starting subtest: zero-clock
[301.265498] Starting dynamic subtest: pipe-A-HDMI-A-3
[301.311602] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.047s)
[301.324318] Starting dynamic subtest: pipe-B-HDMI-A-3
[301.325496] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[301.336303] Starting dynamic subtest: pipe-C-HDMI-A-3
[301.337140] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[301.347948] Starting dynamic subtest: pipe-D-HDMI-A-3
[301.348850] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[301.349766] Subtest zero-clock: SUCCESS (0.056s)
[301.541516] [055/133] (738s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[303.066438] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[303.832452] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.764s)
[304.102404] [056/133] (736s left) kms_flip (dpms-off-confusion)
[305.621366] Starting subtest: dpms-off-confusion
[305.625979] Starting dynamic subtest: A-HDMI-A3
[313.372216] Dynamic subtest A-HDMI-A3: SUCCESS (7.742s)
[313.412675] Starting dynamic subtest: B-HDMI-A3
[321.089997] Dynamic subtest B-HDMI-A3: SUCCESS (7.712s)
[321.102681] Starting dynamic subtest: C-HDMI-A3
[328.776239] Dynamic subtest C-HDMI-A3: SUCCESS (7.683s)
[328.788911] Starting dynamic subtest: D-HDMI-A3
[336.462350] Dynamic subtest D-HDMI-A3: SUCCESS (7.682s)
[336.463251] Subtest dpms-off-confusion: SUCCESS (30.833s)
[336.718653] [057/133] (703s left) kms_flip (flip-vs-fences-interruptible)
[338.234746] Starting subtest: flip-vs-fences-interruptible
[338.236558] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[338.400625] [058/133] (701s left) kms_cursor_edge_walk (128x128-top-edge)
[339.940717] Starting subtest: 128x128-top-edge
[339.941692] Starting dynamic subtest: pipe-A-HDMI-A-3
[343.282326] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.340s)
[343.294565] Starting dynamic subtest: pipe-D-HDMI-A-3
[346.517703] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.232s)
[346.518634] Subtest 128x128-top-edge: SUCCESS (6.576s)
[346.708751] [059/133] (693s left) gem_exec_capture (capture-invisible)
[346.802871] Starting subtest: capture-invisible
[346.803803] Starting dynamic subtest: lmem0
[346.805731] Dynamic subtest lmem0: SKIP (0.000s)
[346.816904] Starting dynamic subtest: smem0
[346.818987] Dynamic subtest smem0: SKIP (0.000s)
[346.821090] Subtest capture-invisible: SKIP (0.002s)
[346.941882] [060/133] (693s left) kms_pipe_crc_basic (read-crc)
[348.453686] Starting subtest: read-crc
[348.454670] Starting dynamic subtest: pipe-A-HDMI-A-3
[349.142518] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.687s)
[349.159172] Starting dynamic subtest: pipe-B-HDMI-A-3
[349.657743] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.513s)
[349.670299] Starting dynamic subtest: pipe-C-HDMI-A-3
[350.138556] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.479s)
[350.151178] Starting dynamic subtest: pipe-D-HDMI-A-3
[350.610491] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.468s)
[350.611462] Subtest read-crc: SUCCESS (2.156s)
[350.783416] [061/133] (689s left) kms_chamelium_edid (hdmi-edid-read)
[352.347013] Subtest hdmi-edid-read: SKIP (0.000s)
[352.449692] [062/133] (688s left) kms_content_protection (lic-type-0)
[354.036042] Starting subtest: lic-type-0
[354.044677] Subtest lic-type-0: SKIP (0.006s)
[354.222305] [063/133] (686s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[355.735428] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[355.737161] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[355.836162] [064/133] (684s left) kms_psr (fbc-psr2-no-drrs)
[357.363197] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[357.427659] [065/133] (683s left) api_intel_allocator (default-alignment)
[357.506986] Starting subtest: default-alignment
[357.513675] Subtest default-alignment: SUCCESS (0.007s)
[357.732900] [066/133] (683s left) kms_pm_dc (dc5-psr)
[360.254876] Starting subtest: dc5-psr
[360.256688] Subtest dc5-psr: SKIP (0.000s)
[360.408397] [067/133] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[361.955692] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[361.957466] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[362.089586] [068/133] (678s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[363.631895] Starting subtest: flip-vs-dpms-on-nop-interruptible
[363.638063] Starting dynamic subtest: A-HDMI-A3
[364.652061] Dynamic subtest A-HDMI-A3: SUCCESS (1.013s)
[364.665749] Starting dynamic subtest: B-HDMI-A3
[365.602948] Dynamic subtest B-HDMI-A3: SUCCESS (0.949s)
[365.615960] Starting dynamic subtest: C-HDMI-A3
[366.552681] Dynamic subtest C-HDMI-A3: SUCCESS (0.948s)
[366.565177] Starting dynamic subtest: D-HDMI-A3
[367.504665] Dynamic subtest D-HDMI-A3: SUCCESS (0.949s)
[367.510342] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (3.873s)
[367.699790] [069/133] (673s left) kms_prop_blob (blob-prop-core)
[367.784965] Starting subtest: blob-prop-core
[367.785975] Subtest blob-prop-core: SUCCESS (0.000s)
[367.897693] [070/133] (673s left) kms_chamelium_hpd (hdmi-hpd-fast)
[369.453823] Subtest hdmi-hpd-fast: SKIP (0.000s)
[369.556226] [071/133] (671s left) i915_query (query-topology-kernel-writes)
[369.644020] Starting subtest: query-topology-kernel-writes
[369.644933] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[369.837830] [072/133] (671s left) vgem_basic (dmabuf-fence-before)
[369.904296] Starting subtest: dmabuf-fence-before
[369.905172] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[370.008869] [073/133] (671s left) kms_plane_multiple (tiling-y)
[371.518156] Starting subtest: tiling-y
[371.519942] Subtest tiling-y: SKIP (0.000s)
[371.607933] [074/133] (669s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[371.701898] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[371.702830] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[371.862488] [075/133] (669s left) gem_exec_reloc (basic-write-cpu)
[371.949153] Subtest basic-write-cpu: SKIP (0.000s)
[372.016940] [076/133] (669s left) kms_cursor_crc (cursor-alpha-transparent)
[373.535692] Starting subtest: cursor-alpha-transparent
[373.536737] Starting dynamic subtest: pipe-A-HDMI-A-3
[374.127787] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.592s)
[374.141337] Starting dynamic subtest: pipe-D-HDMI-A-3
[374.551321] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.421s)
[374.552311] Subtest cursor-alpha-transparent: SUCCESS (1.017s)
[375.081051] [077/133] (666s left) gem_eio (throttle)
[375.383906] Starting subtest: throttle
[375.867767] Subtest throttle: SUCCESS (0.484s)
[377.411161] [078/133] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[378.947622] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[378.949425] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[379.107973] [079/133] (662s left) kms_fb_coherency (memset-crc)
[380.648740] Starting subtest: memset-crc
[380.649637] Starting dynamic subtest: mmap-offset-fixed
[381.183642] Dynamic subtest mmap-offset-fixed: SUCCESS (0.534s)
[381.239930] Subtest memset-crc: SUCCESS (0.591s)
[381.440087] [080/133] (660s left) kms_psr (psr-primary-mmap-gtt)
[382.955060] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[383.013005] [081/133] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[384.531636] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[384.533457] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[384.693606] [082/133] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[386.236397] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[386.238184] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[386.373403] [083/133] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[387.920062] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[387.922117] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[388.066938] [084/133] (654s left) gem_exec_schedule (submit-late-slice)
[388.190047] Starting subtest: submit-late-slice
[388.190997] Starting dynamic subtest: rcs0
[388.267896] Dynamic subtest rcs0: SUCCESS (0.077s)
[388.281003] Starting dynamic subtest: bcs0
[388.318782] Dynamic subtest bcs0: SUCCESS (0.050s)
[388.331984] Starting dynamic subtest: vcs0
[388.366490] Dynamic subtest vcs0: SUCCESS (0.047s)
[388.379800] Starting dynamic subtest: vcs1
[388.415967] Dynamic subtest vcs1: SUCCESS (0.048s)
[388.429274] Starting dynamic subtest: vecs0
[388.464916] Dynamic subtest vecs0: SUCCESS (0.048s)
[388.478254] Starting dynamic subtest: vecs1
[388.513996] Dynamic subtest vecs1: SUCCESS (0.048s)
[388.527310] Starting dynamic subtest: ccs0
[388.563434] Dynamic subtest ccs0: SUCCESS (0.048s)
[388.564656] Subtest submit-late-slice: SUCCESS (0.374s)
[389.024018] [085/133] (653s left) kms_big_fb (linear-16bpp-rotate-270)
[390.550500] Starting subtest: linear-16bpp-rotate-270
[390.617979] Subtest linear-16bpp-rotate-270: SKIP (0.066s)
[390.816086] [086/133] (651s left) gem_exercise_blt (fast-copy-emit)
[390.905033] Starting subtest: fast-copy-emit
[390.905990] Starting dynamic subtest: linear-smem-smem-emit
[390.952892] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.047s)
[390.965950] Starting dynamic subtest: linear-smem-lmem0-emit
[390.968474] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[390.981283] Starting dynamic subtest: linear-lmem0-smem-emit
[391.078901] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.109s)
[391.092079] Starting dynamic subtest: linear-lmem0-lmem0-emit
[391.188162] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.108s)
[391.201092] Starting dynamic subtest: xmajor-smem-smem-emit
[391.203699] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.014s)
[391.217420] Starting dynamic subtest: xmajor-smem-lmem0-emit
[391.218327] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.013s)
[391.231660] Starting dynamic subtest: xmajor-lmem0-smem-emit
[391.329109] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.110s)
[391.342456] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[391.439637] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.109s)
[391.452810] Starting dynamic subtest: tile4-smem-smem-emit
[391.455632] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[391.469473] Starting dynamic subtest: tile4-smem-lmem0-emit
[391.470432] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.013s)
[391.482032] Starting dynamic subtest: tile4-lmem0-smem-emit
[391.581046] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.110s)
[391.594496] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[391.691886] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.110s)
[391.704999] Starting dynamic subtest: tile64-smem-smem-emit
[391.708555] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[391.721715] Starting dynamic subtest: tile64-smem-lmem0-emit
[391.723279] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[391.736476] Starting dynamic subtest: tile64-lmem0-smem-emit
[391.834193] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.110s)
[391.847728] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[391.944113] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.109s)
[391.945004] Subtest fast-copy-emit: SUCCESS (1.040s)
[392.129181] [087/133] (650s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[392.216042] Subtest writes-after-reads-snoop: SKIP (0.000s)
[392.297399] [088/133] (650s left) gem_exec_schedule (noreorder-priority)
[392.515104] Starting subtest: noreorder-priority
[392.516335] Starting dynamic subtest: rcs0
[393.692964] Dynamic subtest rcs0: SUCCESS (1.179s)
[393.706667] Starting dynamic subtest: bcs0
[394.822983] Dynamic subtest bcs0: SUCCESS (1.129s)
[394.835966] Starting dynamic subtest: vcs0
[395.950952] Dynamic subtest vcs0: SUCCESS (1.127s)
[395.964163] Starting dynamic subtest: vcs1
[397.083837] Dynamic subtest vcs1: SUCCESS (1.132s)
[397.097798] Starting dynamic subtest: vecs0
[398.205788] Dynamic subtest vecs0: SUCCESS (1.121s)
[398.218877] Starting dynamic subtest: vecs1
[399.329897] Dynamic subtest vecs1: SUCCESS (1.123s)
[399.343095] Starting dynamic subtest: ccs0
[400.452925] Dynamic subtest ccs0: SUCCESS (1.122s)
[400.453919] Subtest noreorder-priority: SUCCESS (7.941s)
[400.697804] [089/133] (641s left) gem_mmap_offset (oob-read)
[400.782018] Starting subtest: oob-read
[400.782941] Subtest oob-read: SUCCESS (0.000s)
[400.964473] [090/133] (641s left) gem_softpin (allocator-fork)
[401.052792] Starting subtest: allocator-fork
[403.358978] Subtest allocator-fork: SUCCESS (2.306s)
[403.548368] [091/133] (639s left) gem_ccs (block-multicopy-inplace)
[403.634886] Starting subtest: block-multicopy-inplace
[403.635859] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[403.680898] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.046s)
[403.694085] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[403.791258] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.109s)
[403.804720] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[403.806670] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[403.819941] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[403.916624] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.109s)
[403.930028] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[403.931737] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[403.945060] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[404.041323] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.108s)
[404.054759] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[404.056558] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[404.069900] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[404.167115] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.109s)
[404.167996] Subtest block-multicopy-inplace: SUCCESS (0.534s)
[404.348228] [092/133] (638s left) gem_exec_fence (syncobj-unused-fence)
[404.923673] Starting subtest: syncobj-unused-fence
[404.953845] Subtest syncobj-unused-fence: SUCCESS (0.030s)
[405.432728] [093/133] (637s left) gem_ctx_shared (q-smoketest-all)
[405.528296] Starting subtest: Q-smoketest-all
[437.843077] Subtest Q-smoketest-all: SUCCESS (32.304s)
[438.164551] [094/133] (604s left) gem_ctx_param (get-priority-new-ctx)
[438.246313] Starting subtest: get-priority-new-ctx
[438.248632] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[438.377631] [095/133] (604s left) kms_atomic_transition (modeset-transition-fencing)
[439.891776] Starting subtest: modeset-transition-fencing
[439.892692] Starting dynamic subtest: 1x-outputs
[441.780461] Dynamic subtest 1x-outputs: SUCCESS (1.887s)
[441.784983] Subtest modeset-transition-fencing: SUCCESS (1.890s)
[441.962079] [096/133] (601s left) kms_pm_rpm (i2c)
[446.316006] Starting subtest: i2c
[450.016083] Subtest i2c: SUCCESS (3.699s)
[450.881349] [097/133] (592s left) vgem_basic (bad-fence)
[450.957897] Starting subtest: bad-fence
[450.958895] Subtest bad-fence: SUCCESS (0.000s)
[451.115765] [098/133] (592s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[452.627729] Starting subtest: plane-upscale-20x20-with-modifiers
[452.628662] Starting dynamic subtest: pipe-A
[453.190972] Dynamic subtest pipe-A: SUCCESS (0.564s)
[453.215439] Starting dynamic subtest: pipe-B
[453.765666] Dynamic subtest pipe-B: SUCCESS (0.573s)
[453.783858] Starting dynamic subtest: pipe-C
[454.324011] Dynamic subtest pipe-C: SUCCESS (0.556s)
[454.350689] Starting dynamic subtest: pipe-D
[454.898553] Dynamic subtest pipe-D: SUCCESS (0.573s)
[454.899566] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.272s)
[455.102953] [099/133] (588s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[456.622566] Starting subtest: fbc-rgb565-draw-mmap-gtt
[456.624343] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[456.858822] [100/133] (586s left) syncobj_wait (wait-all-for-submit-complex)
[456.936983] Starting subtest: wait-all-for-submit-complex
[457.160802] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[457.342518] [101/133] (586s left) gem_mmap (basic)
[457.419781] Subtest basic: SKIP (0.000s)
[457.486586] [102/133] (586s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[459.005424] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[459.007022] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[459.228773] [103/133] (584s left) gem_eio (in-flight-10ms)
[459.556553] Starting subtest: in-flight-10ms
[464.834091] Subtest in-flight-10ms: SUCCESS (5.277s)
[466.427892] [104/133] (577s left) i915_hangman (engine-engine-hang)
[466.560666] Starting subtest: engine-engine-hang
[466.561645] Starting dynamic subtest: rcs0
[467.349004] Dynamic subtest rcs0: SUCCESS (0.788s)
[467.364164] Starting dynamic subtest: bcs0
[468.063839] Dynamic subtest bcs0: SUCCESS (0.713s)
[468.077357] Starting dynamic subtest: vcs0
[468.808896] Dynamic subtest vcs0: SUCCESS (0.744s)
[468.822786] Starting dynamic subtest: vcs1
[469.529694] Dynamic subtest vcs1: SUCCESS (0.719s)
[469.543822] Starting dynamic subtest: vecs0
[470.239000] Dynamic subtest vecs0: SUCCESS (0.708s)
[470.252801] Starting dynamic subtest: vecs1
[470.951798] Dynamic subtest vecs1: SUCCESS (0.711s)
[470.965533] Starting dynamic subtest: ccs0
[471.700894] Dynamic subtest ccs0: SUCCESS (0.748s)
[471.701826] Subtest engine-engine-hang: SUCCESS (5.140s)
[471.898318] [105/133] (571s left) vgem_basic (setversion)
[471.960845] Starting subtest: setversion
[471.962566] Subtest setversion: SUCCESS (0.000s)
[472.063421] [106/133] (571s left) gem_mmap_wc (write)
[472.142771] Subtest write: SKIP (0.000s)
[472.224838] [107/133] (571s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[473.746531] Starting subtest: y-tiled-64bpp-rotate-0
[473.748294] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[473.976741] [108/133] (570s left) kms_psr (pr-cursor-render)
[475.492973] Subtest pr-cursor-render: SKIP (0.000s)
[475.558502] [109/133] (568s left) core_auth (getclient-master-drop)
[475.609517] Starting subtest: getclient-master-drop
[475.668385] Subtest getclient-master-drop: SUCCESS (0.059s)
[475.871594] [110/133] (568s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[475.953892] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[476.061980] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[476.196398] [111/133] (568s left) gem_ctx_engines (invalid-engines)
[476.284951] Starting subtest: invalid-engines
[476.317990] Subtest invalid-engines: SUCCESS (0.034s)
[476.650856] [112/133] (567s left) i915_query (hwconfig_table)
[476.729995] Starting subtest: hwconfig_table
[476.887263] Subtest hwconfig_table: SUCCESS (0.001s)
[476.959446] [113/133] (567s left) gem_exec_flush (basic-uc-ro-default)
[477.047694] Subtest basic-uc-ro-default: SKIP (0.000s)
[477.149189] [114/133] (567s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[478.676237] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[478.677936] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[478.916335] [115/133] (565s left) gem_pxp (reject-modify-context-protection-off-1)
[481.522572] Starting subtest: reject-modify-context-protection-off-1
[481.524683] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[481.620962] [116/133] (563s left) i915_drm_fdinfo (most-busy-check-all)
[481.692986] Starting subtest: most-busy-check-all
[481.693960] Starting dynamic subtest: rcs0
[481.728040] Dynamic subtest rcs0: SKIP (0.034s)
[481.740723] Starting dynamic subtest: bcs0
[481.743124] Dynamic subtest bcs0: SKIP (0.001s)
[481.755395] Starting dynamic subtest: vcs0
[481.757604] Dynamic subtest vcs0: SKIP (0.000s)
[481.769752] Starting dynamic subtest: vcs1
[481.772102] Dynamic subtest vcs1: SKIP (0.000s)
[481.783971] Starting dynamic subtest: vecs0
[481.786275] Dynamic subtest vecs0: SKIP (0.000s)
[481.798750] Starting dynamic subtest: vecs1
[481.800861] Dynamic subtest vecs1: SKIP (0.001s)
[481.812744] Starting dynamic subtest: ccs0
[481.815146] Dynamic subtest ccs0: SKIP (0.000s)
[481.817387] Subtest most-busy-check-all: SKIP (0.044s)
[481.866184] [117/133] (562s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[483.414695] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[483.416495] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[483.526911] [118/133] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[485.059446] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[485.061096] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[485.253933] [119/133] (559s left) device_reset (cold-reset-bound)
[485.343876] Starting subtest: cold-reset-bound
[485.345923] Subtest cold-reset-bound: SKIP (0.000s)
[485.431446] [120/133] (559s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[486.953995] Starting subtest: 4-tiled-16bpp-rotate-90
[487.016200] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.061s)
[487.205411] [121/133] (557s left) gem_partial_pwrite_pread (write-display)
[487.290804] Subtest write-display: SKIP (0.000s)
[487.362225] [122/133] (557s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[488.878728] Starting subtest: plane-lut1d-pre-ctm3x4
[489.101571] Starting dynamic subtest: pipe-A-plane-0
[489.350008] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[489.392416] Starting dynamic subtest: pipe-A-plane-1
[489.551633] Dynamic subtest pipe-A-plane-1: SUCCESS (0.196s)
[489.594838] Starting dynamic subtest: pipe-A-plane-2
[489.748897] Dynamic subtest pipe-A-plane-2: SUCCESS (0.195s)
[490.002917] Starting dynamic subtest: pipe-B-plane-0
[490.166636] Dynamic subtest pipe-B-plane-0: SUCCESS (0.198s)
[490.210133] Starting dynamic subtest: pipe-B-plane-1
[490.365248] Dynamic subtest pipe-B-plane-1: SUCCESS (0.195s)
[490.379625] Starting dynamic subtest: pipe-B-plane-2
[490.533228] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[490.839870] Starting dynamic subtest: pipe-C-plane-0
[491.000290] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s)
[491.040090] Starting dynamic subtest: pipe-C-plane-1
[491.199345] Dynamic subtest pipe-C-plane-1: SUCCESS (0.195s)
[491.211765] Starting dynamic subtest: pipe-C-plane-2
[491.383945] Dynamic subtest pipe-C-plane-2: SUCCESS (0.183s)
[491.713723] Starting dynamic subtest: pipe-D-plane-0
[491.874631] Dynamic subtest pipe-D-plane-0: SUCCESS (0.197s)
[491.902682] Starting dynamic subtest: pipe-D-plane-1
[492.059294] Dynamic subtest pipe-D-plane-1: SUCCESS (0.181s)
[492.095757] Starting dynamic subtest: pipe-D-plane-2
[492.275828] Dynamic subtest pipe-D-plane-2: SUCCESS (0.212s)
[492.331842] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.452s)
[492.524261] [123/133] (552s left) i915_pm_rpm (gem-pread)
[496.281038] Starting subtest: gem-pread
[497.542479] Subtest gem-pread: SUCCESS (1.259s)
[498.403794] [124/133] (546s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[499.921661] Starting subtest: plane-scaler-unity-scaling-with-rotation
[499.922650] Starting dynamic subtest: pipe-A
[500.286876] Dynamic subtest pipe-A: SUCCESS (0.365s)
[500.303682] Starting dynamic subtest: pipe-B
[500.678885] Dynamic subtest pipe-B: SUCCESS (0.391s)
[500.699328] Starting dynamic subtest: pipe-C
[501.087683] Dynamic subtest pipe-C: SUCCESS (0.407s)
[501.117790] Starting dynamic subtest: pipe-D
[501.496018] Dynamic subtest pipe-D: SUCCESS (0.406s)
[501.497354] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.576s)
[501.713428] [125/133] (543s left) perf_pmu (busy-accuracy-98)
[501.786955] Starting subtest: busy-accuracy-98
[501.787945] Starting dynamic subtest: rcs0
[504.847868] Dynamic subtest rcs0: SUCCESS (3.061s)
[504.860686] Starting dynamic subtest: bcs0
[507.905968] Dynamic subtest bcs0: SUCCESS (3.058s)
[507.918709] Starting dynamic subtest: vcs0
[510.966873] Dynamic subtest vcs0: SUCCESS (3.061s)
[510.979693] Starting dynamic subtest: vcs1
[514.027964] Dynamic subtest vcs1: SUCCESS (3.061s)
[514.040824] Starting dynamic subtest: vecs0
[517.089337] Dynamic subtest vecs0: SUCCESS (3.061s)
[517.102271] Starting dynamic subtest: vecs1
[520.149668] Dynamic subtest vecs1: SUCCESS (3.060s)
[520.162586] Starting dynamic subtest: ccs0
[523.210797] Dynamic subtest ccs0: SUCCESS (3.061s)
[523.211719] Subtest busy-accuracy-98: SUCCESS (21.430s)
[523.385619] [126/133] (522s left) kms_vrr (flip-basic)
[524.899880] Starting subtest: flip-basic
[524.902461] Subtest flip-basic: SKIP (0.000s)
[525.010644] [127/133] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[526.547687] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[526.549433] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[526.695950] [128/133] (518s left) gem_mmap (basic-small-bo)
[526.808666] Subtest basic-small-bo: SKIP (0.000s)
[526.887067] [129/133] (518s left) kms_flip (2x-flip-vs-panning-vs-hang)
[528.400540] Starting subtest: 2x-flip-vs-panning-vs-hang
[528.412876] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.013s)
[528.519505] [130/133] (517s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[530.052012] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[531.396606] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.343s)
[531.587630] [131/133] (514s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[533.104439] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[536.095730] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.992s)
[536.279407] [132/133] (509s left) perf_pmu (semaphore-busy)
[536.351538] Starting subtest: semaphore-busy
[536.352509] Starting dynamic subtest: rcs0
[538.031958] Dynamic subtest rcs0: SUCCESS (1.678s)
[538.048922] Starting dynamic subtest: bcs0
[539.668848] Dynamic subtest bcs0: SUCCESS (1.634s)
[539.689902] Starting dynamic subtest: vcs0
[541.305251] Dynamic subtest vcs0: SUCCESS (1.630s)
[541.321843] Starting dynamic subtest: vcs1
[542.943438] Dynamic subtest vcs1: SUCCESS (1.633s)
[542.956972] Starting dynamic subtest: vecs0
[544.589280] Dynamic subtest vecs0: SUCCESS (1.642s)
[544.606537] Starting dynamic subtest: vecs1
[546.234093] Dynamic subtest vecs1: SUCCESS (1.640s)
[546.251417] Starting dynamic subtest: ccs0
[547.879283] Dynamic subtest ccs0: SUCCESS (1.640s)
[547.881249] Subtest semaphore-busy: SUCCESS (11.529s)
[548.067670] [133/133] (497s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[549.585732] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[549.586665] Starting dynamic subtest: pipe-A-HDMI-A-3
[549.608635] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[549.620963] Starting dynamic subtest: pipe-B-HDMI-A-3
[549.643340] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[549.655343] Starting dynamic subtest: pipe-C-HDMI-A-3
[549.679028] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[549.691132] Starting dynamic subtest: pipe-D-HDMI-A-3
[549.713955] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[549.715720] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.016s)
[549.865707] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: gem_ctx_bad_destroy
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: kms_hdr
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: gen7_exec_parse
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_dp_link_training
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_chamelium_audio
results: parsing output: 29/ for test: gem_pread
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_exec_store
results: parsing output: 40/ for test: kms_fbcon_fbt
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_render_copy_redux
results: parsing output: 48/ for test: gen7_exec_parse
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_selftest
results: parsing output: 53/ for test: kms_invalid_mode
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_cursor_edge_walk
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: kms_pipe_crc_basic
results: parsing output: 60/ for test: kms_chamelium_edid
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_pm_dc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_prop_blob
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_plane_multiple
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_fb_coherency
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exercise_blt
results: parsing output: 86/ for test: gem_partial_pwrite_pread
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: gem_ccs
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: gem_ctx_shared
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: vgem_basic
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_mmap
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: i915_hangman
results: parsing output: 104/ for test: vgem_basic
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: core_auth
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_ctx_engines
results: parsing output: 111/ for test: i915_query
results: parsing output: 112/ for test: gem_exec_flush
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: device_reset
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_partial_pwrite_pread
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: i915_pm_rpm
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_vrr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_ccs
Done.