[114.025560] Initializing watchdogs
[114.025642]   /dev/watchdog0
[114.069705] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[114.084493] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[114.089270] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[114.092264] [001/156] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[115.588334] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[116.675810] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.086s)
[116.894388] [002/156] (957s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[116.940228] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[116.941037] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[117.046409] [003/156] (957s left) gem_ppgtt (shrink-vs-evict-pinned)
[117.101380] Starting subtest: shrink-vs-evict-pinned
[124.831137] Subtest shrink-vs-evict-pinned: SUCCESS (7.725s)
[124.955464] [004/156] (949s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[126.445530] Starting subtest: basic-flip-before-cursor-legacy
[127.454399] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.009s)
[127.666194] [005/156] (947s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[129.163777] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[129.165432] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[129.364236] [006/156] (945s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[130.876872] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[130.878882] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[131.089847] [007/156] (944s left) kms_psr (psr2-primary-page-flip)
[132.581137] Subtest psr2-primary-page-flip: SKIP (0.000s)
[132.647090] [008/156] (942s left) syncobj_timeline (host-signal-points)
[132.692828] Starting subtest: host-signal-points
[132.703415] Subtest host-signal-points: SUCCESS (0.011s)
[132.802164] [009/156] (942s left) kms_dp_link_training (uhbr-sst)
[134.290472] Starting subtest: uhbr-sst
[134.292578] Subtest uhbr-sst: SKIP (0.000s)
[134.415639] [010/156] (940s left) gen3_render_tiledy_blits
[134.551189] [011/156] (940s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[136.039899] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[136.040908] Starting dynamic subtest: pipe-A-HDMI-A-4
[156.656301] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.541s)
[156.671354] Starting dynamic subtest: pipe-B-HDMI-A-4
[178.576740] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.184s)
[178.588695] Starting dynamic subtest: pipe-C-HDMI-A-4
[200.577147] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.221s)
[200.588559] Starting dynamic subtest: pipe-D-HDMI-A-4
[222.552771] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.144s)
[222.553706] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (41.094s)
[228.804515] [012/156] (852s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[228.858165] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[228.859087] Starting dynamic subtest: smem
[228.953234] Dynamic subtest smem: SUCCESS (0.094s)
[228.968818] Starting dynamic subtest: lmem0
[229.892384] Dynamic subtest lmem0: SUCCESS (0.936s)
[229.893439] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (1.031s)
[230.195149] [013/156] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[231.709339] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[231.711376] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[231.883416] [014/156] (849s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[233.381718] Starting subtest: fbcpsrhdr-tiling-linear
[233.383788] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[233.548910] [015/156] (848s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[235.062786] Starting subtest: y-tiled-32bpp-rotate-270
[237.099382] Subtest y-tiled-32bpp-rotate-270: SUCCESS (2.033s)
[237.298392] [016/156] (844s left) gem_readwrite (read-bad-handle)
[237.345893] Subtest read-bad-handle: SKIP (0.000s)
[237.435586] [017/156] (844s left) kms_addfb_basic (basic)
[237.480704] Starting subtest: basic
[237.481701] Subtest basic: SUCCESS (0.000s)
[239.092825] [018/156] (842s left) kms_invalid_mode (bad-hsync-end)
[240.590513] Starting subtest: bad-hsync-end
[240.591533] Starting dynamic subtest: pipe-A-HDMI-A-4
[240.635759] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.046s)
[240.647294] Starting dynamic subtest: pipe-B-HDMI-A-4
[240.648488] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[240.659728] Starting dynamic subtest: pipe-C-HDMI-A-4
[240.660920] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[240.673002] Starting dynamic subtest: pipe-D-HDMI-A-4
[240.673919] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[240.674846] Subtest bad-hsync-end: SUCCESS (0.053s)
[240.834680] [019/156] (841s left) gem_userptr_blits (readonly-pwrite-unsync)
[240.888837] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[241.099806] [020/156] (841s left) gem_userptr_blits (forbidden-operations)
[241.152521] Starting subtest: forbidden-operations
[241.154136] Subtest forbidden-operations: SKIP (0.000s)
[241.327169] [021/156] (840s left) prime_vgem (basic-fence-read)
[241.464520] Starting subtest: basic-fence-read
[241.474291] Subtest basic-fence-read: SKIP (0.010s)
[241.613221] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[241.615403] [022/156] (840s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render)
[243.112007] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render
[243.114169] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[243.291040] [023/156] (839s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[244.787850] Starting subtest: fbchdr-tiling-y
[244.789583] Subtest fbchdr-tiling-y: SKIP (0.000s)
[244.943495] [024/156] (837s left) kms_psr (pr-cursor-mmap-cpu)
[246.437818] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[246.521478] [025/156] (836s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[248.033215] Starting subtest: x-tiled-8bpp-rotate-180
[249.732018] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.695s)
[249.910629] [026/156] (832s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[251.400015] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[251.402080] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[251.517083] [027/156] (831s left) kms_vblank (wait-forked-busy-hang)
[253.016774] Starting subtest: wait-forked-busy-hang
[253.017633] Starting dynamic subtest: pipe-A-HDMI-A-4
[279.883768] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.868s)
[279.897965] Starting dynamic subtest: pipe-D-HDMI-A-4
[304.892937] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.003s)
[304.893886] Subtest wait-forked-busy-hang: SUCCESS (51.878s)
[305.097469] [028/156] (777s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[306.587625] Starting subtest: bad-aux-stride-y-tiled-ccs
[306.588473] Starting dynamic subtest: pipe-A-HDMI-A-4
[306.596611] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[306.608448] Starting dynamic subtest: pipe-B-HDMI-A-4
[306.616654] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[306.628141] Starting dynamic subtest: pipe-C-HDMI-A-4
[306.636611] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[306.647918] Starting dynamic subtest: pipe-D-HDMI-A-4
[306.656645] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[306.658560] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[306.886098] [029/156] (775s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[308.396289] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[309.011361] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s)
[309.321856] [030/156] (773s left) gem_fence_thrash (bo-write-verify-threaded-none)
[309.365120] Starting subtest: bo-write-verify-threaded-none
[309.368227] Subtest bo-write-verify-threaded-none: SKIP (0.003s)
[309.455903] [031/156] (773s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[310.952602] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[310.954572] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[311.110961] [032/156] (772s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[312.610721] Starting subtest: hdr-1p-pri-indfb-multidraw
[312.612437] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[312.789202] [033/156] (770s left) perf (gen12-mi-rpc)
[312.911516] Starting subtest: gen12-mi-rpc
[312.912425] Starting dynamic subtest: rcs0
[312.963864] Dynamic subtest rcs0: SUCCESS (0.052s)
[312.964715] Subtest gen12-mi-rpc: SUCCESS (0.053s)
[313.041437] [034/156] (770s left) kms_color (invalid-gamma-lut-sizes)
[314.570003] Starting subtest: invalid-gamma-lut-sizes
[314.571070] Starting dynamic subtest: pipe-A
[314.619204] Dynamic subtest pipe-A: SUCCESS (0.050s)
[314.631471] Starting dynamic subtest: pipe-B
[314.632627] Dynamic subtest pipe-B: SUCCESS (0.002s)
[314.644248] Starting dynamic subtest: pipe-C
[314.645169] Dynamic subtest pipe-C: SUCCESS (0.001s)
[314.656637] Starting dynamic subtest: pipe-D
[314.657707] Dynamic subtest pipe-D: SUCCESS (0.001s)
[314.658781] Subtest invalid-gamma-lut-sizes: SUCCESS (0.056s)
[314.796456] [035/156] (768s left) gem_ctx_shared (q-independent)
[314.855461] Starting subtest: Q-independent
[314.856444] Starting dynamic subtest: rcs0
[315.013223] Dynamic subtest rcs0: SUCCESS (0.154s)
[315.025179] Starting dynamic subtest: bcs0
[315.104950] Dynamic subtest bcs0: SUCCESS (0.094s)
[315.116859] Starting dynamic subtest: vcs0
[315.200372] Dynamic subtest vcs0: SUCCESS (0.095s)
[315.212539] Starting dynamic subtest: vcs1
[315.297732] Dynamic subtest vcs1: SUCCESS (0.097s)
[315.309952] Starting dynamic subtest: vecs0
[315.406716] Dynamic subtest vecs0: SUCCESS (0.109s)
[315.407514] Subtest Q-independent: SUCCESS (0.552s)
[315.733926] [036/156] (767s left) api_intel_bb (render-ccs)
[315.778844] Starting subtest: render-ccs
[315.871995] Subtest render-ccs: SUCCESS (0.094s)
[316.003413] [037/156] (767s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[320.432348] Starting subtest: modeset-non-lpsp-stress-no-wait
[323.784696] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (3.352s)
[323.962380] [038/156] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[325.459386] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[325.461531] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[325.618305] [039/156] (758s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[325.683404] Starting subtest: map-fixed-invalidate-overlap
[325.685126] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[325.873490] [040/156] (757s left) i915_pciid
[326.057291] [041/156] (757s left) kms_invalid_mode (uint-max-clock)
[327.544754] Starting subtest: uint-max-clock
[327.545626] Starting dynamic subtest: pipe-A-HDMI-A-4
[327.589711] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.043s)
[327.602277] Starting dynamic subtest: pipe-B-HDMI-A-4
[327.603405] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[327.615275] Starting dynamic subtest: pipe-C-HDMI-A-4
[327.616242] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[327.629296] Starting dynamic subtest: pipe-D-HDMI-A-4
[327.630169] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[327.631051] Subtest uint-max-clock: SUCCESS (0.052s)
[327.788583] [042/156] (756s left) kms_frontbuffer_tracking (basic)
[329.284786] Starting subtest: basic
[332.162258] Subtest basic: SUCCESS (2.877s)
[332.347652] [043/156] (751s left) kms_psr (fbc-psr2-no-drrs)
[333.840610] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[333.923896] [044/156] (750s left) gem_pipe_control_store_loop (reused-buffer)
[333.975625] Starting subtest: reused-buffer
[336.145467] Subtest reused-buffer: SUCCESS (2.167s)
[336.307435] [045/156] (747s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[337.834627] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[337.966015] [046/156] (746s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[339.495174] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[339.496202] Starting dynamic subtest: pipe-A-HDMI-A-4
[340.377058] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.877s)
[340.389300] Starting dynamic subtest: pipe-B-HDMI-A-4
[340.469524] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.091s)
[340.481370] Starting dynamic subtest: pipe-C-HDMI-A-4
[340.560648] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.089s)
[340.572868] Starting dynamic subtest: pipe-D-HDMI-A-4
[340.651114] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.089s)
[340.651888] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SUCCESS (1.153s)
[340.932385] [047/156] (743s left) gen9_exec_parse (bb-start-out)
[340.986051] Subtest bb-start-out: SKIP (0.000s)
[341.060704] [048/156] (743s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[342.606322] Starting subtest: dp-mst-lic-type-0-hdcp14
[342.608250] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[342.816565] [049/156] (741s left) i915_drm_fdinfo (busy)
[342.865809] Starting subtest: busy
[342.866712] Starting dynamic subtest: rcs0
[342.868495] Dynamic subtest rcs0: SKIP (0.000s)
[342.880877] Starting dynamic subtest: bcs0
[342.882565] Dynamic subtest bcs0: SKIP (0.000s)
[342.894879] Starting dynamic subtest: vcs0
[342.896619] Dynamic subtest vcs0: SKIP (0.001s)
[342.909013] Starting dynamic subtest: vcs1
[342.911189] Dynamic subtest vcs1: SKIP (0.000s)
[342.924854] Starting dynamic subtest: vecs0
[342.926929] Dynamic subtest vecs0: SKIP (0.000s)
[342.928954] Subtest busy: SKIP (0.006s)
[342.991588] [050/156] (741s left) kms_scaling_modes (scaling-mode-none)
[344.481702] Starting subtest: scaling-mode-none
[344.487107] Subtest scaling-mode-none: SKIP (0.001s)
[344.615719] [051/156] (740s left) gem_eio (in-flight-immediate)
[344.821204] Starting subtest: in-flight-immediate
[349.065406] Subtest in-flight-immediate: SUCCESS (4.244s)
[350.655882] [052/156] (734s left) kms_psr (psr2-cursor-mmap-gtt)
[352.154358] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[352.227079] [053/156] (732s left) gem_close (basic)
[352.279187] Starting subtest: basic
[352.280163] Subtest basic: SUCCESS (0.000s)
[352.437749] [054/156] (732s left) syncobj_wait (wait-for-submit-complex)
[352.484321] Starting subtest: wait-for-submit-complex
[352.546477] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[352.759777] [055/156] (732s left) gem_pxp (hw-rejects-pxp-context)
[355.330651] Starting subtest: hw-rejects-pxp-context
[355.331867] Subtest hw-rejects-pxp-context: SUCCESS (0.004s)
[355.461790] [056/156] (729s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[356.973462] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[356.975634] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[357.125412] [057/156] (728s left) gem_exec_fence (syncobj-timeline-wait)
[357.644978] Starting subtest: syncobj-timeline-wait
[357.697194] Subtest syncobj-timeline-wait: SUCCESS (0.055s)
[357.958277] [058/156] (727s left) perf_pmu (render-node-busy)
[358.010832] Starting subtest: render-node-busy
[358.011659] Starting dynamic subtest: rcs0
[358.615643] Dynamic subtest rcs0: SUCCESS (0.605s)
[358.633413] Starting dynamic subtest: bcs0
[359.171710] Dynamic subtest bcs0: SUCCESS (0.555s)
[359.187709] Starting dynamic subtest: vcs0
[359.729616] Dynamic subtest vcs0: SUCCESS (0.557s)
[359.745783] Starting dynamic subtest: vcs1
[360.289417] Dynamic subtest vcs1: SUCCESS (0.557s)
[360.311805] Starting dynamic subtest: vecs0
[360.851323] Dynamic subtest vecs0: SUCCESS (0.558s)
[360.853815] Subtest render-node-busy: SUCCESS (2.842s)
[361.053323] [059/156] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[362.550499] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[362.552296] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[362.720633] [060/156] (722s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[364.219187] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[364.220831] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[364.383938] [061/156] (721s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[365.876189] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[365.878283] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[365.986439] [062/156] (719s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[367.480103] Starting subtest: async-flip-with-page-flip-events-linear
[367.743698] Starting dynamic subtest: pipe-A-HDMI-A-4
[370.071877] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.324s)
[370.261480] Starting dynamic subtest: pipe-B-HDMI-A-4
[372.328314] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.076s)
[372.510775] Starting dynamic subtest: pipe-C-HDMI-A-4
[374.574152] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.073s)
[374.751344] Starting dynamic subtest: pipe-D-HDMI-A-4
[376.823950] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.082s)
[376.824970] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.342s)
[377.211087] [063/156] (708s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[378.707593] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[378.709522] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[378.867514] [064/156] (707s left) prime_vgem (shrink)
[378.953996] Starting subtest: shrink
[378.960304] Subtest shrink: SUCCESS (0.008s)
[379.144015] [065/156] (706s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[379.188938] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[379.263297] [066/156] (706s left) kms_flip (2x-flip-vs-fences)
[380.755847] Starting subtest: 2x-flip-vs-fences
[380.757689] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[380.911932] [067/156] (705s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[382.520377] Starting subtest: cursor-rapid-movement-32x10
[382.573549] Subtest cursor-rapid-movement-32x10: SKIP (0.052s)
[383.002046] [068/156] (703s left) kms_cursor_crc (cursor-offscreen-512x512)
[384.768388] Starting subtest: cursor-offscreen-512x512
[384.771981] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[385.019296] [069/156] (701s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[386.509801] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[386.597291] [070/156] (699s left) gem_spin_batch (spin-all-new)
[386.654375] Starting subtest: spin-all-new
[386.694547] Subtest spin-all-new: SUCCESS (0.040s)
[387.052179] [071/156] (699s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[388.546420] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[388.547455] Starting dynamic subtest: pipe-A-valid-mode
[389.932646] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.385s)
[389.933505] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.387s)
[390.140122] [072/156] (696s left) gem_mmap_gtt (basic-small-bo-tiledy)
[390.189150] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[390.275737] [073/156] (696s left) dmabuf_sync_file (import-multiple-read-write)
[390.331043] Starting subtest: import-multiple-read-write
[390.333950] Subtest import-multiple-read-write: SUCCESS (0.006s)
[390.441766] [074/156] (696s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[391.938511] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[391.940202] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[392.131591] [075/156] (694s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[393.628799] Starting subtest: hdr-farfromfence-mmap-gtt
[393.630842] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[393.837625] [076/156] (693s left) kms_pm_dc (dc5-dpms)
[396.336151] Starting subtest: dc5-dpms
[397.600559] Subtest dc5-dpms: SUCCESS (1.262s)
[397.742403] [077/156] (689s left) kms_psr (fbc-pr-dpms)
[399.236774] Subtest fbc-pr-dpms: SKIP (0.000s)
[399.318883] [078/156] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[400.813488] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[403.455013] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.641s)
[403.717776] [079/156] (683s left) i915_query (query-topology-known-pci-ids)
[403.763183] Starting subtest: query-topology-known-pci-ids
[403.765024] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[403.874479] [080/156] (683s left) gem_mmap_gtt (zero-extend)
[403.923252] Subtest zero-extend: SKIP (0.000s)
[404.001814] [081/156] (683s left) i915_pm_rpm (system-suspend-execbuf)
[408.439766] Starting subtest: system-suspend-execbuf
[471.258672] Subtest system-suspend-execbuf: SUCCESS (53.052s)
[472.207909] [082/156] (615s left) gem_ctx_create (basic-files)
[472.269735] Starting subtest: basic-files
[474.287798] Subtest basic-files: SUCCESS (2.019s)
[474.653022] [083/156] (612s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[476.148882] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[476.150497] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[476.334779] [084/156] (611s left) i915_pm_rps (thresholds-idle-park)
[476.389928] Starting subtest: thresholds-idle-park
[476.391675] Subtest thresholds-idle-park: SKIP (0.000s)
[476.502942] [085/156] (611s left) gem_exec_whisper (basic-queues-priority)
[476.561647] Starting subtest: basic-queues-priority
[490.798401] Subtest basic-queues-priority: SUCCESS (14.233s)
[491.066878] [086/156] (596s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[492.563450] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[492.565405] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[492.745350] [087/156] (595s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[494.257756] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[495.353546] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.093s)
[495.566821] [088/156] (592s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[497.063346] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[497.065225] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[497.253244] [089/156] (591s left) gem_exec_flush (basic-wb-prw-default)
[497.323394] Subtest basic-wb-prw-default: SKIP (0.000s)
[497.445707] [090/156] (590s left) syncobj_timeline (wait-any-interrupted)
[497.491972] Starting subtest: wait-any-interrupted
[497.597521] Subtest wait-any-interrupted: SUCCESS (0.102s)
[497.766474] [091/156] (590s left) gen7_exec_parse (basic-offset)
[497.816187] Subtest basic-offset: SKIP (0.000s)
[497.897913] [092/156] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[499.396886] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[499.398868] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[499.588818] [093/156] (589s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[501.123650] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[501.264339] [094/156] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[502.760104] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[502.762048] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[502.956913] [095/156] (585s left) gem_ctx_persistence (legacy-engines-hang)
[503.017668] Starting subtest: legacy-engines-hang
[503.018597] Starting dynamic subtest: render
[503.079665] Dynamic subtest render: SUCCESS (0.061s)
[503.097814] Starting dynamic subtest: bsd1
[503.177897] Dynamic subtest bsd1: SUCCESS (0.095s)
[503.231702] Starting dynamic subtest: bsd2
[503.250535] Dynamic subtest bsd2: SUCCESS (0.066s)
[503.269435] Starting dynamic subtest: blt
[503.344588] Dynamic subtest blt: SUCCESS (0.091s)
[503.400545] Starting dynamic subtest: vebox
[503.415549] Dynamic subtest vebox: SUCCESS (0.064s)
[503.416489] Subtest legacy-engines-hang: SUCCESS (0.399s)
[503.573214] [096/156] (585s left) gem_exec_balancer (parallel-ordering)
[503.952924] Starting subtest: parallel-ordering
[506.096207] Subtest parallel-ordering: SUCCESS (2.145s)
[506.246620] [097/156] (582s left) gem_basic (create-fd-close)
[506.291470] Starting subtest: create-fd-close
[506.293585] Subtest create-fd-close: SUCCESS (0.000s)
[506.476472] [098/156] (582s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[507.967884] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[507.968720] Starting dynamic subtest: pipe-A-HDMI-A-4
[507.990820] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[508.005664] Starting dynamic subtest: pipe-B-HDMI-A-4
[508.028013] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[508.042539] Starting dynamic subtest: pipe-C-HDMI-A-4
[508.065404] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[508.079946] Starting dynamic subtest: pipe-D-HDMI-A-4
[508.102373] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[508.104253] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.021s)
[508.288773] [099/156] (580s left) gem_close_race (multigpu-basic-process)
[508.362145] Starting subtest: multigpu-basic-process
[508.364151] Subtest multigpu-basic-process: SKIP (0.000s)
[508.719093] [100/156] (580s left) gem_media_fill (media-fill)
[508.772923] Starting subtest: media-fill
[508.773936] Starting dynamic subtest: smem
[508.795422] Dynamic subtest smem: SUCCESS (0.022s)
[508.812428] Starting dynamic subtest: lmem0
[508.813603] Dynamic subtest lmem0: SUCCESS (0.009s)
[508.814706] Subtest media-fill: SUCCESS (0.034s)
[509.061226] [101/156] (580s left) kms_plane (plane-position-covered)
[510.553004] Starting subtest: plane-position-covered
[511.046581] Starting dynamic subtest: pipe-A-plane-1
[511.409468] Dynamic subtest pipe-A-plane-1: SUCCESS (0.363s)
[511.424281] Starting dynamic subtest: pipe-A-plane-2
[511.790776] Dynamic subtest pipe-A-plane-2: SUCCESS (0.377s)
[511.805760] Starting dynamic subtest: pipe-A-plane-3
[512.149314] Dynamic subtest pipe-A-plane-3: SUCCESS (0.360s)
[512.166527] Starting dynamic subtest: pipe-A-plane-4
[512.528298] Dynamic subtest pipe-A-plane-4: SUCCESS (0.377s)
[512.543546] Starting dynamic subtest: pipe-A-plane-5
[512.892408] Dynamic subtest pipe-A-plane-5: SUCCESS (0.363s)
[512.907714] Starting dynamic subtest: pipe-A-plane-6
[513.224406] Dynamic subtest pipe-A-plane-6: SUCCESS (0.330s)
[513.239901] Starting dynamic subtest: pipe-A-plane-7
[513.245198] Dynamic subtest pipe-A-plane-7: SUCCESS (0.020s)
[513.558807] Starting dynamic subtest: pipe-B-plane-1
[513.866237] Dynamic subtest pipe-B-plane-1: SUCCESS (0.324s)
[513.881213] Starting dynamic subtest: pipe-B-plane-2
[514.246708] Dynamic subtest pipe-B-plane-2: SUCCESS (0.379s)
[514.263484] Starting dynamic subtest: pipe-B-plane-3
[514.589101] Dynamic subtest pipe-B-plane-3: SUCCESS (0.342s)
[514.608347] Starting dynamic subtest: pipe-B-plane-4
[514.935670] Dynamic subtest pipe-B-plane-4: SUCCESS (0.345s)
[514.954814] Starting dynamic subtest: pipe-B-plane-5
[515.297961] Dynamic subtest pipe-B-plane-5: SUCCESS (0.360s)
[515.312967] Starting dynamic subtest: pipe-B-plane-6
[515.663535] Dynamic subtest pipe-B-plane-6: SUCCESS (0.364s)
[515.678666] Starting dynamic subtest: pipe-B-plane-7
[515.689546] Dynamic subtest pipe-B-plane-7: SUCCESS (0.025s)
[515.690463] Subtest plane-position-covered: SUCCESS (5.138s)
[515.915777] [102/156] (573s left) kms_atomic (plane-immutable-zpos)
[517.407759] Starting subtest: plane-immutable-zpos
[517.410088] Starting dynamic subtest: pipe-A-HDMI-A-4
[518.194277] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.785s)
[518.195192] Subtest plane-immutable-zpos: SUCCESS (0.788s)
[518.407223] [103/156] (571s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu)
[519.903530] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu
[519.905335] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[520.055872] [104/156] (569s left) gem_exec_fence (syncobj-channel)
[520.489758] Starting subtest: syncobj-channel
[521.516720] Subtest syncobj-channel: SUCCESS (1.024s)
[521.937686] [105/156] (567s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[523.435485] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[523.437590] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[523.600947] [106/156] (566s left) kms_lease (page-flip-implicit-plane)
[525.093005] Starting subtest: page-flip-implicit-plane
[525.094048] Starting dynamic subtest: pipe-A-HDMI-A-4
[525.523386] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.429s)
[525.548692] Starting dynamic subtest: pipe-B-HDMI-A-4
[525.820411] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.293s)
[525.836798] Starting dynamic subtest: pipe-C-HDMI-A-4
[526.098713] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.276s)
[526.115845] Starting dynamic subtest: pipe-D-HDMI-A-4
[526.369145] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.268s)
[526.370082] Subtest page-flip-implicit-plane: SUCCESS (1.278s)
[526.590219] [107/156] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[528.089197] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[528.090873] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[528.307731] [108/156] (561s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt)
[529.810655] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt
[529.812908] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[529.992484] [109/156] (560s left) syncobj_wait (invalid-reset-one-illegal-handle)
[530.040416] Starting subtest: invalid-reset-one-illegal-handle
[530.041471] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[530.181747] [110/156] (560s left) kms_properties (plane-properties-legacy)
[531.675106] Starting subtest: plane-properties-legacy
[531.675969] Starting dynamic subtest: pipe-A-HDMI-A-4
[532.128456] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.452s)
[532.144820] Starting dynamic subtest: pipe-B-HDMI-A-4
[532.590580] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.459s)
[532.608049] Starting dynamic subtest: pipe-C-HDMI-A-4
[533.062243] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.467s)
[533.078156] Starting dynamic subtest: pipe-D-HDMI-A-4
[533.513641] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.452s)
[533.514526] Subtest plane-properties-legacy: SUCCESS (1.840s)
[533.724600] [111/156] (556s left) gem_exec_schedule (out-order)
[533.788149] Starting subtest: out-order
[533.789138] Starting dynamic subtest: rcs0
[533.984899] Dynamic subtest rcs0: SUCCESS (0.193s)
[534.000000] Starting dynamic subtest: bcs0
[534.121072] Dynamic subtest bcs0: SUCCESS (0.138s)
[534.137875] Starting dynamic subtest: vcs0
[534.260758] Dynamic subtest vcs0: SUCCESS (0.138s)
[534.277623] Starting dynamic subtest: vcs1
[534.410950] Dynamic subtest vcs1: SUCCESS (0.149s)
[534.427791] Starting dynamic subtest: vecs0
[534.561150] Dynamic subtest vecs0: SUCCESS (0.149s)
[534.562088] Subtest out-order: SUCCESS (0.774s)
[535.024931] [112/156] (555s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[536.521159] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[536.522825] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[536.753238] [113/156] (553s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[538.251735] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[538.253782] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[538.418515] [114/156] (552s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[539.913289] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[539.994024] [115/156] (550s left) gem_exec_store (cachelines)
[540.051064] Starting subtest: cachelines
[540.051916] Starting dynamic subtest: rcs0
[540.134724] Dynamic subtest rcs0: SUCCESS (0.083s)
[540.159479] Starting dynamic subtest: bcs0
[540.198054] Dynamic subtest bcs0: SUCCESS (0.061s)
[540.245787] Starting dynamic subtest: vcs0
[540.274380] Dynamic subtest vcs0: SUCCESS (0.073s)
[540.293843] Starting dynamic subtest: vcs1
[540.329515] Dynamic subtest vcs1: SUCCESS (0.053s)
[540.358389] Starting dynamic subtest: vecs0
[540.393769] Dynamic subtest vecs0: SUCCESS (0.062s)
[540.398043] Subtest cachelines: SUCCESS (0.344s)
[540.721148] [116/156] (550s left) kms_cursor_crc (cursor-sliding-32x32)
[542.300772] Starting subtest: cursor-sliding-32x32
[542.355357] Subtest cursor-sliding-32x32: SKIP (0.052s)
[542.776327] [117/156] (548s left) syncobj_timeline (multi-wait-all-signaled)
[542.823564] Starting subtest: multi-wait-all-signaled
[542.824482] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[542.955512] [118/156] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[544.450232] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[544.452091] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[544.624965] [119/156] (546s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[546.121960] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[546.123560] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[546.290976] [120/156] (545s left) kms_flip (plain-flip-ts-check-interruptible)
[547.795958] Starting subtest: plain-flip-ts-check-interruptible
[547.804644] Starting dynamic subtest: A-HDMI-A4
[555.826475] Dynamic subtest A-HDMI-A4: SUCCESS (8.020s)
[555.844877] Starting dynamic subtest: B-HDMI-A4
[563.791968] Dynamic subtest B-HDMI-A4: SUCCESS (7.960s)
[563.811330] Starting dynamic subtest: C-HDMI-A4
[571.758733] Dynamic subtest C-HDMI-A4: SUCCESS (7.961s)
[571.775875] Starting dynamic subtest: D-HDMI-A4
[579.726872] Dynamic subtest D-HDMI-A4: SUCCESS (7.966s)
[579.727789] Subtest plain-flip-ts-check-interruptible: SUCCESS (31.930s)
[579.962999] [121/156] (511s left) sysfs_heartbeat_interval (mixed)
[580.014765] Starting subtest: mixed
[580.017323] Starting dynamic subtest: vecs0
[585.320948] Dynamic subtest vecs0: SUCCESS (5.304s)
[585.337834] Starting dynamic subtest: vcs0
[590.392861] Dynamic subtest vcs0: SUCCESS (5.069s)
[590.415473] Starting dynamic subtest: bcs0
[595.473505] Dynamic subtest bcs0: SUCCESS (5.076s)
[595.490763] Starting dynamic subtest: rcs0
[600.758009] Dynamic subtest rcs0: SUCCESS (5.282s)
[600.775776] Starting dynamic subtest: vcs1
[605.816236] Dynamic subtest vcs1: SUCCESS (5.055s)
[605.819733] Subtest mixed: SUCCESS (25.801s)
[606.067163] [122/156] (485s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[607.560392] Starting subtest: primary-x-tiled-reflect-x-180
[618.464533] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.904s)
[618.731590] [123/156] (472s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[618.779906] Starting subtest: single-wait-all-for-submit-unsubmitted
[618.885758] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[619.017189] [124/156] (472s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[620.513648] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[620.515330] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[620.662382] [125/156] (471s left) sw_sync (sync_busy_fork)
[620.710254] Starting subtest: sync_busy_fork
[621.729214] Subtest sync_busy_fork: SUCCESS (1.016s)
[621.821641] [126/156] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[623.318475] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[623.320334] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[623.502603] [127/156] (468s left) syncobj_timeline (32bits-limit)
[623.550956] Starting subtest: 32bits-limit
[623.551860] Subtest 32bits-limit: SUCCESS (0.001s)
[623.689219] [128/156] (468s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[625.184895] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[625.186526] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[625.371059] [129/156] (466s left) gem_ctx_persistence (engines-queued)
[625.423198] Starting subtest: engines-queued
[625.424082] Starting dynamic subtest: rcs0
[625.488486] Dynamic subtest rcs0: SUCCESS (0.065s)
[625.505425] Starting dynamic subtest: bcs0
[625.532452] Dynamic subtest bcs0: SUCCESS (0.042s)
[625.551837] Starting dynamic subtest: vcs0
[625.582552] Dynamic subtest vcs0: SUCCESS (0.048s)
[625.608427] Starting dynamic subtest: vcs1
[625.639750] Dynamic subtest vcs1: SUCCESS (0.055s)
[625.671098] Starting dynamic subtest: vecs0
[625.705590] Dynamic subtest vecs0: SUCCESS (0.063s)
[625.708843] Subtest engines-queued: SUCCESS (0.284s)
[625.965403] [130/156] (466s left) kms_atomic_interruptible (legacy-pageflip)
[627.456421] Starting subtest: legacy-pageflip
[627.458817] Starting dynamic subtest: pipe-A-HDMI-A-4
[633.692832] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.234s)
[633.693856] Subtest legacy-pageflip: SUCCESS (6.237s)
[633.894341] [131/156] (458s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[635.392133] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[635.393814] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[635.584150] [132/156] (456s left) kms_big_fb (linear-32bpp-rotate-180)
[637.094483] Starting subtest: linear-32bpp-rotate-180
[639.130784] Subtest linear-32bpp-rotate-180: SUCCESS (2.033s)
[639.419106] [133/156] (453s left) api_intel_allocator (reserve-simple)
[639.465956] Starting subtest: reserve-simple
[639.480637] Subtest reserve-simple: SUCCESS (0.016s)
[639.658950] [134/156] (453s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[641.157045] Starting subtest: fbc-rgb101010-draw-blt
[642.028928] Subtest fbc-rgb101010-draw-blt: SUCCESS (0.873s)
[642.235209] [135/156] (450s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[643.731598] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[643.733492] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[643.913768] [136/156] (448s left) kms_plane_alpha_blend (constant-alpha-max)
[645.404979] Starting subtest: constant-alpha-max
[645.664614] Starting dynamic subtest: pipe-A-HDMI-A-4
[646.550178] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.885s)
[646.566724] Starting dynamic subtest: pipe-D-HDMI-A-4
[647.454904] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.902s)
[647.455758] Subtest constant-alpha-max: SUCCESS (2.052s)
[647.671027] [137/156] (445s left) kms_draw_crc (draw-method-blt)
[649.163670] Starting subtest: draw-method-blt
[649.164546] Starting dynamic subtest: xrgb8888-untiled
[649.554971] Dynamic subtest xrgb8888-untiled: SUCCESS (0.391s)
[649.607085] Starting dynamic subtest: rgb565-untiled
[649.905030] Dynamic subtest rgb565-untiled: SUCCESS (0.342s)
[649.957664] Starting dynamic subtest: xrgb2101010-untiled
[650.238328] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.326s)
[650.257600] Starting dynamic subtest: xbgr16161616f-untiled
[650.555252] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.311s)
[650.607885] Starting dynamic subtest: xrgb8888-xtiled
[650.738619] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.176s)
[650.788484] Starting dynamic subtest: rgb565-xtiled
[650.921872] Dynamic subtest rgb565-xtiled: SUCCESS (0.176s)
[650.972854] Starting dynamic subtest: xrgb2101010-xtiled
[651.088605] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.159s)
[651.134050] Starting dynamic subtest: xbgr16161616f-xtiled
[651.255232] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.159s)
[651.307820] Starting dynamic subtest: xrgb8888-ytiled
[651.438853] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.176s)
[651.492193] Starting dynamic subtest: rgb565-ytiled
[651.622206] Dynamic subtest rgb565-ytiled: SUCCESS (0.176s)
[651.669594] Starting dynamic subtest: xrgb2101010-ytiled
[651.788625] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.159s)
[651.808210] Starting dynamic subtest: xbgr16161616f-ytiled
[651.922055] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.128s)
[651.932108] Subtest draw-method-blt: SUCCESS (2.762s)
[652.176931] [138/156] (440s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[653.673005] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[653.674629] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[653.851932] [139/156] (439s left) kms_chamelium_color (ctm-0-75)
[655.342914] Subtest ctm-0-75: SKIP (0.000s)
[655.420858] [140/156] (437s left) gem_ccs (large-ctrl-surf-copy)
[655.473273] Starting subtest: large-ctrl-surf-copy
[655.475179] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[655.599958] [141/156] (437s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[657.090393] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[657.091507] Starting dynamic subtest: pipe-A
[657.203803] Dynamic subtest pipe-A: SUCCESS (0.115s)
[657.221701] Starting dynamic subtest: pipe-B
[657.363534] Dynamic subtest pipe-B: SUCCESS (0.158s)
[657.380029] Starting dynamic subtest: pipe-C
[657.520198] Dynamic subtest pipe-C: SUCCESS (0.155s)
[657.536581] Starting dynamic subtest: pipe-D
[657.678037] Dynamic subtest pipe-D: SUCCESS (0.156s)
[657.679004] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.590s)
[657.892707] [142/156] (435s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[659.390324] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[659.392184] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[659.601105] [143/156] (433s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[661.093053] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[661.094890] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[661.212717] [144/156] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[662.721058] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[662.722724] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[662.899898] [145/156] (430s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[664.396531] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[664.398407] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[664.589195] [146/156] (429s left) gem_exec_schedule (submit-late-slice)
[664.652806] Starting subtest: submit-late-slice
[664.653787] Starting dynamic subtest: rcs0
[664.713526] Dynamic subtest rcs0: SUCCESS (0.060s)
[664.730706] Starting dynamic subtest: bcs0
[664.754041] Dynamic subtest bcs0: SUCCESS (0.039s)
[664.771154] Starting dynamic subtest: vcs0
[664.796018] Dynamic subtest vcs0: SUCCESS (0.040s)
[664.813011] Starting dynamic subtest: vcs1
[664.838285] Dynamic subtest vcs1: SUCCESS (0.041s)
[664.855292] Starting dynamic subtest: vecs0
[664.882251] Dynamic subtest vecs0: SUCCESS (0.042s)
[664.883293] Subtest submit-late-slice: SUCCESS (0.230s)
[665.380264] [147/156] (428s left) gem_exec_balancer (bonded-dual)
[665.438733] Starting subtest: bonded-dual
[665.440506] Subtest bonded-dual: SKIP (0.000s)
[665.920979] [148/156] (428s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[667.416426] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[667.418208] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[667.599038] [149/156] (426s left) gem_workarounds (suspend-resume-fd)
[667.672856] Starting subtest: suspend-resume-fd
[688.708876] Subtest suspend-resume-fd: SUCCESS (10.169s)
[694.882099] [150/156] (405s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[696.379488] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[696.381169] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[696.565532] [151/156] (403s left) kms_vblank (query-idle)
[698.057889] Starting subtest: query-idle
[698.058946] Starting dynamic subtest: pipe-A-HDMI-A-4
[700.369918] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.312s)
[700.388488] Starting dynamic subtest: pipe-D-HDMI-A-4
[702.562937] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.188s)
[702.563830] Subtest query-idle: SUCCESS (4.507s)
[702.764754] [152/156] (397s left) syncobj_timeline (multi-wait-submitted-signaled)
[702.812528] Starting subtest: multi-wait-submitted-signaled
[702.813398] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[702.943701] [153/156] (397s left) syncobj_wait (multi-wait-submitted)
[702.990167] Starting subtest: multi-wait-submitted
[703.103221] Subtest multi-wait-submitted: SUCCESS (0.109s)
[703.287292] [154/156] (397s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[704.782754] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[704.784672] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[704.968257] [155/156] (395s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[706.467280] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[706.469213] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[706.652256] [156/156] (394s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[708.148523] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[708.150357] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[708.322632] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_ppgtt
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_dp_link_training
results: parsing output: 9/ for test: gen3_render_tiledy_blits
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_readwrite
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: prime_vgem
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_fence_thrash
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: gem_ctx_shared
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: i915_pciid
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_pipe_control_store_loop
results: parsing output: 44/ for test: kms_chamelium_frames
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gen9_exec_parse
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_scaling_modes
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_close
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: gem_mmap_wc
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: dmabuf_sync_file
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_pm_dc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: gem_ctx_create
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: i915_pm_rps
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gen7_exec_parse
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: gem_basic
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_close_race
results: parsing output: 99/ for test: gem_media_fill
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_properties
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: gem_exec_store
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: sysfs_heartbeat_interval
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: api_intel_allocator
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_plane_alpha_blend
results: parsing output: 136/ for test: kms_draw_crc
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_chamelium_color
results: parsing output: 139/ for test: gem_ccs
results: parsing output: 140/ for test: kms_plane_scaling
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_plane
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_schedule
results: parsing output: 146/ for test: gem_exec_balancer
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_workarounds
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_vblank
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: syncobj_wait
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.