[69.212538] Initializing watchdogs
[69.212620]   /dev/watchdog0
[69.241405] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[69.255328] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.259939] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.263338] [001/131] (960s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[69.318814] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[69.385319] [002/131] (960s left) kms_content_protection (mei-interface)
[71.465714] Starting subtest: mei-interface
[71.743017] Subtest mei-interface: SKIP (0.275s)
[72.245166] [003/131] (957s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[74.244372] Starting subtest: dsc-fractional-bpp-with-bpc
[74.265237] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[74.401118] [004/131] (955s left) gem_lmem_swapping (parallel-random-verify-ccs)
[79.294949] Starting subtest: parallel-random-verify-ccs
[79.296947] Starting dynamic subtest: lmem0
[79.300332] Dynamic subtest lmem0: SKIP (0.000s)
[79.303714] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[83.153901] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[83.156187] [005/131] (946s left) gem_mmap_gtt (basic-copy)
[87.068710] Subtest basic-copy: SKIP (0.000s)
[87.147690] [FACT gem_mmap_gtt (basic-copy)] new: kernel.kmod_is_loaded.i915: true
[87.151222] [006/131] (942s left) kms_addfb_basic (too-high)
[89.129157] Starting subtest: too-high
[89.130657] Subtest too-high: SUCCESS (0.001s)
[89.325460] [007/131] (940s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[89.381940] Starting subtest: invalid-signal-one-illegal-handle
[89.383508] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[89.551822] [008/131] (940s left) gem_exec_balancer (parallel)
[89.909940] Starting subtest: parallel
[91.911176] Subtest parallel: SUCCESS (2.001s)
[92.041515] [009/131] (938s left) kms_cursor_crc (cursor-sliding-32x32)
[94.118649] Starting subtest: cursor-sliding-32x32
[94.169903] Subtest cursor-sliding-32x32: SKIP (0.046s)
[94.630801] [010/131] (935s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[96.630456] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[96.698512] [011/131] (933s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[98.710954] Starting subtest: yf-tiled-32bpp-rotate-0
[98.714380] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[98.944432] [012/131] (931s left) perf (short-reads)
[99.105566] Starting subtest: short-reads
[99.124459] Subtest short-reads: SUCCESS (0.028s)
[99.186130] [013/131] (931s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[101.189577] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[102.334700] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.141s)
[102.526142] [014/131] (928s left) gem_exec_whisper (basic-fds-priority)
[102.583486] Starting subtest: basic-fds-priority
[115.724122] Subtest basic-fds-priority: SUCCESS (13.135s)
[116.032092] [015/131] (914s left) gem_close (basic)
[116.081128] Starting subtest: basic
[116.082678] Subtest basic: SUCCESS (0.000s)
[116.269418] [016/131] (914s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[118.255333] Starting subtest: compare-crc-sanitycheck-xr24
[118.256878] Starting dynamic subtest: pipe-A-HDMI-A-4
[118.803419] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.548s)
[118.812923] Starting dynamic subtest: pipe-B-HDMI-A-4
[119.198892] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.394s)
[119.209979] Starting dynamic subtest: pipe-C-HDMI-A-4
[119.601635] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.400s)
[119.612116] Starting dynamic subtest: pipe-D-HDMI-A-4
[120.009543] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.407s)
[120.011144] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.755s)
[120.247247] [017/131] (910s left) core_getstats (basic)
[120.311549] Starting subtest: basic
[120.314176] Subtest basic: SUCCESS (0.000s)
[120.464023] [018/131] (910s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[122.467319] Starting subtest: y-tiled-64bpp-rotate-0
[124.871806] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.402s)
[125.137406] [019/131] (906s left) api_intel_allocator (reopen-fork)
[125.186973] Starting subtest: reopen-fork
[128.567350] Subtest reopen-fork: SUCCESS (3.367s)
[128.714516] [020/131] (902s left) gem_exec_await (wide-all)
[128.901334] Starting subtest: wide-all
[151.078968] Subtest wide-all: SUCCESS (22.177s)
[151.346835] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[151.351127] [021/131] (880s left) kms_cursor_crc (cursor-tearing-position-change)
[153.449891] Starting subtest: cursor-tearing-position-change
[153.451510] Starting dynamic subtest: pipe-A-HDMI-A-4
[153.958733] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.507s)
[153.969122] Starting dynamic subtest: pipe-D-HDMI-A-4
[154.295974] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.336s)
[154.297713] Subtest cursor-tearing-position-change: SUCCESS (0.847s)
[155.017663] [022/131] (876s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[157.006268] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[157.007838] Starting dynamic subtest: pipe-A-HDMI-A-4
[159.477364] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.460s)
[159.508306] Starting dynamic subtest: pipe-B-HDMI-A-4
[160.485787] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.001s)
[160.500943] Starting dynamic subtest: pipe-C-HDMI-A-4
[161.425568] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.935s)
[161.457505] Starting dynamic subtest: pipe-D-HDMI-A-4
[162.399539] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.967s)
[162.402267] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.383s)
[162.659027] [023/131] (868s left) dumb_buffer (map-valid)
[162.706713] Starting subtest: map-valid
[162.708427] Subtest map-valid: SUCCESS (0.000s)
[162.909024] [024/131] (868s left) prime_vgem (basic-fence-read)
[162.968491] Starting subtest: basic-fence-read
[162.980216] Subtest basic-fence-read: SKIP (0.010s)
[163.127653] [025/131] (868s left) i915_drm_fdinfo (virtual-busy-idle)
[163.177559] Starting subtest: virtual-busy-idle
[163.181027] Subtest virtual-busy-idle: SKIP (0.000s)
[163.346341] [026/131] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[165.336926] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[165.340114] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[165.562930] [027/131] (866s left) syncobj_timeline (wait-for-submit-delayed-submit)
[165.621973] Starting subtest: wait-for-submit-delayed-submit
[165.728531] Subtest wait-for-submit-delayed-submit: SUCCESS (0.105s)
[165.912165] [028/131] (866s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[167.896423] Starting subtest: plane-scaler-unity-scaling-with-rotation
[167.897966] Starting dynamic subtest: pipe-A
[168.246333] Dynamic subtest pipe-A: SKIP (0.346s)
[168.256869] Starting dynamic subtest: pipe-B
[168.633964] Dynamic subtest pipe-B: SKIP (0.388s)
[168.644168] Starting dynamic subtest: pipe-C
[169.024389] Dynamic subtest pipe-C: SKIP (0.389s)
[169.034595] Starting dynamic subtest: pipe-D
[169.413292] Dynamic subtest pipe-D: SKIP (0.388s)
[169.416602] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (1.513s)
[169.632680] [029/131] (862s left) kms_cursor_crc (cursor-offscreen-max-size)
[171.934621] Starting subtest: cursor-offscreen-max-size
[171.939613] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[172.189745] [030/131] (860s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[172.238601] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[172.344822] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[172.519837] [031/131] (859s left) kms_scaling_modes (scaling-mode-full-aspect)
[174.507311] Starting subtest: scaling-mode-full-aspect
[174.515416] Subtest scaling-mode-full-aspect: SKIP (0.002s)
[174.697117] [032/131] (857s left) gem_caching (reads)
[174.751660] Starting subtest: reads
[178.404167] Subtest reads: SUCCESS (3.652s)
[178.619032] [033/131] (853s left) gem_ctx_shared (disjoint-timelines)
[178.678884] Starting subtest: disjoint-timelines
[178.713184] Subtest disjoint-timelines: SUCCESS (0.034s)
[179.035256] [034/131] (853s left) kms_plane (pixel-format-source-clamping)
[181.015363] Starting subtest: pixel-format-source-clamping
[181.049209] Starting dynamic subtest: pipe-A-plane-0
[188.582867] Dynamic subtest pipe-A-plane-0: SUCCESS (7.533s)
[188.597369] Starting dynamic subtest: pipe-A-plane-3
[194.699210] Dynamic subtest pipe-A-plane-3: SUCCESS (6.114s)
[194.711221] Starting dynamic subtest: pipe-A-plane-5
[198.615914] Dynamic subtest pipe-A-plane-5: SUCCESS (3.916s)
[198.628480] Starting dynamic subtest: pipe-A-plane-7
[198.630389] Dynamic subtest pipe-A-plane-7: SUCCESS (0.000s)
[198.758045] Starting dynamic subtest: pipe-B-plane-0
[206.099301] Dynamic subtest pipe-B-plane-0: SUCCESS (7.350s)
[206.144251] Starting dynamic subtest: pipe-B-plane-3
[212.582155] Dynamic subtest pipe-B-plane-3: SUCCESS (6.480s)
[212.593527] Starting dynamic subtest: pipe-B-plane-5
[216.098885] Dynamic subtest pipe-B-plane-5: SUCCESS (3.516s)
[216.110992] Starting dynamic subtest: pipe-B-plane-7
[216.112990] Dynamic subtest pipe-B-plane-7: SUCCESS (0.000s)
[216.153407] Subtest pixel-format-source-clamping: SUCCESS (35.137s)
[216.513062] [035/131] (816s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[219.084859] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[219.087978] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[219.231890] [036/131] (813s left) prime_vgem (sync)
[219.308982] Starting subtest: sync
[219.310515] Starting dynamic subtest: rcs0
[219.368549] Dynamic subtest rcs0: SUCCESS (0.059s)
[219.380686] Starting dynamic subtest: bcs0
[219.411777] Dynamic subtest bcs0: SUCCESS (0.042s)
[219.422212] Starting dynamic subtest: vcs0
[219.452535] Dynamic subtest vcs0: SUCCESS (0.040s)
[219.464728] Starting dynamic subtest: vcs1
[219.493432] Dynamic subtest vcs1: SUCCESS (0.039s)
[219.508829] Starting dynamic subtest: vecs0
[219.535906] Dynamic subtest vecs0: SUCCESS (0.041s)
[219.537738] Subtest sync: SUCCESS (0.228s)
[219.731608] [037/131] (813s left) kms_cdclk (plane-scaling)
[219.781577] Subtest plane-scaling: SKIP (0.000s)
[219.857898] [038/131] (813s left) i915_pm_rps (thresholds)
[219.914127] Starting subtest: thresholds
[219.917335] Subtest thresholds: SKIP (0.000s)
[220.084221] [039/131] (812s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[222.087089] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[223.331228] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.243s)
[223.588548] [040/131] (809s left) drm_read (empty-block)
[225.633279] Starting subtest: empty-block
[226.635240] Subtest empty-block: SUCCESS (1.000s)
[226.850663] [041/131] (806s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[228.832997] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[228.834748] Starting dynamic subtest: pipe-A
[228.986220] Dynamic subtest pipe-A: SUCCESS (0.156s)
[228.998730] Starting dynamic subtest: pipe-B
[229.127507] Dynamic subtest pipe-B: SUCCESS (0.140s)
[229.138226] Starting dynamic subtest: pipe-C
[229.267969] Dynamic subtest pipe-C: SUCCESS (0.139s)
[229.279102] Starting dynamic subtest: pipe-D
[229.408966] Dynamic subtest pipe-D: SUCCESS (0.140s)
[229.410598] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.579s)
[229.672553] [042/131] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[231.673949] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[231.677540] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[231.921587] [043/131] (801s left) api_intel_allocator (reserve-simple)
[231.971044] Starting subtest: reserve-simple
[231.985376] Subtest reserve-simple: SUCCESS (0.016s)
[232.190398] [044/131] (801s left) syncobj_timeline (etime-single-wait-all-submitted)
[232.237918] Starting subtest: etime-single-wait-all-submitted
[232.344624] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[232.535562] [045/131] (801s left) kms_vblank (query-forked)
[234.526321] Starting subtest: query-forked
[234.528010] Starting dynamic subtest: pipe-A-HDMI-A-4
[236.905105] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.377s)
[236.920935] Starting dynamic subtest: pipe-D-HDMI-A-4
[239.110043] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.200s)
[239.111546] Subtest query-forked: SUCCESS (4.585s)
[239.313212] [046/131] (794s left) kms_psr (fbc-pr-basic)
[241.296538] Subtest fbc-pr-basic: SKIP (0.000s)
[241.373904] [047/131] (792s left) gem_ctx_persistence (idempotent)
[241.427109] Starting subtest: idempotent
[241.428780] Subtest idempotent: SUCCESS (0.000s)
[241.586278] [048/131] (792s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[243.575377] Starting subtest: flip-vs-cursor-crc-atomic
[244.101359] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.527s)
[244.309694] [049/131] (789s left) kms_properties (invalid-properties-legacy)
[246.318801] Starting subtest: invalid-properties-legacy
[246.660479] Subtest invalid-properties-legacy: SUCCESS (0.339s)
[246.779603] [050/131] (787s left) i915_query (query-topology-kernel-writes)
[246.827205] Starting subtest: query-topology-kernel-writes
[246.828751] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[246.979481] [051/131] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[248.974560] Starting subtest: psr-1p-primscrn-cur-indfb-move
[248.977403] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[249.241600] [052/131] (785s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[251.225652] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[251.226922] Starting dynamic subtest: pipe-A-HDMI-A-4
[251.240145] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[251.250984] Starting dynamic subtest: pipe-B-HDMI-A-4
[251.264750] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[251.275276] Starting dynamic subtest: pipe-C-HDMI-A-4
[251.289575] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[251.300155] Starting dynamic subtest: pipe-D-HDMI-A-4
[251.315857] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[251.319040] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[251.502146] [053/131] (782s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[253.505451] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[253.508831] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[253.727687] [054/131] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[255.721321] Starting subtest: fbcpsr-rgb565-draw-blt
[255.724065] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[255.942981] [055/131] (778s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[257.930447] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[258.003893] [056/131] (776s left) gem_exec_fence (parallel)
[258.218296] Starting subtest: parallel
[258.220248] Starting dynamic subtest: rcs0
[260.371266] Dynamic subtest rcs0: SUCCESS (2.151s)
[260.382277] Starting dynamic subtest: bcs0
[262.523301] Dynamic subtest bcs0: SUCCESS (2.151s)
[262.534492] Starting dynamic subtest: vcs0
[264.679462] Dynamic subtest vcs0: SUCCESS (2.155s)
[264.690571] Starting dynamic subtest: vcs1
[266.836154] Dynamic subtest vcs1: SUCCESS (2.155s)
[266.847302] Starting dynamic subtest: vecs0
[268.991202] Dynamic subtest vecs0: SUCCESS (2.154s)
[268.992927] Subtest parallel: SUCCESS (10.774s)
[269.695753] [057/131] (765s left) i915_pm_rc6_residency (rc6-idle)
[269.742623] Starting subtest: rc6-idle
[269.751309] Starting dynamic subtest: gt0-rcs0
[294.159031] Dynamic subtest gt0-rcs0: SUCCESS (24.407s)
[294.173961] Starting dynamic subtest: gt0-bcs0
[318.470252] Dynamic subtest gt0-bcs0: SUCCESS (24.308s)
[318.488836] Starting dynamic subtest: gt0-vcs0
[342.753772] Dynamic subtest gt0-vcs0: SUCCESS (24.281s)
[342.765647] Starting dynamic subtest: gt0-vecs0
[367.147668] Dynamic subtest gt0-vecs0: SUCCESS (24.392s)
[367.157463] Subtest rc6-idle: SUCCESS (97.411s)
[367.350618] [058/131] (667s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[369.338308] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[369.340036] Starting dynamic subtest: pipe-A-valid-mode
[370.123557] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.782s)
[370.125309] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.784s)
[370.329411] [059/131] (664s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[372.332893] Starting subtest: 4-tiled-16bpp-rotate-180
[372.336121] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[372.580639] [060/131] (662s left) kms_flip (2x-flip-vs-fences-interruptible)
[374.574541] Starting subtest: 2x-flip-vs-fences-interruptible
[374.577750] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[374.814844] [061/131] (660s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[376.801237] Starting subtest: short-flip-after-cursor-toggle
[377.791205] Subtest short-flip-after-cursor-toggle: SUCCESS (0.991s)
[378.000142] [062/131] (657s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[379.995808] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[380.004285] Starting dynamic subtest: A-HDMI-A4
[380.764726] Dynamic subtest A-HDMI-A4: SUCCESS (0.760s)
[380.776356] Starting dynamic subtest: B-HDMI-A4
[381.434046] Dynamic subtest B-HDMI-A4: SUCCESS (0.667s)
[381.445910] Starting dynamic subtest: C-HDMI-A4
[382.111215] Dynamic subtest C-HDMI-A4: SUCCESS (0.675s)
[382.123438] Starting dynamic subtest: D-HDMI-A4
[382.785522] Dynamic subtest D-HDMI-A4: SUCCESS (0.674s)
[382.787129] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.789s)
[383.001185] [063/131] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[385.001048] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[385.004161] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[385.244840] [064/131] (650s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[387.292213] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[387.402346] [065/131] (648s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[389.394702] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[392.203796] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.810s)
[392.459219] [066/131] (643s left) gem_basic (bad-close)
[392.505445] Starting subtest: bad-close
[392.508879] Subtest bad-close: SUCCESS (0.000s)
[392.708681] [067/131] (643s left) gem_exec_schedule (preempt-contexts)
[392.771414] Starting subtest: preempt-contexts
[392.773006] Starting dynamic subtest: rcs0
[392.861207] Dynamic subtest rcs0: SUCCESS (0.089s)
[392.873196] Starting dynamic subtest: bcs0
[392.931674] Dynamic subtest bcs0: SUCCESS (0.069s)
[392.943673] Starting dynamic subtest: vcs0
[393.004168] Dynamic subtest vcs0: SUCCESS (0.071s)
[393.016066] Starting dynamic subtest: vcs1
[393.074310] Dynamic subtest vcs1: SUCCESS (0.069s)
[393.085857] Starting dynamic subtest: vecs0
[393.145372] Dynamic subtest vecs0: SUCCESS (0.070s)
[393.146849] Subtest preempt-contexts: SUCCESS (0.375s)
[393.635764] [068/131] (642s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[395.626807] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[395.630396] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[395.872845] [069/131] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[397.877252] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[397.880708] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[398.116220] [070/131] (638s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[398.187171] Starting subtest: yf-tiled-to-vebox-x-tiled
[398.188568] Starting dynamic subtest: smem
[398.270214] Dynamic subtest smem: SUCCESS (0.082s)
[398.281960] Starting dynamic subtest: lmem0
[399.025234] Dynamic subtest lmem0: SUCCESS (0.750s)
[399.026847] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.835s)
[399.270016] [071/131] (636s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[401.271324] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[402.373505] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.099s)
[402.568628] [072/131] (633s left) kms_pm_rpm (modeset-stress-extra-wait)
[407.030477] Starting subtest: modeset-stress-extra-wait
[459.660809] Subtest modeset-stress-extra-wait: SUCCESS (52.626s)
[459.856981] [073/131] (576s left) syncobj_wait (multi-wait-submitted-signaled)
[459.904359] Starting subtest: multi-wait-submitted-signaled
[459.905709] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[460.058623] [074/131] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[462.052963] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[462.056249] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[462.303554] [075/131] (574s left) gem_exec_whisper (basic-contexts-all)
[462.390183] Starting subtest: basic-contexts-all
[469.089775] Subtest basic-contexts-all: SUCCESS (6.695s)
[469.382572] [076/131] (567s left) gen7_exec_parse (basic-offset)
[469.435451] Subtest basic-offset: SKIP (0.000s)
[469.546263] [077/131] (567s left) perf_pmu (busy-accuracy-98)
[469.597160] Starting subtest: busy-accuracy-98
[469.598663] Starting dynamic subtest: rcs0
[472.644581] Dynamic subtest rcs0: SUCCESS (3.045s)
[472.656770] Starting dynamic subtest: bcs0
[475.689843] Dynamic subtest bcs0: SUCCESS (3.044s)
[475.702428] Starting dynamic subtest: vcs0
[478.738645] Dynamic subtest vcs0: SUCCESS (3.047s)
[478.751178] Starting dynamic subtest: vcs1
[481.787639] Dynamic subtest vcs1: SUCCESS (3.048s)
[481.800149] Starting dynamic subtest: vecs0
[484.832757] Dynamic subtest vecs0: SUCCESS (3.044s)
[484.834382] Subtest busy-accuracy-98: SUCCESS (15.235s)
[485.015634] [078/131] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[487.012482] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[487.015712] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[487.277934] [079/131] (549s left) kms_chamelium_edid (dp-edid-read)
[489.314865] Subtest dp-edid-read: SKIP (0.000s)
[489.423516] [080/131] (547s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[491.451262] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[491.562848] [081/131] (545s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[493.553264] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[493.556174] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[493.742403] [082/131] (543s left) kms_psr (psr2-dpms)
[495.731864] Subtest psr2-dpms: SKIP (0.000s)
[495.806760] [083/131] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[497.800342] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[497.803065] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[498.004978] [084/131] (539s left) gem_basic (create-close)
[498.051188] Starting subtest: create-close
[498.054236] Subtest create-close: SUCCESS (0.000s)
[498.252656] [085/131] (539s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[500.237648] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[500.241635] Starting dynamic subtest: pipe-A-HDMI-A-4
[500.256125] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[500.268274] Starting dynamic subtest: pipe-B-HDMI-A-4
[500.282992] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[500.294769] Starting dynamic subtest: pipe-C-HDMI-A-4
[500.309739] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[500.321453] Starting dynamic subtest: pipe-D-HDMI-A-4
[500.337145] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[500.340253] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[500.514440] [086/131] (537s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[502.513831] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[502.517906] Starting dynamic subtest: pipe-A-HDMI-A-4
[502.533161] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[502.545674] Starting dynamic subtest: pipe-B-HDMI-A-4
[502.560779] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[502.572711] Starting dynamic subtest: pipe-C-HDMI-A-4
[502.588419] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[502.600556] Starting dynamic subtest: pipe-D-HDMI-A-4
[502.616854] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[502.620155] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.013s)
[502.795712] [087/131] (534s left) perf_pmu (render-node-busy-idle)
[502.862702] Starting subtest: render-node-busy-idle
[502.864097] Starting dynamic subtest: rcs0
[503.568498] Dynamic subtest rcs0: SUCCESS (0.706s)
[503.585478] Starting dynamic subtest: bcs0
[504.227510] Dynamic subtest bcs0: SUCCESS (0.657s)
[504.244397] Starting dynamic subtest: vcs0
[504.890121] Dynamic subtest vcs0: SUCCESS (0.660s)
[504.913460] Starting dynamic subtest: vcs1
[505.557128] Dynamic subtest vcs1: SUCCESS (0.660s)
[505.580929] Starting dynamic subtest: vecs0
[506.221227] Dynamic subtest vecs0: SUCCESS (0.657s)
[506.230842] Subtest render-node-busy-idle: SUCCESS (3.362s)
[506.411678] [088/131] (531s left) kms_psr (psr-cursor-plane-onoff)
[508.421436] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[508.497889] [089/131] (529s left) gem_exec_fence (syncobj-wait)
[508.985827] Starting subtest: syncobj-wait
[509.071201] Subtest syncobj-wait: SUCCESS (0.085s)
[509.507566] [090/131] (528s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[511.500877] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[511.503886] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[511.759346] [091/131] (526s left) kms_psr (fbc-psr-cursor-plane-move)
[513.775998] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[513.848721] [092/131] (524s left) gem_mmap_gtt (basic-short)
[513.898787] Subtest basic-short: SKIP (0.000s)
[513.985762] [093/131] (524s left) gem_ctx_engines (execute-one)
[514.043564] Starting subtest: execute-one
[516.343973] Subtest execute-one: SUCCESS (2.300s)
[516.714334] [094/131] (521s left) gem_readwrite (write-bad-handle)
[516.761919] Subtest write-bad-handle: SKIP (0.000s)
[516.852173] [095/131] (521s left) gem_vm_create (invalid-create)
[516.903193] Starting subtest: invalid-create
[516.906781] Subtest invalid-create: SUCCESS (0.002s)
[517.089698] [096/131] (521s left) sysfs_timeslice_duration (duration)
[517.140149] Starting subtest: duration
[517.141729] Starting dynamic subtest: vecs0
[530.266991] Dynamic subtest vecs0: SUCCESS (13.125s)
[530.282216] Starting dynamic subtest: vcs0
[543.428763] Dynamic subtest vcs0: SUCCESS (13.159s)
[543.444867] Starting dynamic subtest: bcs0
[556.573258] Dynamic subtest bcs0: SUCCESS (13.141s)
[556.589045] Starting dynamic subtest: rcs0
[569.712436] Dynamic subtest rcs0: SUCCESS (13.137s)
[569.726141] Starting dynamic subtest: vcs1
[582.859913] Dynamic subtest vcs1: SUCCESS (13.146s)
[582.861528] Subtest duration: SUCCESS (65.722s)
[583.022965] [097/131] (455s left) kms_flip (flip-vs-suspend)
[585.009691] Starting subtest: flip-vs-suspend
[585.016664] Starting dynamic subtest: A-HDMI-A4
[626.806952] Dynamic subtest A-HDMI-A4: SUCCESS (19.340s)
[626.823427] Starting dynamic subtest: B-HDMI-A4
[668.788796] Dynamic subtest B-HDMI-A4: SUCCESS (18.863s)
[668.805355] Starting dynamic subtest: C-HDMI-A4
[710.798759] Dynamic subtest C-HDMI-A4: SUCCESS (18.843s)
[710.817656] Starting dynamic subtest: D-HDMI-A4
[752.815221] Dynamic subtest D-HDMI-A4: SUCCESS (18.889s)
[752.818818] Subtest flip-vs-suspend: SUCCESS (75.951s)
[759.067050] [098/131] (285s left) gem_mmap_gtt (zero-extend)
[759.115132] Subtest zero-extend: SKIP (0.000s)
[759.197658] [099/131] (285s left) perf (invalid-remove-userspace-config)
[759.401855] Starting subtest: invalid-remove-userspace-config
[759.413706] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[759.485288] [100/131] (285s left) sw_sync (sync_multi_consumer_producer)
[759.532812] Starting subtest: sync_multi_consumer_producer
[759.802787] Subtest sync_multi_consumer_producer: SUCCESS (0.268s)
[759.955189] [101/131] (284s left) kms_atomic_interruptible (legacy-cursor)
[761.944101] Starting subtest: legacy-cursor
[761.945589] Starting dynamic subtest: pipe-A-HDMI-A-4
[768.146134] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.200s)
[768.147834] Subtest legacy-cursor: SUCCESS (6.203s)
[768.348824] [102/131] (276s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[770.345949] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[770.349299] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[770.593146] [103/131] (274s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[772.583677] Starting subtest: basic-modeset-with-all-modifiers-formats
[772.787499] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs-XRGB8888
[773.092379] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs-XRGB8888: SUCCESS (0.305s)
[773.106219] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs-XRGB2101010
[773.135399] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs-XRGB2101010: SUCCESS (0.032s)
[773.148723] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs-XRGB16161616F
[773.158864] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs-XRGB16161616F: SUCCESS (0.032s)
[773.172569] Starting dynamic subtest: pipe-A-HDMI-A-4-y-RGB565
[773.342156] Dynamic subtest pipe-A-HDMI-A-4-y-RGB565: SUCCESS (0.182s)
[773.355921] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XRGB8888
[773.375430] Dynamic subtest pipe-A-HDMI-A-4-y-XRGB8888: SUCCESS (0.032s)
[773.392334] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XRGB2101010
[773.408834] Dynamic subtest pipe-A-HDMI-A-4-y-XRGB2101010: SUCCESS (0.032s)
[773.428480] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XRGB16161616F
[773.442287] Dynamic subtest pipe-A-HDMI-A-4-y-XRGB16161616F: SUCCESS (0.032s)
[773.464899] Starting dynamic subtest: pipe-A-HDMI-A-4-y-YUYV
[773.475605] Dynamic subtest pipe-A-HDMI-A-4-y-YUYV: SUCCESS (0.031s)
[773.498287] Starting dynamic subtest: pipe-A-HDMI-A-4-y-Y210
[773.508898] Dynamic subtest pipe-A-HDMI-A-4-y-Y210: SUCCESS (0.031s)
[773.528922] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XYUV8888
[773.542266] Dynamic subtest pipe-A-HDMI-A-4-y-XYUV8888: SUCCESS (0.032s)
[773.558059] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XV30
[773.575509] Dynamic subtest pipe-A-HDMI-A-4-y-XV30: SUCCESS (0.032s)
[773.591387] Starting dynamic subtest: pipe-A-HDMI-A-4-y-XV36
[773.608902] Dynamic subtest pipe-A-HDMI-A-4-y-XV36: SUCCESS (0.032s)
[773.624937] Starting dynamic subtest: pipe-A-HDMI-A-4-x-RGB565
[773.808550] Dynamic subtest pipe-A-HDMI-A-4-x-RGB565: SUCCESS (0.198s)
[773.822583] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XRGB8888
[773.841894] Dynamic subtest pipe-A-HDMI-A-4-x-XRGB8888: SUCCESS (0.032s)
[773.861483] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XRGB2101010
[773.875312] Dynamic subtest pipe-A-HDMI-A-4-x-XRGB2101010: SUCCESS (0.032s)
[773.896211] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XRGB16161616F
[773.908912] Dynamic subtest pipe-A-HDMI-A-4-x-XRGB16161616F: SUCCESS (0.031s)
[773.929464] Starting dynamic subtest: pipe-A-HDMI-A-4-x-YUYV
[773.941885] Dynamic subtest pipe-A-HDMI-A-4-x-YUYV: SUCCESS (0.031s)
[773.958327] Starting dynamic subtest: pipe-A-HDMI-A-4-x-Y210
[773.975251] Dynamic subtest pipe-A-HDMI-A-4-x-Y210: SUCCESS (0.032s)
[773.990278] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XYUV8888
[774.008597] Dynamic subtest pipe-A-HDMI-A-4-x-XYUV8888: SUCCESS (0.032s)
[774.023662] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XV30
[774.041873] Dynamic subtest pipe-A-HDMI-A-4-x-XV30: SUCCESS (0.032s)
[774.056946] Starting dynamic subtest: pipe-A-HDMI-A-4-x-XV36
[774.075530] Dynamic subtest pipe-A-HDMI-A-4-x-XV36: SUCCESS (0.032s)
[774.090240] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-RGB565
[774.259415] Dynamic subtest pipe-A-HDMI-A-4-linear-RGB565: SUCCESS (0.183s)
[774.273133] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XRGB8888
[774.292791] Dynamic subtest pipe-A-HDMI-A-4-linear-XRGB8888: SUCCESS (0.032s)
[774.309488] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XRGB2101010
[774.326124] Dynamic subtest pipe-A-HDMI-A-4-linear-XRGB2101010: SUCCESS (0.032s)
[774.343005] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XRGB16161616F
[774.359439] Dynamic subtest pipe-A-HDMI-A-4-linear-XRGB16161616F: SUCCESS (0.032s)
[774.376404] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-YUYV
[774.392804] Dynamic subtest pipe-A-HDMI-A-4-linear-YUYV: SUCCESS (0.032s)
[774.409911] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-Y210
[774.426101] Dynamic subtest pipe-A-HDMI-A-4-linear-Y210: SUCCESS (0.032s)
[774.443115] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XYUV8888
[774.459480] Dynamic subtest pipe-A-HDMI-A-4-linear-XYUV8888: SUCCESS (0.032s)
[774.476502] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XV30
[774.492864] Dynamic subtest pipe-A-HDMI-A-4-linear-XV30: SUCCESS (0.032s)
[774.509922] Starting dynamic subtest: pipe-A-HDMI-A-4-linear-XV36
[774.526158] Dynamic subtest pipe-A-HDMI-A-4-linear-XV36: SUCCESS (0.032s)
[774.745932] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.163s)
[774.975456] [104/131] (270s left) gem_exec_balancer (bonded-chain)
[775.033842] Starting subtest: bonded-chain
[783.079789] Subtest bonded-chain: SUCCESS (8.043s)
[783.580817] [105/131] (261s left) kms_flip (plain-flip-fb-recreate)
[785.568604] Starting subtest: plain-flip-fb-recreate
[785.574993] Starting dynamic subtest: A-HDMI-A4
[793.616032] Dynamic subtest A-HDMI-A4: SUCCESS (8.040s)
[793.665833] Starting dynamic subtest: B-HDMI-A4
[801.627289] Dynamic subtest B-HDMI-A4: SUCCESS (8.003s)
[801.668608] Starting dynamic subtest: C-HDMI-A4
[809.638093] Dynamic subtest C-HDMI-A4: SUCCESS (8.002s)
[809.682727] Starting dynamic subtest: D-HDMI-A4
[817.632649] Dynamic subtest D-HDMI-A4: SUCCESS (7.986s)
[817.642507] Subtest plain-flip-fb-recreate: SUCCESS (32.069s)
[817.968698] [106/131] (227s left) gem_mmap_offset (clear)
[818.017214] Starting subtest: clear
[818.018834] Starting dynamic subtest: lmem0
[839.583398] Dynamic subtest lmem0: SUCCESS (21.563s)
[839.597413] Starting dynamic subtest: smem0
[865.701872] Dynamic subtest smem0: SUCCESS (26.115s)
[865.704479] Subtest clear: SUCCESS (47.681s)
[866.163755] [107/131] (179s left) gem_mmap (big-bo)
[866.259198] Subtest big-bo: SKIP (0.000s)
[866.333688] [108/131] (179s left) gem_tiled_blits (normal)
[866.426265] Subtest normal: SKIP (0.000s)
[866.499877] [109/131] (179s left) syncobj_timeline (multi-wait-signaled)
[866.558104] Starting subtest: multi-wait-signaled
[866.559626] Subtest multi-wait-signaled: SUCCESS (0.001s)
[866.750193] [110/131] (178s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[866.840922] Starting subtest: y-tiled-to-vebox-x-tiled
[866.842723] Starting dynamic subtest: smem
[866.937220] Dynamic subtest smem: SUCCESS (0.095s)
[866.951181] Starting dynamic subtest: lmem0
[867.692666] Dynamic subtest lmem0: SUCCESS (0.751s)
[867.694655] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.849s)
[867.999224] [111/131] (177s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[872.968332] Starting subtest: dpms-mode-unset-lpsp
[874.153576] Subtest dpms-mode-unset-lpsp: SKIP (1.177s)
[875.468566] [112/131] (170s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[877.479390] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[877.551399] [113/131] (168s left) kms_joiner (basic-force-ultra-joiner)
[879.546142] Starting subtest: basic-force-ultra-joiner
[879.549201] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[879.745450] [114/131] (166s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[881.739701] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[881.742771] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[881.943748] [115/131] (164s left) gem_unfence_active_buffers
[882.179045] [116/131] (164s left) kms_vblank (wait-forked-hang)
[884.165467] Starting subtest: wait-forked-hang
[884.169432] Starting dynamic subtest: pipe-A-HDMI-A-4
[910.326892] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.159s)
[910.346215] Starting dynamic subtest: pipe-D-HDMI-A-4
[935.334834] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.002s)
[935.336514] Subtest wait-forked-hang: SUCCESS (51.169s)
[935.561526] [117/131] (110s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[937.557489] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[937.560114] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[937.776792] [118/131] (108s left) gem_exec_params (sol-reset-invalid)
[937.828333] Starting subtest: sol-reset-invalid
[937.831695] Subtest sol-reset-invalid: SUCCESS (0.002s)
[938.030604] [119/131] (108s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[940.019588] Starting subtest: cursor-vs-flip-toggle
[974.345145] Subtest cursor-vs-flip-toggle: SUCCESS (34.327s)
[974.586167] [120/131] ( 72s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[976.580279] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[976.583270] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[976.821251] [121/131] ( 70s left) gem_exec_schedule (manyslice)
[976.884868] Starting subtest: manyslice
[976.886462] Starting dynamic subtest: rcs0
[981.936294] Dynamic subtest rcs0: SUCCESS (5.048s)
[981.950511] Starting dynamic subtest: bcs0
[987.821082] Dynamic subtest bcs0: SUCCESS (5.883s)
[987.841927] Starting dynamic subtest: vcs0
[993.345523] Dynamic subtest vcs0: SUCCESS (5.523s)
[993.359864] Starting dynamic subtest: vcs1
[998.360575] Dynamic subtest vcs1: SUCCESS (5.014s)
[998.375285] Starting dynamic subtest: vecs0
[1003.376057] Dynamic subtest vecs0: SUCCESS (5.013s)
[1003.377725] Subtest manyslice: SUCCESS (26.492s)
[1003.836405] [122/131] ( 43s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[1005.881675] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[1005.885023] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[1006.122219] [123/131] ( 40s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[1008.116063] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[1008.119286] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[1008.385153] [124/131] ( 38s left) kms_addfb_basic (basic)
[1008.435352] Starting subtest: basic
[1008.436979] Subtest basic: SUCCESS (0.000s)
[1010.629419] [125/131] ( 36s left) i915_suspend (basic-s3-without-i915)
[1010.678138] Starting subtest: basic-s3-without-i915
[1036.271793] Subtest basic-s3-without-i915: SUCCESS (14.613s)
[1038.384263] [126/131] ( 11s left) gem_basic (multigpu-create-close)
[1038.435021] Starting subtest: multigpu-create-close
[1038.437982] Subtest multigpu-create-close: SKIP (0.000s)
[1038.577224] [127/131] ( 10s left) kms_lease (lease-unleased-crtc)
[1040.566998] Starting subtest: lease-unleased-crtc
[1040.568689] Starting dynamic subtest: pipe-A-HDMI-A-4
[1040.646279] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.077s)
[1040.658350] Starting dynamic subtest: pipe-B-HDMI-A-4
[1040.699330] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.045s)
[1040.711014] Starting dynamic subtest: pipe-C-HDMI-A-4
[1040.724389] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.028s)
[1040.736099] Starting dynamic subtest: pipe-D-HDMI-A-4
[1040.754328] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.028s)
[1040.755756] Subtest lease-unleased-crtc: SUCCESS (0.189s)
[1040.921187] [128/131] (  8s left) gem_exec_suspend (basic)
[1040.984049] Starting subtest: basic
[1040.985575] Starting dynamic subtest: smem
[1042.364570] Dynamic subtest smem: SUCCESS (1.380s)
[1042.377321] Starting dynamic subtest: lmem0
[1043.639489] Dynamic subtest lmem0: SUCCESS (1.274s)
[1043.641214] Subtest basic: SUCCESS (2.656s)
[1043.917337] [129/131] (  5s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[1045.910811] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[1045.913958] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[1046.176265] [130/131] (  3s left) gen9_exec_parse (bb-oversize)
[1046.229596] Subtest bb-oversize: SKIP (0.000s)
[1046.312196] [131/131] (  3s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[1048.301632] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[1048.303047] Starting dynamic subtest: pipe-A-valid-mode
[1048.341944] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s)
[1048.344821] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.040s)
[1048.531444] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_b_c_ivb
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_dsc
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: gem_close
results: parsing output: 15/ for test: kms_pipe_crc_basic
results: parsing output: 16/ for test: core_getstats
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: api_intel_allocator
results: parsing output: 19/ for test: gem_exec_await
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: dumb_buffer
results: parsing output: 23/ for test: prime_vgem
results: parsing output: 24/ for test: i915_drm_fdinfo
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_scaling_modes
results: parsing output: 31/ for test: gem_caching
results: parsing output: 32/ for test: gem_ctx_shared
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: kms_cdclk
results: parsing output: 37/ for test: i915_pm_rps
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: drm_read
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_properties
results: parsing output: 49/ for test: i915_query
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: i915_pm_rc6_residency
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_basic
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_basic
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_ctx_engines
results: parsing output: 93/ for test: gem_readwrite
results: parsing output: 94/ for test: gem_vm_create
results: parsing output: 95/ for test: sysfs_timeslice_duration
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: gem_tiled_blits
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_joiner
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_unfence_active_buffers
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: i915_suspend
results: parsing output: 125/ for test: gem_basic
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: gem_exec_suspend
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gen9_exec_parse
results: parsing output: 130/ for test: kms_flip_scaled_crc
Done.