[55.196222] Initializing watchdogs
[55.196267]   /dev/watchdog0
[55.209178] [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]
[55.213784] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.215982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.219292] [001/131] (960s left) kms_psr (fbc-psr-primary-mmap-gtt)
[55.338590] Starting subtest: fbc-psr-primary-mmap-gtt
[55.340731] Starting dynamic subtest: eDP-1
[55.345134] Dynamic subtest eDP-1: SKIP (0.000s)
[55.349408] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[55.427852] [002/131] (960s left) perf (gen12-group-exclusive-stream-sample-oa)
[55.555781] Starting subtest: gen12-group-exclusive-stream-sample-oa
[55.573255] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[55.608573] [003/131] (960s left) gem_exec_params (cliprects-invalid)
[55.674534] Starting subtest: cliprects-invalid
[55.676687] Subtest cliprects-invalid: SUCCESS (0.000s)
[55.793335] [004/131] (960s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[55.893900] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[55.990632] [005/131] (959s left) i915_pm_rpm (gem-pread)
[58.024969] Starting subtest: gem-pread
[60.051936] Subtest gem-pread: SUCCESS (2.050s)
[60.162187] [006/131] (955s left) vgem_basic (bad-handle)
[60.225731] Starting subtest: bad-handle
[60.227935] Subtest bad-handle: SUCCESS (0.000s)
[60.302232] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[60.305098] [007/131] (955s left) kms_cursor_crc (cursor-suspend)
[60.438715] Starting subtest: cursor-suspend
[60.440612] Starting dynamic subtest: pipe-A-eDP-1
[92.940162] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.187s)
[92.950198] Starting dynamic subtest: pipe-D-eDP-1
[125.921440] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.637s)
[125.923600] Subtest cursor-suspend: SUCCESS (6.826s)
[126.724304] [008/131] (889s left) vgem_basic (sysfs)
[126.772089] Starting subtest: sysfs
[126.774021] Subtest sysfs: SUCCESS (0.000s)
[126.836956] [009/131] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[126.935141] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[126.939457] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[127.054034] [010/131] (888s left) kms_lease (lease-uevent)
[127.144790] Starting subtest: lease-uevent
[128.153225] Subtest lease-uevent: SUCCESS (1.035s)
[128.243766] [011/131] (887s left) sw_sync (timeline_closed)
[128.278048] Starting subtest: timeline_closed
[128.280320] Subtest timeline_closed: SUCCESS (0.000s)
[128.354403] [012/131] (887s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[128.439858] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[128.442204] Starting dynamic subtest: pipe-A-eDP-1
[128.462945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[128.472490] Starting dynamic subtest: pipe-B-eDP-1
[128.491678] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[128.498678] Starting dynamic subtest: pipe-C-eDP-1
[128.517490] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[128.524437] Starting dynamic subtest: pipe-D-eDP-1
[128.543529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[128.545425] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[130.647865] [013/131] (885s left) kms_async_flips (invalid-async-flip-atomic)
[130.797518] Starting subtest: invalid-async-flip-atomic
[131.174698] Starting dynamic subtest: pipe-A-eDP-1
[132.012896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[132.374965] Starting dynamic subtest: pipe-B-eDP-1
[133.145003] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[133.499705] Starting dynamic subtest: pipe-C-eDP-1
[134.254059] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[134.604397] Starting dynamic subtest: pipe-D-eDP-1
[135.360851] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[135.363126] Subtest invalid-async-flip-atomic: SUCCESS (4.624s)
[136.521358] [014/131] (879s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[136.701322] Starting subtest: cursor-rapid-movement-64x64
[136.703717] Starting dynamic subtest: pipe-A-eDP-1
[137.240162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[137.264711] Starting dynamic subtest: pipe-D-eDP-1
[138.414120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[138.416211] Subtest cursor-rapid-movement-64x64: SUCCESS (1.727s)
[139.267914] [015/131] (876s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[139.331172] Starting subtest: single-wait-for-submit-unsubmitted
[139.440445] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[139.526396] [016/131] (876s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[139.609853] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[139.612175] Starting dynamic subtest: pipe-A
[140.729709] Dynamic subtest pipe-A: SUCCESS (1.129s)
[140.738118] Starting dynamic subtest: pipe-B
[142.895434] Dynamic subtest pipe-B: SUCCESS (2.175s)
[142.903871] Starting dynamic subtest: pipe-C
[144.043994] Dynamic subtest pipe-C: SUCCESS (1.152s)
[144.053498] Starting dynamic subtest: pipe-D
[145.187157] Dynamic subtest pipe-D: SUCCESS (1.146s)
[145.189512] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.604s)
[146.387513] [017/131] (869s left) perf_pmu (most-busy-check-all)
[146.426391] Starting subtest: most-busy-check-all
[146.428843] Starting dynamic subtest: rcs0
[147.699799] Dynamic subtest rcs0: SUCCESS (1.275s)
[147.710324] Starting dynamic subtest: bcs0
[149.686327] Dynamic subtest bcs0: SUCCESS (1.987s)
[149.696932] Starting dynamic subtest: vcs0
[151.668821] Dynamic subtest vcs0: SUCCESS (1.986s)
[151.679120] Starting dynamic subtest: vcs1
[153.716939] Dynamic subtest vcs1: SUCCESS (2.049s)
[153.727891] Starting dynamic subtest: vecs0
[155.699939] Dynamic subtest vecs0: SUCCESS (1.983s)
[155.711320] Starting dynamic subtest: ccs0
[157.685594] Dynamic subtest ccs0: SUCCESS (1.982s)
[157.688477] Subtest most-busy-check-all: SUCCESS (11.273s)
[157.803825] [018/131] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[157.913974] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[161.539269] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.628s)
[162.690814] [019/131] (853s left) kms_psr (psr-no-drrs)
[162.782710] Starting subtest: psr-no-drrs
[162.785112] Starting dynamic subtest: eDP-1
[164.447900] Dynamic subtest eDP-1: SUCCESS (1.663s)
[164.450120] Subtest psr-no-drrs: SUCCESS (1.664s)
[165.260499] [020/131] (851s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[165.357245] Starting subtest: fbc-tiling-linear
[169.107030] Subtest fbc-tiling-linear: SUCCESS (3.755s)
[170.270364] [021/131] (846s left) i915_drm_fdinfo (virtual-busy-idle)
[170.307636] Starting subtest: virtual-busy-idle
[170.312066] Subtest virtual-busy-idle: SKIP (0.000s)
[170.388975] [022/131] (846s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[170.443026] Starting subtest: multi-wait-all-for-submit-signaled
[170.445585] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[170.559070] [023/131] (845s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[170.660799] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[170.665276] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[170.815676] [024/131] (845s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[170.908204] Starting subtest: random-ccs-data-yf-tiled-ccs
[170.910538] Starting dynamic subtest: pipe-A-eDP-1
[170.936550] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.946906] Starting dynamic subtest: pipe-B-eDP-1
[170.970984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.979367] Starting dynamic subtest: pipe-C-eDP-1
[171.003380] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.011194] Starting dynamic subtest: pipe-D-eDP-1
[171.035736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.039763] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[173.127183] [025/131] (843s left) prime_busy (after-wait)
[173.179592] Starting subtest: after-wait
[173.184585] Starting dynamic subtest: rcs0
[173.211666] Dynamic subtest rcs0: SUCCESS (0.029s)
[173.221166] Starting dynamic subtest: bcs0
[173.280671] Dynamic subtest bcs0: SUCCESS (0.068s)
[173.290076] Starting dynamic subtest: vcs0
[173.320696] Dynamic subtest vcs0: SUCCESS (0.040s)
[173.329065] Starting dynamic subtest: vcs1
[173.361158] Dynamic subtest vcs1: SUCCESS (0.040s)
[173.369636] Starting dynamic subtest: vecs0
[173.402379] Dynamic subtest vecs0: SUCCESS (0.041s)
[173.410742] Starting dynamic subtest: ccs0
[173.442966] Dynamic subtest ccs0: SUCCESS (0.040s)
[173.550229] Subtest after-wait: SUCCESS (0.369s)
[173.636400] [026/131] (843s left) gem_userptr_blits (input-checking)
[173.693608] Starting subtest: input-checking
[173.695463] Subtest input-checking: SUCCESS (0.000s)
[173.856412] [027/131] (842s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[173.959609] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[174.583981] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[174.782207] [028/131] (841s left) kms_plane_multiple (tiling-4)
[174.879339] Starting subtest: tiling-4
[174.881687] Starting dynamic subtest: pipe-A-eDP-1
[178.567386] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.684s)
[178.577237] Starting dynamic subtest: pipe-B-eDP-1
[182.907344] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.340s)
[182.916757] Starting dynamic subtest: pipe-C-eDP-1
[187.254078] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.344s)
[187.262230] Starting dynamic subtest: pipe-D-eDP-1
[191.588537] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.334s)
[191.590958] Subtest tiling-4: SUCCESS (16.708s)
[192.410251] [029/131] (824s left) gen7_exec_parse (batch-without-end)
[192.462958] Subtest batch-without-end: SKIP (0.000s)
[192.542905] [030/131] (824s left) kms_psr (fbc-pr-primary-blt)
[192.635553] Starting subtest: fbc-pr-primary-blt
[192.639725] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[192.730913] [031/131] (824s left) gem_exec_reloc (basic-wc-gtt)
[192.792136] Subtest basic-wc-gtt: SKIP (0.000s)
[192.870583] [032/131] (824s left) gem_pxp (verify-pxp-stale-buf-execution)
[192.997601] Starting subtest: verify-pxp-stale-buf-execution
[194.057153] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[194.220112] [033/131] (822s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[194.277336] Starting subtest: saturated-hostile-nopreempt
[194.279807] Starting dynamic subtest: rcs0
[194.385775] Dynamic subtest rcs0: SKIP (0.104s)
[194.397077] Starting dynamic subtest: bcs0
[194.404256] Dynamic subtest bcs0: SKIP (0.016s)
[194.412446] Starting dynamic subtest: vcs0
[194.417131] Dynamic subtest vcs0: SKIP (0.012s)
[194.425202] Starting dynamic subtest: vcs1
[194.440159] Dynamic subtest vcs1: SKIP (0.024s)
[194.448393] Starting dynamic subtest: vecs0
[194.462123] Dynamic subtest vecs0: SKIP (0.021s)
[194.469990] Starting dynamic subtest: ccs0
[194.489356] Dynamic subtest ccs0: SKIP (0.026s)
[194.494309] Subtest saturated-hostile-nopreempt: SKIP (0.211s)
[194.578523] [034/131] (822s left) gem_exec_balancer (hang)
[194.830597] Starting subtest: hang
[196.688654] Subtest hang: SUCCESS (1.859s)
[196.847585] [035/131] (820s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[196.956296] Starting subtest: bad-aux-stride-y-tiled-ccs
[196.958525] Starting dynamic subtest: pipe-A-eDP-1
[196.980254] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.990424] Starting dynamic subtest: pipe-B-eDP-1
[197.010829] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[197.018387] Starting dynamic subtest: pipe-C-eDP-1
[197.038976] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[197.046669] Starting dynamic subtest: pipe-D-eDP-1
[197.067548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[197.071608] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[199.282413] [036/131] (817s left) api_intel_bb (intel-bb-blit-y)
[199.339455] Starting subtest: intel-bb-blit-y
[202.827446] Subtest intel-bb-blit-y: SUCCESS (3.488s)
[202.973454] [037/131] (814s left) gem_exec_fence (basic-busy)
[203.160215] Starting subtest: basic-busy
[203.162540] Starting dynamic subtest: rcs0
[203.282659] Dynamic subtest rcs0: SUCCESS (0.122s)
[203.294122] Starting dynamic subtest: bcs0
[203.343295] Dynamic subtest bcs0: SUCCESS (0.058s)
[203.354250] Starting dynamic subtest: vcs0
[203.403633] Dynamic subtest vcs0: SUCCESS (0.059s)
[203.414175] Starting dynamic subtest: vcs1
[203.466455] Dynamic subtest vcs1: SUCCESS (0.061s)
[203.475922] Starting dynamic subtest: vecs0
[203.530663] Dynamic subtest vecs0: SUCCESS (0.062s)
[203.540518] Starting dynamic subtest: ccs0
[203.586703] Dynamic subtest ccs0: SUCCESS (0.054s)
[203.589089] Subtest basic-busy: SUCCESS (0.428s)
[205.786098] [038/131] (811s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[205.890401] Starting subtest: y-tiled-addfb-size-offset-overflow
[205.894810] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[206.021624] [039/131] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[206.118030] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[206.122325] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[206.245170] [040/131] (811s left) gem_exec_flush (basic-wb-set-default)
[206.304388] Starting subtest: basic-wb-set-default
[211.750856] Subtest basic-wb-set-default: SUCCESS (5.448s)
[211.948317] [041/131] (805s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[212.051119] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[212.055445] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[212.173685] [042/131] (805s left) gem_exec_params (sol-reset-not-gen7)
[212.231015] Starting subtest: sol-reset-not-gen7
[212.236512] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[212.401167] [043/131] (804s left) kms_cursor_crc (cursor-onscreen-128x128)
[212.598759] Starting subtest: cursor-onscreen-128x128
[212.601151] Starting dynamic subtest: pipe-A-eDP-1
[214.701632] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.100s)
[214.727575] Starting dynamic subtest: pipe-D-eDP-1
[217.524020] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[217.526137] Subtest cursor-onscreen-128x128: SUCCESS (4.926s)
[218.340817] [044/131] (799s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[218.449739] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[218.452165] Starting dynamic subtest: A-eDP1
[222.039181] Dynamic subtest A-eDP1: SUCCESS (3.585s)
[222.048932] Starting dynamic subtest: B-eDP1
[225.224829] Dynamic subtest B-eDP1: SUCCESS (3.183s)
[225.233492] Starting dynamic subtest: C-eDP1
[228.310666] Dynamic subtest C-eDP1: SUCCESS (3.086s)
[228.320193] Starting dynamic subtest: D-eDP1
[231.414237] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[231.416549] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.963s)
[232.231409] [045/131] (785s left) kms_scaling_modes (scaling-mode-none)
[232.327703] Starting subtest: scaling-mode-none
[232.329894] Starting dynamic subtest: pipe-A-eDP-1
[232.426373] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s)
[232.437351] Starting dynamic subtest: pipe-B-eDP-1
[232.461632] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[232.470054] Starting dynamic subtest: pipe-C-eDP-1
[232.495623] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s)
[232.504256] Starting dynamic subtest: pipe-D-eDP-1
[232.527666] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[232.532150] Subtest scaling-mode-none: SKIP (0.201s)
[232.700526] [046/131] (784s left) gem_exec_fence (syncobj-repeat)
[233.126492] Starting subtest: syncobj-repeat
[233.297512] Subtest syncobj-repeat: SUCCESS (0.169s)
[234.815766] [047/131] (782s left) kms_force_connector_basic (force-edid)
[234.902844] Starting subtest: force-edid
[235.263309] Subtest force-edid: SUCCESS (0.370s)
[235.426473] [048/131] (782s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[235.541041] Starting subtest: short-flip-after-cursor-toggle
[236.460611] Subtest short-flip-after-cursor-toggle: SUCCESS (0.918s)
[237.290215] [049/131] (780s left) kms_pm_dc (dc3co-vpb-simulation)
[238.390960] Starting subtest: dc3co-vpb-simulation
[247.288305] Subtest dc3co-vpb-simulation: SKIP (8.893s)
[247.434444] [050/131] (770s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[247.520623] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[247.522783] Starting dynamic subtest: pipe-A-default-mode
[247.811625] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[247.816184] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.290s)
[248.664608] [051/131] (769s left) kms_psr (pr-sprite-blt)
[248.753732] Starting subtest: pr-sprite-blt
[248.758055] Subtest pr-sprite-blt: SKIP (0.000s)
[248.838911] [052/131] (768s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[248.930664] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[248.932918] Starting dynamic subtest: pipe-A-default-mode
[249.236859] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[249.241364] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.303s)
[250.074827] [053/131] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[250.173702] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[250.178187] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[250.330280] [054/131] (767s left) gem_unfence_active_buffers
[250.494332] [055/131] (767s left) gem_ccs (ctrl-surf-copy)
[250.552321] Starting subtest: ctrl-surf-copy
[250.556791] Subtest ctrl-surf-copy: SKIP (0.000s)
[250.713284] [056/131] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[250.822196] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[250.826433] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[250.955771] [057/131] (767s left) prime_vgem (fence-write-hang)
[251.042788] Subtest fence-write-hang: SKIP (0.000s)
[251.169741] [058/131] (766s left) kms_vrr (lobf)
[251.267942] Starting subtest: lobf
[251.271372] Subtest lobf: SKIP (0.000s)
[251.361471] [059/131] (766s left) gem_exec_suspend (basic)
[251.431450] Starting subtest: basic
[251.433608] Starting dynamic subtest: smem
[252.723900] Dynamic subtest smem: SUCCESS (1.290s)
[252.726458] Subtest basic: SUCCESS (1.291s)
[252.930485] [060/131] (765s left) gem_cs_tlb (engines)
[252.985076] Starting subtest: engines
[252.987261] Starting dynamic subtest: rcs0
[255.137527] Dynamic subtest rcs0: SUCCESS (2.152s)
[255.147213] Starting dynamic subtest: bcs0
[257.292323] Dynamic subtest bcs0: SUCCESS (2.152s)
[257.300699] Starting dynamic subtest: vcs0
[259.445323] Dynamic subtest vcs0: SUCCESS (2.152s)
[259.454487] Starting dynamic subtest: vcs1
[261.598027] Dynamic subtest vcs1: SUCCESS (2.152s)
[261.608376] Starting dynamic subtest: vecs0
[263.750371] Dynamic subtest vecs0: SUCCESS (2.151s)
[263.761617] Starting dynamic subtest: ccs0
[265.906315] Dynamic subtest ccs0: SUCCESS (2.154s)
[265.908712] Subtest engines: SUCCESS (12.921s)
[266.037414] [061/131] (752s left) gem_exec_schedule (smoketest)
[266.216358] Starting subtest: smoketest
[266.218378] Starting dynamic subtest: rcs0
[271.782449] Dynamic subtest rcs0: SUCCESS (5.514s)
[271.793093] Starting dynamic subtest: bcs0
[277.306986] Dynamic subtest bcs0: SUCCESS (5.529s)
[277.318261] Starting dynamic subtest: vcs0
[282.795501] Dynamic subtest vcs0: SUCCESS (5.486s)
[282.811044] Starting dynamic subtest: vcs1
[288.289262] Dynamic subtest vcs1: SUCCESS (5.496s)
[288.304590] Starting dynamic subtest: vecs0
[293.795823] Dynamic subtest vecs0: SUCCESS (5.506s)
[293.811532] Starting dynamic subtest: ccs0
[299.295086] Dynamic subtest ccs0: SUCCESS (5.498s)
[299.297266] Subtest smoketest: SUCCESS (33.034s)
[299.441422] [062/131] (718s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[299.537569] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[299.539772] Starting dynamic subtest: pipe-A-eDP-1
[299.562779] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.571867] Starting dynamic subtest: pipe-B-eDP-1
[299.593627] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.601817] Starting dynamic subtest: pipe-C-eDP-1
[299.622705] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.630753] Starting dynamic subtest: pipe-D-eDP-1
[299.652609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.656943] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[301.846539] [063/131] (716s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[301.949246] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[301.953646] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[302.091242] [064/131] (716s left) syncobj_basic (illegal-fd-to-handle)
[302.159642] Starting subtest: illegal-fd-to-handle
[302.161533] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[302.283717] [065/131] (716s left) core_setmaster (master-drop-set-shared-fd)
[302.374332] Starting subtest: master-drop-set-shared-fd
[302.396258] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[302.434628] [066/131] (715s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[302.484453] Starting subtest: single-wait-all-for-submit-available-submitted
[302.486790] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[302.598034] [067/131] (715s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[302.694804] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[302.698971] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[302.804988] [068/131] (715s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[302.865142] Starting subtest: yf-tiled-to-vebox-x-tiled
[302.869130] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[303.059783] [069/131] (715s left) gem_exec_capture (userptr)
[303.118813] Starting subtest: userptr
[303.962311] Subtest userptr: SUCCESS (0.842s)
[304.122724] [070/131] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[304.224246] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[304.228731] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[304.359445] [071/131] (714s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[304.461684] Starting subtest: psr-shrfb-scaledprimary
[310.191519] Subtest psr-shrfb-scaledprimary: SUCCESS (5.736s)
[310.357793] [072/131] (708s left) gem_exec_whisper (basic-contexts-forked-all)
[310.408199] Starting subtest: basic-contexts-forked-all
[330.485576] Subtest basic-contexts-forked-all: SUCCESS (20.078s)
[330.683985] [073/131] (687s left) gem_userptr_blits (nohangcheck)
[330.770058] Starting subtest: nohangcheck
[331.132084] Subtest nohangcheck: SUCCESS (0.358s)
[331.271174] [074/131] (687s left) kms_rotation_crc (exhaust-fences)
[331.368831] Starting subtest: exhaust-fences
[331.373233] Subtest exhaust-fences: SKIP (0.000s)
[331.454584] [075/131] (687s left) kms_sequence (queue-idle)
[331.556975] Starting subtest: queue-idle
[331.559173] Starting dynamic subtest: pipe-A-eDP-1
[333.358406] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s)
[333.368140] Starting dynamic subtest: pipe-B-eDP-1
[335.861369] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[335.873760] Starting dynamic subtest: pipe-C-eDP-1
[338.341916] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.477s)
[338.352245] Starting dynamic subtest: pipe-D-eDP-1
[340.844193] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s)
[340.846576] Subtest queue-idle: SUCCESS (9.291s)
[341.739116] [076/131] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[341.841966] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[348.476576] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.638s)
[348.637987] [077/131] (670s left) gem_lmem_swapping (heavy-multi)
[348.678741] Subtest heavy-multi: SKIP (0.000s)
[348.717787] [078/131] (670s left) gem_exec_params (invalid-flag)
[348.777986] Starting subtest: invalid-flag
[348.780307] Subtest invalid-flag: SUCCESS (0.000s)
[348.886945] [079/131] (670s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[348.987994] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[348.990224] Starting dynamic subtest: pipe-A-eDP-1
[365.747960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.441s)
[365.759136] Starting dynamic subtest: pipe-B-eDP-1
[382.654418] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.320s)
[382.668872] Starting dynamic subtest: pipe-C-eDP-1
[399.612494] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.286s)
[399.621915] Starting dynamic subtest: pipe-D-eDP-1
[416.609906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.318s)
[416.612167] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.369s)
[417.865826] [080/131] (601s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[417.976808] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[417.978692] Starting dynamic subtest: pipe-A-eDP-1
[418.119020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[418.128462] Starting dynamic subtest: pipe-B-eDP-1
[418.149309] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[418.158725] Starting dynamic subtest: pipe-C-eDP-1
[418.180717] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[418.189460] Starting dynamic subtest: pipe-D-eDP-1
[418.211415] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[418.214063] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.172s)
[420.313201] [081/131] (598s left) gem_ctx_shared (detached-shared-gtt)
[420.376443] Starting subtest: detached-shared-gtt
[422.499384] Subtest detached-shared-gtt: SUCCESS (2.153s)
[422.919674] [082/131] (596s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[423.020041] Starting subtest: x-tiled-16bpp-rotate-90
[423.040592] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[423.186793] [083/131] (595s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[423.582318] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[424.434766] [084/131] (594s left) gem_exec_suspend (basic-s3)
[424.493961] Starting subtest: basic-S3
[424.496456] Starting dynamic subtest: smem
[445.515848] Dynamic subtest smem: SUCCESS (6.693s)
[445.518893] Subtest basic-S3: SUCCESS (6.695s)
[445.719759] [085/131] (573s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[445.832122] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[446.906598] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.500s)
[446.965352] [086/131] (572s left) kms_chamelium_edid (dp-mode-timings)
[447.343285] Subtest dp-mode-timings: SKIP (0.000s)
[448.151740] [087/131] (571s left) kms_invalid_mode (bad-hsync-end)
[448.249991] Starting subtest: bad-hsync-end
[448.252301] Starting dynamic subtest: pipe-A-eDP-1
[448.541358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[448.552980] Starting dynamic subtest: pipe-B-eDP-1
[448.555245] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[448.563869] Starting dynamic subtest: pipe-C-eDP-1
[448.566162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[448.581521] Starting dynamic subtest: pipe-D-eDP-1
[448.583801] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[448.586101] Subtest bad-hsync-end: SUCCESS (0.299s)
[449.371986] [088/131] (569s left) gem_exec_reloc (basic-active)
[449.439831] Subtest basic-active: SKIP (0.000s)
[449.527507] [089/131] (569s left) kms_pipe_crc_basic (read-crc)
[449.616874] Starting subtest: read-crc
[449.618780] Starting dynamic subtest: pipe-A-eDP-1
[450.322227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[450.334150] Starting dynamic subtest: pipe-B-eDP-1
[451.698669] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[451.707726] Starting dynamic subtest: pipe-C-eDP-1
[453.050314] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s)
[453.062268] Starting dynamic subtest: pipe-D-eDP-1
[454.338866] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[454.341241] Subtest read-crc: SUCCESS (4.734s)
[455.172761] [090/131] (564s left) i915_query (engine-info-invalid)
[455.236527] Starting subtest: engine-info-invalid
[455.238850] Subtest engine-info-invalid: SUCCESS (0.000s)
[455.376618] [091/131] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[455.463639] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[462.617903] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.164s)
[462.763890] [092/131] (556s left) gem_mmap_gtt (cpuset-big-copy-xy)
[462.810511] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[462.871488] [093/131] (556s left) kms_dsc (dsc-with-output-formats)
[462.962367] Starting subtest: dsc-with-output-formats
[462.985693] Subtest dsc-with-output-formats: SKIP (0.001s)
[463.044921] [094/131] (556s left) kms_frontbuffer_tracking (psr-2p-rte)
[463.148605] Starting subtest: psr-2p-rte
[463.152730] Subtest psr-2p-rte: SKIP (0.000s)
[463.291491] [095/131] (556s left) vgem_basic (dmabuf-export)
[463.333648] Starting subtest: dmabuf-export
[463.386558] Subtest dmabuf-export: SUCCESS (0.055s)
[463.543554] [096/131] (556s left) kms_flip (2x-flip-vs-fences)
[463.634573] Starting subtest: 2x-flip-vs-fences
[463.638114] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[463.757984] [097/131] (555s left) kms_psr (fbc-psr2-cursor-blt)
[463.841805] Starting subtest: fbc-psr2-cursor-blt
[463.843659] Starting dynamic subtest: eDP-1
[463.846969] Dynamic subtest eDP-1: SKIP (0.000s)
[463.850308] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[463.924022] [098/131] (555s left) gem_ctx_param (invalid-set-no-zeromap)
[463.975712] Starting subtest: invalid-set-no-zeromap
[463.977906] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[464.062856] [099/131] (555s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[464.151400] Starting subtest: psr-indfb-scaledprimary
[469.765006] Subtest psr-indfb-scaledprimary: SUCCESS (5.619s)
[469.912921] [100/131] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[470.011565] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[470.015559] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[470.148365] [101/131] (549s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[475.196873] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[475.199462] Starting dynamic subtest: pipe-A-eDP-1
[481.689430] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.494s)
[481.698717] Starting dynamic subtest: pipe-B-eDP-1
[488.171677] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.484s)
[488.174005] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.982s)
[489.047648] [102/131] (530s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[489.177047] Starting subtest: flip-vs-cursor-legacy
[496.207794] Subtest flip-vs-cursor-legacy: SUCCESS (7.035s)
[497.029651] [103/131] (522s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[497.134295] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[497.138154] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[497.266030] [104/131] (522s left) gem_exec_schedule (pi-shared-iova)
[497.446865] Starting subtest: pi-shared-iova
[497.448843] Starting dynamic subtest: rcs0
[497.518532] Dynamic subtest rcs0: SUCCESS (0.076s)
[497.532080] Starting dynamic subtest: vcs0
[497.573162] Dynamic subtest vcs0: SUCCESS (0.055s)
[497.587309] Starting dynamic subtest: vcs1
[497.623714] Dynamic subtest vcs1: SUCCESS (0.051s)
[497.637570] Starting dynamic subtest: vecs0
[497.676158] Dynamic subtest vecs0: SUCCESS (0.051s)
[497.692683] Starting dynamic subtest: ccs0
[497.741355] Dynamic subtest ccs0: SUCCESS (0.064s)
[497.743842] Subtest pi-shared-iova: SUCCESS (0.305s)
[499.657401] [105/131] (520s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[499.720928] Starting subtest: etime-single-wait-available-unsubmitted
[499.823561] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[499.910882] [106/131] (520s left) kms_flip (2x-flip-vs-panning-interruptible)
[500.003989] Starting subtest: 2x-flip-vs-panning-interruptible
[500.015322] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[500.104322] [107/131] (519s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[505.070260] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[505.072746] Starting dynamic subtest: pipe-A-eDP-1
[505.828324] Dynamic subtest pipe-A-eDP-1: SKIP (0.759s)
[505.838330] Starting dynamic subtest: pipe-B-eDP-1
[507.024796] Dynamic subtest pipe-B-eDP-1: SKIP (1.204s)
[507.029394] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.967s)
[508.285619] [108/131] (511s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[508.385662] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[512.637502] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.274s)
[513.789775] [109/131] (506s left) i915_drm_fdinfo (busy-idle)
[513.830531] Starting subtest: busy-idle
[513.832499] Starting dynamic subtest: rcs0
[513.867864] Dynamic subtest rcs0: SKIP (0.036s)
[513.879563] Starting dynamic subtest: bcs0
[513.883688] Dynamic subtest bcs0: SKIP (0.000s)
[513.892842] Starting dynamic subtest: vcs0
[513.897373] Dynamic subtest vcs0: SKIP (0.000s)
[513.905821] Starting dynamic subtest: vcs1
[513.909913] Dynamic subtest vcs1: SKIP (0.000s)
[513.918620] Starting dynamic subtest: vecs0
[513.922784] Dynamic subtest vecs0: SKIP (0.000s)
[513.930887] Starting dynamic subtest: ccs0
[513.934995] Dynamic subtest ccs0: SKIP (0.000s)
[513.939171] Subtest busy-idle: SKIP (0.042s)
[513.974505] [110/131] (506s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[514.036768] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[514.039108] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[514.176681] [111/131] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[514.274552] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[514.278768] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[514.410966] [112/131] (505s left) kms_pm_dc (dc6-dpms)
[515.509938] Starting subtest: dc6-dpms
[517.589012] Subtest dc6-dpms: SUCCESS (2.084s)
[517.680697] [113/131] (502s left) gem_mmap_offset (partial-unmap)
[517.739368] Starting subtest: partial-unmap
[517.741305] Starting dynamic subtest: smem0
[518.227655] Dynamic subtest smem0: SUCCESS (0.489s)
[518.230122] Subtest partial-unmap: SUCCESS (0.491s)
[518.377055] [114/131] (501s left) kms_cursor_legacy (torture-move)
[518.483786] Starting subtest: torture-move
[518.486211] Starting dynamic subtest: pipe-A
[524.075124] Dynamic subtest pipe-A: SUCCESS (5.595s)
[524.087313] Starting dynamic subtest: pipe-B
[529.927423] Dynamic subtest pipe-B: SUCCESS (5.854s)
[529.940347] Starting dynamic subtest: pipe-C
[535.735705] Dynamic subtest pipe-C: SUCCESS (5.803s)
[535.747970] Starting dynamic subtest: pipe-D
[541.898762] Dynamic subtest pipe-D: SUCCESS (6.160s)
[541.910485] Starting dynamic subtest: all-pipes
[547.857895] Dynamic subtest all-pipes: SUCCESS (5.957s)
[547.860571] Subtest torture-move: SUCCESS (29.380s)
[548.037942] [115/131] (472s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[548.101752] Starting subtest: y-tiled-ccs-to-y-tiled
[548.106342] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[548.313206] [116/131] (472s left) kms_flip (2x-dpms-vs-vblank-race)
[548.409126] Starting subtest: 2x-dpms-vs-vblank-race
[548.419920] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[548.566211] [117/131] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[548.654450] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[548.658747] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[548.778971] [118/131] (471s left) kms_color (invalid-ctm-matrix-sizes)
[548.870194] Starting subtest: invalid-ctm-matrix-sizes
[548.872341] Starting dynamic subtest: pipe-A
[548.874698] Dynamic subtest pipe-A: SUCCESS (0.002s)
[548.884353] Starting dynamic subtest: pipe-B
[548.886210] Dynamic subtest pipe-B: SUCCESS (0.003s)
[548.894872] Starting dynamic subtest: pipe-C
[548.897191] Dynamic subtest pipe-C: SUCCESS (0.003s)
[548.906046] Starting dynamic subtest: pipe-D
[548.908408] Dynamic subtest pipe-D: SUCCESS (0.004s)
[548.910376] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[548.971319] [119/131] (471s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[549.030903] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[549.033339] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[549.155625] [120/131] (471s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[549.256097] Starting subtest: 4-tiled-16bpp-rotate-270
[549.276009] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[549.434857] [121/131] (471s left) kms_rotation_crc (primary-rotation-90)
[549.529528] Starting subtest: primary-rotation-90
[549.532993] Subtest primary-rotation-90: SKIP (0.001s)
[549.627522] [122/131] (471s left) vgem_basic (setversion)
[549.665602] Starting subtest: setversion
[549.668928] Subtest setversion: SUCCESS (0.000s)
[549.749603] [123/131] (470s left) gem_readwrite (read-bad-handle)
[549.807547] Subtest read-bad-handle: SKIP (0.000s)
[549.874584] [124/131] (470s left) gem_partial_pwrite_pread (reads-uncached)
[549.931983] Subtest reads-uncached: SKIP (0.000s)
[549.994614] [125/131] (470s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[550.088536] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[550.099761] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[550.205543] [126/131] (470s left) syncobj_eventfd (timeline-wait-signaled)
[550.272656] Starting subtest: timeline-wait-signaled
[550.274268] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[550.409968] [127/131] (470s left) gem_mmap_offset (ptrace)
[550.466820] Starting subtest: ptrace
[550.468446] Starting dynamic subtest: smem0-wb
[550.481375] Dynamic subtest smem0-wb: SUCCESS (0.013s)
[550.491963] Starting dynamic subtest: smem0-wc
[550.500569] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[550.508965] Starting dynamic subtest: smem0-uc
[550.516625] Dynamic subtest smem0-uc: SUCCESS (0.015s)
[550.518569] Subtest ptrace: SUCCESS (0.052s)
[550.680774] [128/131] (470s left) gem_spin_batch (spin-all)
[550.737921] Starting subtest: spin-all
[550.751283] Subtest spin-all: SUCCESS (0.012s)
[552.589427] [129/131] (468s left) kms_prime (d3hot)
[552.672279] Subtest D3hot: SKIP (0.000s)
[552.763617] [130/131] (468s left) drm_read (short-buffer-block)
[552.898158] Starting subtest: short-buffer-block
[552.900522] Subtest short-buffer-block: SUCCESS (0.000s)
[553.051219] [131/131] (467s left) kms_flip (flip-vs-suspend)
[553.137128] Starting subtest: flip-vs-suspend
[553.139442] Starting dynamic subtest: A-eDP1
[602.506094] Dynamic subtest A-eDP1: SUCCESS (4.407s)
[602.520186] Starting dynamic subtest: B-eDP1
[651.506437] Dynamic subtest B-eDP1: SUCCESS (4.378s)
[651.516778] Starting dynamic subtest: C-eDP1
[700.498168] Dynamic subtest C-eDP1: SUCCESS (4.336s)
[700.508373] Starting dynamic subtest: D-eDP1
[749.514066] Dynamic subtest D-eDP1: SUCCESS (4.333s)
[749.518624] Subtest flip-vs-suspend: SUCCESS (17.462s)
[750.643811] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: i915_pm_rpm
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: vgem_basic
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_lease
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: prime_busy
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_plane_multiple
results: parsing output: 28/ for test: gen7_exec_parse
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_scaling_modes
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_force_connector_basic
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_pm_dc
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_unfence_active_buffers
results: parsing output: 54/ for test: gem_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_vgem
results: parsing output: 57/ for test: kms_vrr
results: parsing output: 58/ for test: gem_exec_suspend
results: parsing output: 59/ for test: gem_cs_tlb
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_basic
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: gem_exec_capture
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_sequence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_lmem_swapping
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: gem_exec_suspend
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_chamelium_edid
results: parsing output: 86/ for test: kms_invalid_mode
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: i915_query
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_dsc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_ctx_param
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_pm_dc
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: vgem_basic
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: gem_partial_pwrite_pread
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: syncobj_eventfd
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: kms_prime
results: parsing output: 129/ for test: drm_read
results: parsing output: 130/ for test: kms_flip
Done.