[58.358576] Initializing watchdogs
[58.358625]   /dev/watchdog0
[58.373125] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.377766] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.380255] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.383588] [001/133] (960s left) gem_mmap_gtt (medium-copy-xy)
[58.467455] Subtest medium-copy-XY: SKIP (0.000s)
[58.538676] [002/133] (960s left) kms_plane (pixel-format-yf-tiled-modifier)
[58.645310] Starting subtest: pixel-format-yf-tiled-modifier
[58.649821] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[58.716436] [003/133] (960s left) kms_pm_rpm (pm-caching)
[60.273032] Starting subtest: pm-caching
[60.278402] Subtest pm-caching: SKIP (0.000s)
[61.030876] [004/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[61.129157] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[61.131647] Starting dynamic subtest: pipe-A-eDP-1
[61.153485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[61.163694] Starting dynamic subtest: pipe-B-eDP-1
[61.183105] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[61.190339] Starting dynamic subtest: pipe-C-eDP-1
[61.209844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[61.218826] Starting dynamic subtest: pipe-D-eDP-1
[61.237968] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[61.239854] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.005s)
[63.397566] [005/133] (955s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[63.812815] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[64.604540] [006/133] (954s left) kms_flip (flip-vs-modeset-vs-hang)
[64.693934] Starting subtest: flip-vs-modeset-vs-hang
[64.696511] Starting dynamic subtest: A-eDP1
[115.381531] Dynamic subtest A-eDP1: SUCCESS (50.680s)
[115.390808] Starting dynamic subtest: D-eDP1
[165.364704] Dynamic subtest D-eDP1: SUCCESS (49.985s)
[165.366678] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.670s)
[165.717179] [007/133] (853s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[165.778053] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[165.780570] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[165.864104] [008/133] (853s left) gem_gpgpu_fill (basic)
[165.914524] Starting subtest: basic
[165.916992] Starting dynamic subtest: smem
[165.922227] Dynamic subtest smem: SUCCESS (0.009s)
[165.924683] Subtest basic: SUCCESS (0.009s)
[166.038324] [009/133] (853s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[166.597069] Starting subtest: syncobj-timeline-invalid-flags
[166.599552] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[167.971043] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[167.974135] [010/133] (851s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[168.035697] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[168.142940] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[168.221068] [011/133] (851s left) gem_mmap_wc (fault-concurrent)
[168.293840] Subtest fault-concurrent: SKIP (0.000s)
[168.357912] [012/133] (850s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[168.450216] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[168.461599] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[168.538911] [013/133] (850s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[168.588729] Starting subtest: multi-wait-all-for-submit-unsubmitted
[168.695454] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[168.795930] [014/133] (850s left) kms_cursor_crc (cursor-offscreen-512x512)
[169.085656] Starting subtest: cursor-offscreen-512x512
[169.090114] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[169.270573] [015/133] (850s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[169.324665] Starting subtest: wait-all-for-submit-delayed-submit
[169.429830] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[169.511310] [016/133] (849s left) kms_draw_crc (draw-method-mmap-wc)
[169.609297] Starting subtest: draw-method-mmap-wc
[169.611565] Starting dynamic subtest: xrgb8888-untiled
[169.875694] Dynamic subtest xrgb8888-untiled: SUCCESS (0.268s)
[169.883858] Starting dynamic subtest: rgb565-untiled
[170.086820] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[170.094836] Starting dynamic subtest: xrgb2101010-untiled
[170.308407] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[170.316585] Starting dynamic subtest: xbgr16161616f-untiled
[170.530173] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[170.539870] Starting dynamic subtest: xrgb8888-xtiled
[170.674992] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[170.683906] Starting dynamic subtest: rgb565-xtiled
[170.797233] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[170.806966] Starting dynamic subtest: xrgb2101010-xtiled
[170.919347] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[170.928225] Starting dynamic subtest: xbgr16161616f-xtiled
[171.052494] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[171.061097] Starting dynamic subtest: xrgb8888-4tiled
[171.196967] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[171.204516] Starting dynamic subtest: rgb565-4tiled
[171.341869] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[171.351182] Starting dynamic subtest: xrgb2101010-4tiled
[171.486422] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[171.496530] Starting dynamic subtest: xbgr16161616f-4tiled
[171.674610] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s)
[171.676647] Subtest draw-method-mmap-wc: SUCCESS (2.068s)
[171.771994] [017/133] (847s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[171.875520] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[178.747871] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.874s)
[178.897695] [018/133] (840s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[179.001117] Starting subtest: psr-rgb565-draw-mmap-cpu
[185.879192] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.881s)
[186.003874] [019/133] (833s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[186.101165] Starting subtest: multiplane-rotation-cropping-bottom
[203.514552] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.416s)
[203.618034] [020/133] (816s left) gem_exec_params (secure-non-root)
[203.684463] Starting subtest: secure-non-root
[203.688471] Subtest secure-non-root: SKIP (0.000s)
[203.798043] [021/133] (815s left) gem_exec_schedule (smoketest)
[203.975194] Starting subtest: smoketest
[203.977599] Starting dynamic subtest: rcs0
[209.516214] Dynamic subtest rcs0: SUCCESS (5.494s)
[209.526560] Starting dynamic subtest: bcs0
[215.023084] Dynamic subtest bcs0: SUCCESS (5.505s)
[215.038435] Starting dynamic subtest: vcs0
[220.530302] Dynamic subtest vcs0: SUCCESS (5.503s)
[220.541683] Starting dynamic subtest: vcs1
[226.034583] Dynamic subtest vcs1: SUCCESS (5.506s)
[226.049823] Starting dynamic subtest: vecs0
[231.538205] Dynamic subtest vecs0: SUCCESS (5.504s)
[231.550530] Starting dynamic subtest: ccs0
[237.035556] Dynamic subtest ccs0: SUCCESS (5.496s)
[237.037919] Subtest smoketest: SUCCESS (33.016s)
[237.176756] [022/133] (782s left) kms_psr (fbc-psr-primary-render)
[237.274746] Starting subtest: fbc-psr-primary-render
[237.276932] Starting dynamic subtest: eDP-1
[237.280944] Dynamic subtest eDP-1: SKIP (0.000s)
[237.284940] Subtest fbc-psr-primary-render: SKIP (0.001s)
[237.362297] [023/133] (782s left) kms_pm_dc (dc3co-vpb-simulation)
[238.457841] Starting subtest: dc3co-vpb-simulation
[247.235952] Subtest dc3co-vpb-simulation: SKIP (8.775s)
[247.389666] [024/133] (772s left) gem_exec_whisper (basic-fds-all)
[247.455077] Starting subtest: basic-fds-all
[258.808770] Subtest basic-fds-all: SUCCESS (11.351s)
[259.009823] [025/133] (760s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[259.117691] Starting subtest: fbc-rgb565-draw-blt
[263.289244] Subtest fbc-rgb565-draw-blt: SUCCESS (4.175s)
[264.425296] [026/133] (755s left) prime_vgem (fence-flip-hang)
[264.496125] Subtest fence-flip-hang: SKIP (0.000s)
[264.591956] [027/133] (755s left) gem_pwrite (basic-random)
[264.655929] Subtest basic-random: SKIP (0.000s)
[264.723255] [028/133] (755s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[264.785064] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[264.789521] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[264.970057] [029/133] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[265.076465] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[272.222887] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.151s)
[272.363305] [030/133] (747s left) kms_flip (wf_vblank-ts-check-interruptible)
[272.462822] Starting subtest: wf_vblank-ts-check-interruptible
[272.464653] Starting dynamic subtest: A-eDP1
[281.410490] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[281.421261] Starting dynamic subtest: B-eDP1
[290.343769] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[290.354080] Starting dynamic subtest: C-eDP1
[299.264879] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[299.276339] Starting dynamic subtest: D-eDP1
[308.109511] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[308.111792] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.645s)
[309.344552] [031/133] (710s left) perf (gen12-unprivileged-single-ctx-counters)
[309.469620] Starting subtest: gen12-unprivileged-single-ctx-counters
[309.471926] Starting dynamic subtest: rcs0
[309.541808] Dynamic subtest rcs0: SUCCESS (0.074s)
[309.544191] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.075s)
[309.596180] [032/133] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[309.743477] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[309.747525] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[309.858256] [033/133] (710s left) kms_big_fb (linear-32bpp-rotate-0)
[309.971434] Starting subtest: linear-32bpp-rotate-0
[311.549158] Subtest linear-32bpp-rotate-0: SUCCESS (1.578s)
[311.671309] [034/133] (708s left) gem_exec_async (concurrent-writes)
[311.730765] Starting subtest: concurrent-writes
[311.733041] Starting dynamic subtest: rcs0
[311.746978] Dynamic subtest rcs0: SUCCESS (0.016s)
[311.758619] Starting dynamic subtest: bcs0
[311.760680] Dynamic subtest bcs0: SUCCESS (0.007s)
[311.770960] Starting dynamic subtest: vcs0
[311.772852] Dynamic subtest vcs0: SUCCESS (0.004s)
[311.781224] Starting dynamic subtest: vcs1
[311.783162] Dynamic subtest vcs1: SUCCESS (0.006s)
[311.791217] Starting dynamic subtest: vecs0
[311.793066] Dynamic subtest vecs0: SUCCESS (0.007s)
[311.801153] Starting dynamic subtest: ccs0
[311.803052] Dynamic subtest ccs0: SUCCESS (0.007s)
[311.804928] Subtest concurrent-writes: SUCCESS (0.051s)
[312.018362] [035/133] (708s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[312.122662] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[319.489374] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.374s)
[319.630640] [036/133] (700s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[319.737135] Starting subtest: plane-lut1d-ctm3x4
[319.882594] Starting dynamic subtest: pipe-A-plane-0
[320.061671] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[320.072347] Starting dynamic subtest: pipe-A-plane-1
[320.226834] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[320.236260] Starting dynamic subtest: pipe-A-plane-2
[320.383770] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[321.551363] Starting dynamic subtest: pipe-B-plane-0
[321.745699] Dynamic subtest pipe-B-plane-0: SUCCESS (0.201s)
[321.759834] Starting dynamic subtest: pipe-B-plane-1
[321.921915] Dynamic subtest pipe-B-plane-1: SUCCESS (0.175s)
[321.931197] Starting dynamic subtest: pipe-B-plane-2
[322.066341] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[323.283575] Starting dynamic subtest: pipe-C-plane-0
[323.443360] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[323.454417] Starting dynamic subtest: pipe-C-plane-1
[323.587622] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[323.596917] Starting dynamic subtest: pipe-C-plane-2
[323.732107] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[324.954016] Starting dynamic subtest: pipe-D-plane-0
[325.113346] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[325.122506] Starting dynamic subtest: pipe-D-plane-1
[325.269031] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[325.278704] Starting dynamic subtest: pipe-D-plane-2
[325.424376] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[325.719975] Subtest plane-lut1d-ctm3x4: SUCCESS (5.983s)
[326.517376] [037/133] (693s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[326.616280] Starting subtest: y-tiled-16bpp-rotate-270
[326.620248] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[326.713356] [038/133] (693s left) kms_properties (plane-properties-legacy)
[326.818780] Starting subtest: plane-properties-legacy
[326.821092] Starting dynamic subtest: pipe-A-eDP-1
[327.381429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[327.391023] Starting dynamic subtest: pipe-B-eDP-1
[328.702505] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s)
[328.711836] Starting dynamic subtest: pipe-C-eDP-1
[329.937651] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[329.947799] Starting dynamic subtest: pipe-D-eDP-1
[331.176064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[331.178504] Subtest plane-properties-legacy: SUCCESS (4.358s)
[331.975981] [039/133] (688s left) gem_exec_reloc (basic-write-read-noreloc)
[332.044049] Subtest basic-write-read-noreloc: SKIP (0.000s)
[332.120518] [040/133] (688s left) sw_sync (sync_multi_timeline_wait)
[332.163235] Starting subtest: sync_multi_timeline_wait
[332.165610] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[332.216849] [041/133] (688s left) kms_plane_scaling (planes-upscale-20x20)
[332.308130] Starting subtest: planes-upscale-20x20
[332.310402] Starting dynamic subtest: pipe-A
[332.367821] Dynamic subtest pipe-A: SUCCESS (0.062s)
[332.378615] Starting dynamic subtest: pipe-B
[333.494995] Dynamic subtest pipe-B: SUCCESS (1.126s)
[333.506099] Starting dynamic subtest: pipe-C
[334.597700] Dynamic subtest pipe-C: SUCCESS (1.102s)
[334.606897] Starting dynamic subtest: pipe-D
[335.726270] Dynamic subtest pipe-D: SUCCESS (1.128s)
[335.728691] Subtest planes-upscale-20x20: SUCCESS (3.421s)
[336.883938] [042/133] (683s left) perf_pmu (busy-idle-check-all)
[336.925378] Starting subtest: busy-idle-check-all
[336.927706] Starting dynamic subtest: rcs0
[337.575611] Dynamic subtest rcs0: SUCCESS (0.651s)
[337.587340] Starting dynamic subtest: bcs0
[338.226683] Dynamic subtest bcs0: SUCCESS (0.649s)
[338.238528] Starting dynamic subtest: vcs0
[339.931314] Dynamic subtest vcs0: SUCCESS (1.700s)
[339.945190] Starting dynamic subtest: vcs1
[341.914562] Dynamic subtest vcs1: SUCCESS (1.980s)
[341.926993] Starting dynamic subtest: vecs0
[343.899355] Dynamic subtest vecs0: SUCCESS (1.982s)
[343.913054] Starting dynamic subtest: ccs0
[344.556199] Dynamic subtest ccs0: SUCCESS (0.655s)
[344.558711] Subtest busy-idle-check-all: SUCCESS (7.633s)
[344.677032] [043/133] (675s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[344.781823] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[344.786209] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[344.878521] [044/133] (675s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[345.077886] Starting subtest: cursor-rapid-movement-128x128
[345.080258] Starting dynamic subtest: pipe-A-eDP-1
[345.635790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[345.665969] Starting dynamic subtest: pipe-D-eDP-1
[346.802577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[346.804982] Subtest cursor-rapid-movement-128x128: SUCCESS (1.726s)
[347.666888] [045/133] (673s left) sw_sync (timeline_closed_signaled)
[347.706081] Starting subtest: timeline_closed_signaled
[347.708242] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[347.763746] [046/133] (673s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[347.864997] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[347.869268] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[347.959456] [047/133] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[348.067966] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[348.072166] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[348.184773] [048/133] (672s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[348.297155] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[348.301536] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[348.380534] [049/133] (672s left) kms_psr (psr-cursor-plane-move)
[348.476055] Starting subtest: psr-cursor-plane-move
[348.478237] Starting dynamic subtest: eDP-1
[350.168463] Dynamic subtest eDP-1: SUCCESS (1.691s)
[350.170701] Subtest psr-cursor-plane-move: SUCCESS (1.693s)
[351.039208] [050/133] (669s left) gem_exec_schedule (pi-distinct-iova)
[351.218161] Starting subtest: pi-distinct-iova
[351.220429] Starting dynamic subtest: rcs0
[351.295205] Dynamic subtest rcs0: SUCCESS (0.079s)
[351.307214] Starting dynamic subtest: vcs0
[351.356730] Dynamic subtest vcs0: SUCCESS (0.061s)
[351.367077] Starting dynamic subtest: vcs1
[351.416448] Dynamic subtest vcs1: SUCCESS (0.059s)
[351.426481] Starting dynamic subtest: vecs0
[351.479284] Dynamic subtest vecs0: SUCCESS (0.062s)
[351.491838] Starting dynamic subtest: ccs0
[351.542833] Dynamic subtest ccs0: SUCCESS (0.062s)
[351.545662] Subtest pi-distinct-iova: SUCCESS (0.327s)
[353.019469] [051/133] (667s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[353.408628] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[354.231950] [052/133] (666s left) i915_drm_fdinfo (busy-check-all)
[354.275056] Starting subtest: busy-check-all
[354.277261] Starting dynamic subtest: rcs0
[354.281869] Dynamic subtest rcs0: SKIP (0.005s)
[354.291510] Starting dynamic subtest: bcs0
[354.295440] Dynamic subtest bcs0: SKIP (0.000s)
[354.303787] Starting dynamic subtest: vcs0
[354.308112] Dynamic subtest vcs0: SKIP (0.000s)
[354.316326] Starting dynamic subtest: vcs1
[354.320620] Dynamic subtest vcs1: SKIP (0.000s)
[354.328785] Starting dynamic subtest: vecs0
[354.333044] Dynamic subtest vecs0: SKIP (0.000s)
[354.341378] Starting dynamic subtest: ccs0
[354.345679] Dynamic subtest ccs0: SKIP (0.000s)
[354.349938] Subtest busy-check-all: SKIP (0.010s)
[354.389182] [053/133] (666s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[354.515987] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[354.520095] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[354.602559] [054/133] (666s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[354.666864] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[354.671591] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[354.852446] [055/133] (666s left) gem_linear_blits (basic)
[355.344986] Starting subtest: basic
[355.353373] Subtest basic: SUCCESS (0.009s)
[355.505443] [056/133] (665s left) gem_wait (invalid-flags)
[355.601966] Starting subtest: invalid-flags
[355.604522] Subtest invalid-flags: SUCCESS (0.000s)
[355.807761] [057/133] (665s left) gem_exec_balancer (parallel-out-fence)
[356.069672] Starting subtest: parallel-out-fence
[357.211067] Subtest parallel-out-fence: SUCCESS (1.141s)
[357.292727] [058/133] (663s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[357.361818] Subtest writes-after-reads: SKIP (0.000s)
[357.426516] [059/133] (663s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[357.540087] Starting subtest: cursorB-vs-flipB-toggle
[357.544596] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[357.685042] [060/133] (663s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[357.750732] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[357.810965] [061/133] (663s left) gem_softpin (allocator-nopin)
[357.863553] Starting subtest: allocator-nopin
[357.952149] Subtest allocator-nopin: SUCCESS (0.088s)
[358.076773] [062/133] (663s left) gen7_exec_parse (batch-without-end)
[358.154316] Subtest batch-without-end: SKIP (0.000s)
[358.218734] [063/133] (663s left) kms_flip (flip-vs-suspend)
[358.309769] Starting subtest: flip-vs-suspend
[358.311903] Starting dynamic subtest: A-eDP1
[407.538499] Dynamic subtest A-eDP1: SUCCESS (4.734s)
[407.557557] Starting dynamic subtest: B-eDP1
[456.524716] Dynamic subtest B-eDP1: SUCCESS (4.437s)
[456.537674] Starting dynamic subtest: C-eDP1
[505.553007] Dynamic subtest C-eDP1: SUCCESS (4.502s)
[505.565973] Starting dynamic subtest: D-eDP1
[554.592005] Dynamic subtest D-eDP1: SUCCESS (4.642s)
[554.596948] Subtest flip-vs-suspend: SUCCESS (18.323s)
[555.768071] [064/133] (465s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[555.873844] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[555.876655] Starting dynamic subtest: pipe-A-eDP-1
[555.905339] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.916560] Starting dynamic subtest: pipe-B-eDP-1
[555.944625] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.954534] Starting dynamic subtest: pipe-C-eDP-1
[555.982876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[555.996697] Starting dynamic subtest: pipe-D-eDP-1
[556.026127] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.031239] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[558.136419] [065/133] (463s left) gem_ctx_engines (invalid-engines)
[558.191958] Starting subtest: invalid-engines
[558.200857] Subtest invalid-engines: SUCCESS (0.009s)
[558.423170] [066/133] (463s left) kms_atomic_transition (plane-toggle-modeset-transition)
[558.515376] Starting subtest: plane-toggle-modeset-transition
[558.518165] Starting dynamic subtest: pipe-A-eDP-1
[571.256699] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.732s)
[571.269252] Starting dynamic subtest: pipe-B-eDP-1
[583.732666] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.466s)
[583.736011] Subtest plane-toggle-modeset-transition: SUCCESS (25.204s)
[584.543897] [067/133] (437s left) kms_psr (fbc-pr-sprite-plane-onoff)
[584.650723] Starting subtest: fbc-pr-sprite-plane-onoff
[584.656207] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[584.722840] [068/133] (436s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[584.814594] Starting subtest: fbcpsr-rgb565-draw-pwrite
[591.866474] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.050s)
[591.980584] [069/133] (429s left) gem_ccs (ctrl-surf-copy)
[592.036251] Starting subtest: ctrl-surf-copy
[592.041249] Subtest ctrl-surf-copy: SKIP (0.000s)
[592.150619] [070/133] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[592.255513] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[592.260719] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[592.342914] [071/133] (429s left) prime_vgem (fence-write-hang)
[592.415546] Subtest fence-write-hang: SKIP (0.000s)
[592.521559] [072/133] (429s left) syncobj_timeline (invalid-signal-zero-handles)
[592.579864] Starting subtest: invalid-signal-zero-handles
[592.582579] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[592.679676] [073/133] (429s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[592.770535] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[592.775549] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[592.851209] [074/133] (429s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[592.941947] Starting subtest: psr-2p-pri-indfb-multidraw
[592.945480] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[593.026038] [075/133] (428s left) kms_pipe_crc_basic (suspend-read-crc)
[593.124012] Starting subtest: suspend-read-crc
[593.126315] Starting dynamic subtest: pipe-A-eDP-1
[610.440790] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s)
[610.452250] Starting dynamic subtest: pipe-B-eDP-1
[628.460281] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.143s)
[628.472520] Starting dynamic subtest: pipe-C-eDP-1
[646.404588] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.129s)
[646.416282] Starting dynamic subtest: pipe-D-eDP-1
[664.415412] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.088s)
[664.417953] Subtest suspend-read-crc: SUCCESS (11.903s)
[665.250933] [076/133] (356s left) dumb_buffer (invalid-bpp)
[665.317706] Starting subtest: invalid-bpp
[665.320095] Subtest invalid-bpp: SUCCESS (0.000s)
[665.427950] [077/133] (356s left) kms_plane (plane-position-hole-dpms)
[665.530477] Starting subtest: plane-position-hole-dpms
[666.032730] Starting dynamic subtest: pipe-A-plane-1
[668.450471] Dynamic subtest pipe-A-plane-1: SUCCESS (2.417s)
[668.462223] Starting dynamic subtest: pipe-A-plane-2
[670.844558] Dynamic subtest pipe-A-plane-2: SUCCESS (2.391s)
[670.856468] Starting dynamic subtest: pipe-A-plane-3
[673.260189] Dynamic subtest pipe-A-plane-3: SUCCESS (2.413s)
[673.270274] Starting dynamic subtest: pipe-A-plane-4
[675.623421] Dynamic subtest pipe-A-plane-4: SUCCESS (2.358s)
[675.634329] Starting dynamic subtest: pipe-A-plane-5
[675.646671] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[676.785991] Starting dynamic subtest: pipe-B-plane-1
[679.210158] Dynamic subtest pipe-B-plane-1: SUCCESS (2.431s)
[679.220835] Starting dynamic subtest: pipe-B-plane-2
[681.597582] Dynamic subtest pipe-B-plane-2: SUCCESS (2.383s)
[681.608060] Starting dynamic subtest: pipe-B-plane-3
[683.971351] Dynamic subtest pipe-B-plane-3: SUCCESS (2.372s)
[683.981990] Starting dynamic subtest: pipe-B-plane-4
[686.399802] Dynamic subtest pipe-B-plane-4: SUCCESS (2.428s)
[686.421142] Starting dynamic subtest: pipe-B-plane-5
[686.430675] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[686.432873] Subtest plane-position-hole-dpms: SUCCESS (20.883s)
[687.208559] [078/133] (334s left) gem_exec_create (madvise)
[687.273028] Starting subtest: madvise
[687.275227] Starting dynamic subtest: smem
[709.278985] Dynamic subtest smem: SUCCESS (21.992s)
[709.281926] Subtest madvise: SUCCESS (21.993s)
[710.591161] [079/133] (311s left) i915_module_load (reload-no-display)
[710.628844] Starting subtest: reload-no-display
[716.605749] Subtest reload-no-display: SUCCESS (5.976s)
[716.635072] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[716.635813] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[716.639330] [080/133] (305s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[718.235449] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[718.238332] Starting dynamic subtest: pipe-A-eDP-1
[718.367756] Dynamic subtest pipe-A-eDP-1: SKIP (0.136s)
[718.385994] Starting dynamic subtest: pipe-B-eDP-1
[719.528751] Dynamic subtest pipe-B-eDP-1: SKIP (1.157s)
[719.533186] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.296s)
[720.755310] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[720.756571] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)] new: kernel.kmod_is_loaded.i915: true
[720.760299] [081/133] (301s left) prime_vgem (coherency-blt)
[720.849155] Starting subtest: coherency-blt
[721.959190] Subtest coherency-blt: SUCCESS (1.108s)
[722.081042] [082/133] (300s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[722.190950] Starting subtest: x-tiled-64bpp-rotate-180
[723.826842] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.637s)
[723.984740] [083/133] (298s left) gem_exec_balancer (indices)
[724.048720] Starting subtest: indices
[726.199995] Subtest indices: SUCCESS (2.148s)
[726.512526] [084/133] (295s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[726.611099] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[726.613425] Starting dynamic subtest: pipe-A-eDP-1
[727.101861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[727.112145] Starting dynamic subtest: pipe-B-eDP-1
[728.593794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s)
[728.607835] Starting dynamic subtest: pipe-C-eDP-1
[730.050797] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.457s)
[730.060809] Starting dynamic subtest: pipe-D-eDP-1
[731.484722] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[731.486827] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.853s)
[732.678681] [085/133] (289s left) kms_sequence (queue-idle)
[732.787556] Starting subtest: queue-idle
[732.789633] Starting dynamic subtest: pipe-A-eDP-1
[734.601174] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[734.612857] Starting dynamic subtest: pipe-B-eDP-1
[737.039098] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s)
[737.049337] Starting dynamic subtest: pipe-C-eDP-1
[739.448992] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.407s)
[739.462211] Starting dynamic subtest: pipe-D-eDP-1
[741.882773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[741.885215] Subtest queue-idle: SUCCESS (9.099s)
[742.687375] [086/133] (279s left) api_intel_bb (simple-bb)
[742.738783] Starting subtest: simple-bb
[742.740833] Subtest simple-bb: SUCCESS (0.005s)
[742.857954] [087/133] (279s left) gem_watchdog (default-physical)
[742.924738] Starting subtest: default-physical
[744.681374] Subtest default-physical: SUCCESS (1.767s)
[744.776020] [088/133] (277s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[744.883319] Starting subtest: fbc-pr-cursor-mmap-cpu
[744.887804] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[744.971364] [089/133] (277s left) kms_cursor_crc (cursor-sliding-256x85)
[745.230171] Starting subtest: cursor-sliding-256x85
[745.281866] Subtest cursor-sliding-256x85: SKIP (0.047s)
[745.456054] [090/133] (277s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[745.558753] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[746.548478] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.988s)
[746.686273] [091/133] (276s left) kms_lease (lease-again)
[746.783644] Starting subtest: lease-again
[746.785452] Starting dynamic subtest: pipe-A-eDP-1
[746.787371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[746.797026] Starting dynamic subtest: pipe-B-eDP-1
[746.798645] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[746.807406] Starting dynamic subtest: pipe-C-eDP-1
[746.808958] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[746.817920] Starting dynamic subtest: pipe-D-eDP-1
[746.819544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[746.821173] Subtest lease-again: SUCCESS (0.014s)
[746.912944] [092/133] (275s left) kms_prop_blob (invalid-get-prop)
[746.967759] Starting subtest: invalid-get-prop
[746.970030] Subtest invalid-get-prop: SUCCESS (0.000s)
[747.085191] [093/133] (275s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[747.179902] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[747.183300] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[747.276437] [094/133] (275s left) gem_mmap_gtt (hang-busy)
[747.337967] Subtest hang-busy: SKIP (0.000s)
[747.417970] [095/133] (275s left) kms_flip (2x-modeset-vs-vblank-race)
[747.515576] Starting subtest: 2x-modeset-vs-vblank-race
[747.527239] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[747.636269] [096/133] (275s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[747.734602] Starting subtest: 4-tiled-64bpp-rotate-0
[749.191677] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.456s)
[749.381391] [097/133] (273s left) kms_addfb_basic (basic)
[749.436493] Starting subtest: basic
[749.438815] Subtest basic: SUCCESS (0.000s)
[749.574480] [098/133] (273s left) gem_reg_read (timestamp-monotonic)
[749.637743] Starting subtest: timestamp-monotonic
[753.955404] Subtest timestamp-monotonic: SUCCESS (4.317s)
[754.031588] [099/133] (269s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[754.132163] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[754.136631] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[754.218436] [100/133] (268s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[754.308451] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[754.310738] Starting dynamic subtest: pipe-A-eDP-1
[754.332833] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[754.344921] Starting dynamic subtest: pipe-B-eDP-1
[754.365292] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[754.374573] Starting dynamic subtest: pipe-C-eDP-1
[754.395555] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[754.404371] Starting dynamic subtest: pipe-D-eDP-1
[754.425854] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[754.430240] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[756.472285] [101/133] (266s left) kms_properties (invalid-properties-legacy)
[756.571285] Starting subtest: invalid-properties-legacy
[756.679142] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[756.765377] [102/133] (266s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[756.824997] Starting subtest: multi-wait-available-unsubmitted-submitted
[756.827483] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[756.942238] [103/133] (266s left) kms_properties (crtc-properties-atomic)
[757.041412] Starting subtest: crtc-properties-atomic
[757.043726] Starting dynamic subtest: pipe-A-eDP-1
[757.486366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[757.499160] Starting dynamic subtest: pipe-B-eDP-1
[758.646219] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[758.656438] Starting dynamic subtest: pipe-C-eDP-1
[759.775756] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[759.787148] Starting dynamic subtest: pipe-D-eDP-1
[760.909182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[760.911676] Subtest crtc-properties-atomic: SUCCESS (3.870s)
[761.718591] [104/133] (261s left) i915_pm_rps (min-max-config-idle)
[761.780934] Starting subtest: min-max-config-idle
[761.785655] Subtest min-max-config-idle: SKIP (0.001s)
[761.889500] [105/133] (261s left) gem_softpin (evict-active-interruptible)
[761.962278] Starting subtest: evict-active-interruptible
[761.964245] Subtest evict-active-interruptible: SUCCESS (0.005s)
[762.098531] [106/133] (261s left) gem_exec_schedule (fairslice)
[762.177103] Starting subtest: fairslice
[762.179040] Starting dynamic subtest: rcs0
[764.189307] Dynamic subtest rcs0: SUCCESS (2.018s)
[764.199964] Starting dynamic subtest: bcs0
[766.204952] Dynamic subtest bcs0: SUCCESS (2.016s)
[766.217734] Starting dynamic subtest: vcs0
[768.227512] Dynamic subtest vcs0: SUCCESS (2.019s)
[768.237734] Starting dynamic subtest: vcs1
[770.247401] Dynamic subtest vcs1: SUCCESS (2.020s)
[770.259752] Starting dynamic subtest: vecs0
[772.268150] Dynamic subtest vecs0: SUCCESS (2.019s)
[772.278944] Starting dynamic subtest: ccs0
[774.286383] Dynamic subtest ccs0: SUCCESS (2.018s)
[774.288329] Subtest fairslice: SUCCESS (12.117s)
[774.603241] [107/133] (248s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[774.704176] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[774.706426] Starting dynamic subtest: pipe-A-eDP-1
[776.885324] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.181s)
[776.895950] Starting dynamic subtest: pipe-B-eDP-1
[779.156808] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.272s)
[779.169017] Starting dynamic subtest: pipe-C-eDP-1
[781.215603] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.056s)
[781.226163] Starting dynamic subtest: pipe-D-eDP-1
[783.377550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s)
[783.379607] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.676s)
[784.544021] [108/133] (238s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[784.642823] Starting subtest: addfb25-y-tiled-legacy
[784.645148] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[784.729564] [109/133] (238s left) kms_psr (fbc-psr-suspend)
[784.826543] Starting subtest: fbc-psr-suspend
[784.828550] Starting dynamic subtest: eDP-1
[784.832707] Dynamic subtest eDP-1: SKIP (0.000s)
[784.836884] Subtest fbc-psr-suspend: SKIP (0.001s)
[784.903455] [110/133] (238s left) gem_ctx_persistence (legacy-engines-persistence)
[784.964721] Starting subtest: legacy-engines-persistence
[784.967160] Starting dynamic subtest: render
[785.756283] Dynamic subtest render: SUCCESS (0.790s)
[785.772095] Starting dynamic subtest: bsd1
[786.526071] Dynamic subtest bsd1: SUCCESS (0.766s)
[786.539853] Starting dynamic subtest: bsd2
[787.284999] Dynamic subtest bsd2: SUCCESS (0.756s)
[787.299876] Starting dynamic subtest: blt
[788.055220] Dynamic subtest blt: SUCCESS (0.767s)
[788.068067] Starting dynamic subtest: vebox
[788.803318] Dynamic subtest vebox: SUCCESS (0.745s)
[788.805965] Subtest legacy-engines-persistence: SUCCESS (3.839s)
[788.933458] [111/133] (234s left) i915_suspend (basic-s2idle-without-i915)
[788.975362] Starting subtest: basic-s2idle-without-i915
[810.726162] Subtest basic-s2idle-without-i915: SUCCESS (6.311s)
[810.870389] [112/133] (212s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[810.981433] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[810.986684] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[811.083681] [113/133] (212s left) syncobj_basic (create-signaled)
[811.145166] Starting subtest: create-signaled
[811.147742] Subtest create-signaled: SUCCESS (0.000s)
[811.253415] [114/133] (212s left) gem_exec_params (cliprects-invalid)
[811.313475] Starting subtest: cliprects-invalid
[811.316432] Subtest cliprects-invalid: SUCCESS (0.000s)
[811.417971] [115/133] (212s left) kms_invalid_mode (overflow-vrefresh)
[811.520121] Starting subtest: overflow-vrefresh
[811.522801] Starting dynamic subtest: pipe-A-eDP-1
[811.822131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.306s)
[811.831938] Starting dynamic subtest: pipe-B-eDP-1
[811.834296] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[811.843430] Starting dynamic subtest: pipe-C-eDP-1
[811.846281] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[811.855236] Starting dynamic subtest: pipe-D-eDP-1
[811.857662] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[811.859990] Subtest overflow-vrefresh: SUCCESS (0.312s)
[812.637761] [116/133] (211s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[812.768049] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[812.772861] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[812.912801] [117/133] (210s left) sysfs_timeslice_duration (invalid)
[812.969935] Starting subtest: invalid
[812.972853] Starting dynamic subtest: vecs0
[812.975727] Dynamic subtest vecs0: SUCCESS (0.000s)
[812.985013] Starting dynamic subtest: ccs0
[812.986991] Dynamic subtest ccs0: SUCCESS (0.000s)
[812.996105] Starting dynamic subtest: vcs0
[812.998327] Dynamic subtest vcs0: SUCCESS (0.000s)
[813.007141] Starting dynamic subtest: bcs0
[813.009401] Dynamic subtest bcs0: SUCCESS (0.000s)
[813.018293] Starting dynamic subtest: rcs0
[813.020805] Dynamic subtest rcs0: SUCCESS (0.000s)
[813.029809] Starting dynamic subtest: vcs1
[813.032073] Dynamic subtest vcs1: SUCCESS (0.000s)
[813.034399] Subtest invalid: SUCCESS (0.006s)
[813.092733] [118/133] (210s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[813.201898] Starting subtest: cursorA-vs-flipA-varying-size
[824.395281] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.189s)
[825.252078] [119/133] (198s left) kms_async_flips (crc-atomic)
[825.353289] Starting subtest: crc-atomic
[825.740735] Starting dynamic subtest: pipe-A-eDP-1
[828.685247] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.941s)
[829.068950] Starting dynamic subtest: pipe-B-eDP-1
[831.939402] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.881s)
[832.334703] Starting dynamic subtest: pipe-C-eDP-1
[835.250449] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.927s)
[835.621303] Starting dynamic subtest: pipe-D-eDP-1
[838.481339] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[838.484206] Subtest crc-atomic: SUCCESS (13.129s)
[839.653971] [120/133] (184s left) gem_ctx_exec (basic-norecovery)
[839.729441] Starting subtest: basic-norecovery
[839.961422] Subtest basic-norecovery: SUCCESS (0.232s)
[840.079791] [121/133] (183s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[840.187422] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[843.974773] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.792s)
[845.162146] [122/133] (178s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[845.264648] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[845.269651] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[845.368671] [123/133] (178s left) syncobj_eventfd (timeline-wait-before-signal)
[845.433456] Starting subtest: timeline-wait-before-signal
[845.461103] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[845.538512] [124/133] (178s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[845.633224] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[845.638270] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[845.740030] [125/133] (178s left) gem_ctx_param (root-set)
[845.795440] Starting subtest: root-set
[845.798355] Subtest root-set: SUCCESS (0.001s)
[845.893505] [126/133] (178s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[845.993810] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[852.741978] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.749s)
[852.876981] [127/133] (171s left) gem_eio (hibernate)
[853.030619] Starting subtest: hibernate
[868.299409] Subtest hibernate: SUCCESS (15.266s)
[876.459047] [128/133] (155s left) kms_content_protection (dp-mst-lic-type-0)
[876.636274] Starting subtest: dp-mst-lic-type-0
[876.641979] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[876.759077] [129/133] (155s left) gem_exec_reloc (basic-write-cpu-noreloc)
[876.823267] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[876.900921] [130/133] (155s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[876.951235] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[876.953406] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[877.068810] [131/133] (155s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[877.166398] Starting subtest: fbc-dirtyfb-ioctl
[877.169186] Starting dynamic subtest: A-eDP-1
[879.804454] Dynamic subtest A-eDP-1: SUCCESS (2.639s)
[879.807714] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.640s)
[880.691813] [132/133] (151s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[880.786861] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[880.791795] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[880.874776] [133/133] (151s left) kms_vblank (query-forked-busy-hang)
[880.967460] Starting subtest: query-forked-busy-hang
[880.970227] Starting dynamic subtest: pipe-A-eDP-1
[907.443413] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.475s)
[907.461175] Starting dynamic subtest: pipe-D-eDP-1
[922.421198] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[922.423452] Subtest query-forked-busy-hang: SUCCESS (41.453s)
[923.265452] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_chamelium_frames
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_gpgpu_fill
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_draw_crc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_pm_dc
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: prime_vgem
results: parsing output: 26/ for test: gem_pwrite
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_async
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_color_pipeline
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: i915_drm_fdinfo
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: gem_linear_blits
results: parsing output: 55/ for test: gem_wait
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_ctx_engines
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: dumb_buffer
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: i915_module_load
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_sequence
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: gem_watchdog
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_prop_blob
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_reg_read
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: i915_suspend
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: sysfs_timeslice_duration
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_eventfd
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_content_protection
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_dirtyfb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_vblank
Done.