[56.428331] Initializing watchdogs
[56.428375]   /dev/watchdog0
[56.441489] [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]
[56.445720] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.448121] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.451426] [001/131] (960s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[56.530223] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[56.584750] [002/131] (960s left) gem_exec_fence (syncobj-invalid-flags)
[57.048106] Starting subtest: syncobj-invalid-flags
[57.050647] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[59.039284] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[59.042632] [003/131] (957s left) gem_linear_blits (normal)
[59.292678] Starting subtest: normal
[63.913579] Subtest normal: SUCCESS (4.615s)
[64.043521] [004/131] (953s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[64.209754] Starting subtest: flip-vs-cursor-crc-legacy
[64.921927] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.710s)
[65.740194] [005/131] (951s left) gem_exec_reloc (basic-write-read-noreloc)
[65.803311] Subtest basic-write-read-noreloc: SKIP (0.000s)
[65.886698] [006/131] (951s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[65.999419] Starting subtest: cursor-vs-flip-toggle
[96.923273] Subtest cursor-vs-flip-toggle: SUCCESS (30.914s)
[97.773852] [007/131] (919s left) i915_query (engine-info-invalid)
[97.840987] Starting subtest: engine-info-invalid
[97.843019] Subtest engine-info-invalid: SUCCESS (0.000s)
[97.971210] [008/131] (919s left) syncobj_timeline (signal)
[98.042152] Starting subtest: signal
[98.044457] Subtest signal: SUCCESS (0.000s)
[98.162134] [009/131] (919s left) perf (blocking)
[98.305828] Starting subtest: blocking
[98.307828] Starting dynamic subtest: 0-rcs0
[108.336837] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[108.344473] Starting dynamic subtest: 1-vcs0
[118.361715] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[118.364407] Subtest blocking: SUCCESS (20.054s)
[118.407671] [010/131] (898s left) perf (gen12-unprivileged-single-ctx-counters)
[118.519945] Starting subtest: gen12-unprivileged-single-ctx-counters
[118.522506] Starting dynamic subtest: rcs0
[118.570218] Dynamic subtest rcs0: SUCCESS (0.049s)
[118.572525] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.051s)
[118.620516] [011/131] (898s left) kms_chamelium_hpd (dp-hpd-storm)
[119.034630] Subtest dp-hpd-storm: SKIP (0.000s)
[119.856024] [012/131] (897s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[119.960981] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[119.965687] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[120.081676] [013/131] (897s left) gem_create (hog-create)
[120.149357] Starting subtest: hog-create
[120.151766] Starting dynamic subtest: smem0
[153.895235] Dynamic subtest smem0: SUCCESS (33.742s)
[153.898034] Subtest hog-create: SUCCESS (33.743s)
[154.107187] [014/131] (863s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[154.217657] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[154.221746] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[154.347133] [015/131] (863s left) gem_pxp (create-regular-buffer)
[154.475125] Starting subtest: create-regular-buffer
[154.477550] Subtest create-regular-buffer: SUCCESS (0.000s)
[154.614810] [016/131] (862s left) device_reset (unbind-reset-rebind)
[154.661249] Starting subtest: unbind-reset-rebind
[159.341602] Subtest unbind-reset-rebind: SUCCESS (4.676s)
[159.379938] [017/131] (858s left) gem_mmap_gtt (ptrace)
[159.449395] Subtest ptrace: SKIP (0.000s)
[159.511758] [018/131] (858s left) syncobj_wait (multi-wait-for-submit-submitted)
[159.566992] Starting subtest: multi-wait-for-submit-submitted
[159.673244] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[159.767405] [019/131] (857s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[159.867268] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[159.869814] Starting dynamic subtest: pipe-A-eDP-1
[159.893852] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.904350] Starting dynamic subtest: pipe-B-eDP-1
[159.924977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.931914] Starting dynamic subtest: pipe-C-eDP-1
[159.952505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.959548] Starting dynamic subtest: pipe-D-eDP-1
[159.980189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.984319] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[162.166920] [020/131] (855s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[162.278560] Starting subtest: y-tiled-32bpp-rotate-180
[162.282636] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[162.393517] [021/131] (855s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[167.449999] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[167.452287] Starting dynamic subtest: pipe-A-eDP-1
[168.230486] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[168.239867] Starting dynamic subtest: pipe-B-eDP-1
[169.356848] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[169.361108] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.906s)
[170.564351] [022/131] (847s left) syncobj_wait (reset-signaled)
[170.632894] Starting subtest: reset-signaled
[170.635372] Subtest reset-signaled: SUCCESS (0.000s)
[170.768104] [023/131] (847s left) kms_big_fb (linear-16bpp-rotate-90)
[170.868839] Starting subtest: linear-16bpp-rotate-90
[170.887232] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[171.044873] [024/131] (846s left) kms_joiner (basic-max-non-joiner)
[171.143118] Starting subtest: basic-max-non-joiner
[171.147586] Subtest basic-max-non-joiner: SKIP (0.000s)
[171.227332] [025/131] (846s left) gem_render_copy_redux (interruptible)
[171.299586] Starting subtest: interruptible
[171.546112] Subtest interruptible: SUCCESS (0.249s)
[171.685230] [026/131] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[171.789688] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[171.793090] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[171.915400] [027/131] (846s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[172.008478] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[172.010133] Starting dynamic subtest: pipe-A-eDP-1
[172.026928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[172.035518] Starting dynamic subtest: pipe-B-eDP-1
[172.052181] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[172.059601] Starting dynamic subtest: pipe-C-eDP-1
[172.075147] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.018s)
[172.082268] Starting dynamic subtest: pipe-D-eDP-1
[172.098369] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[172.100190] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.080s)
[174.417198] [028/131] (843s left) kms_sequence (get-forked)
[174.521253] Starting subtest: get-forked
[174.523504] Starting dynamic subtest: pipe-A-eDP-1
[176.398578] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[176.409423] Starting dynamic subtest: pipe-B-eDP-1
[178.926087] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.526s)
[178.935128] Starting dynamic subtest: pipe-C-eDP-1
[181.478125] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.551s)
[181.488611] Starting dynamic subtest: pipe-D-eDP-1
[183.974557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[183.976757] Subtest get-forked: SUCCESS (9.454s)
[184.862980] [029/131] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[184.967907] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[192.329311] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.365s)
[192.508384] [030/131] (825s left) gem_ctx_persistence (heartbeat-many)
[192.567058] Starting subtest: heartbeat-many
[192.571627] Subtest heartbeat-many: SKIP (0.000s)
[192.711684] [031/131] (825s left) gem_exec_schedule (fairslice)
[192.796816] Starting subtest: fairslice
[192.798761] Starting dynamic subtest: rcs0
[194.808659] Dynamic subtest rcs0: SUCCESS (2.018s)
[194.818525] Starting dynamic subtest: bcs0
[196.828762] Dynamic subtest bcs0: SUCCESS (2.018s)
[196.836995] Starting dynamic subtest: vcs0
[198.846443] Dynamic subtest vcs0: SUCCESS (2.019s)
[198.856063] Starting dynamic subtest: vcs1
[200.867809] Dynamic subtest vcs1: SUCCESS (2.019s)
[200.877165] Starting dynamic subtest: vecs0
[202.882860] Dynamic subtest vecs0: SUCCESS (2.015s)
[202.892028] Starting dynamic subtest: ccs0
[204.899513] Dynamic subtest ccs0: SUCCESS (2.018s)
[204.901694] Subtest fairslice: SUCCESS (12.111s)
[205.221751] [032/131] (812s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[205.291017] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[205.295409] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[205.499035] [033/131] (812s left) api_intel_bb (delta-check)
[205.554181] Starting subtest: delta-check
[205.563051] Subtest delta-check: SUCCESS (0.010s)
[205.734011] [034/131] (812s left) kms_async_flips (invalid-async-flip-atomic)
[205.847609] Starting subtest: invalid-async-flip-atomic
[206.228278] Starting dynamic subtest: pipe-A-eDP-1
[207.071451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.843s)
[207.429242] Starting dynamic subtest: pipe-B-eDP-1
[208.207496] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[208.563543] Starting dynamic subtest: pipe-C-eDP-1
[209.332344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[209.685097] Starting dynamic subtest: pipe-D-eDP-1
[210.449663] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[210.451967] Subtest invalid-async-flip-atomic: SUCCESS (4.601s)
[211.656983] [035/131] (806s left) perf (polling)
[211.785566] Starting subtest: polling
[211.787709] Starting dynamic subtest: 0-rcs0
[221.800649] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[221.809109] Starting dynamic subtest: 1-vcs0
[231.822134] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[231.824959] Subtest polling: SUCCESS (20.036s)
[231.867621] [036/131] (786s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[231.963148] Starting subtest: plane-upscale-factor-0-25-with-rotation
[231.965352] Starting dynamic subtest: pipe-A
[232.189614] Dynamic subtest pipe-A: SUCCESS (0.226s)
[232.200088] Starting dynamic subtest: pipe-B
[233.489090] Dynamic subtest pipe-B: SUCCESS (1.299s)
[233.497619] Starting dynamic subtest: pipe-C
[234.828111] Dynamic subtest pipe-C: SUCCESS (1.338s)
[234.838655] Starting dynamic subtest: pipe-D
[236.157574] Dynamic subtest pipe-D: SUCCESS (1.329s)
[236.160029] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.195s)
[237.356269] [037/131] (781s left) kms_chamelium_audio (dp-audio)
[237.730860] Subtest dp-audio: SKIP (0.000s)
[238.530809] [038/131] (779s left) syncobj_timeline (invalid-query-illegal-handle)
[238.595908] Starting subtest: invalid-query-illegal-handle
[238.598123] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[238.731229] [039/131] (779s left) gem_mmap (big-bo)
[238.796288] Subtest big-bo: SKIP (0.000s)
[238.864861] [040/131] (779s left) gem_exec_params (rsvd2-dirt)
[238.931086] Starting subtest: rsvd2-dirt
[238.935970] Subtest rsvd2-dirt: SKIP (0.000s)
[239.048034] [041/131] (779s left) kms_pm_rpm (modeset-non-lpsp-stress)
[241.088059] Starting subtest: modeset-non-lpsp-stress
[242.257478] Subtest modeset-non-lpsp-stress: SKIP (1.166s)
[242.656849] [042/131] (775s left) kms_psr (psr2-basic)
[242.759251] Starting subtest: psr2-basic
[242.761602] Starting dynamic subtest: eDP-1
[244.395369] Dynamic subtest eDP-1: SUCCESS (1.637s)
[244.397674] Subtest psr2-basic: SUCCESS (1.638s)
[245.215274] [043/131] (773s left) gem_mmap_gtt (basic-small-bo)
[245.280277] Subtest basic-small-bo: SKIP (0.000s)
[245.342609] [044/131] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[245.437175] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[249.116576] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.682s)
[250.307756] [045/131] (768s left) gem_ctx_param (vm)
[250.365414] Starting subtest: vm
[250.410288] Subtest vm: SUCCESS (0.044s)
[250.578939] [046/131] (768s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[250.687301] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[251.278120] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.592s)
[251.484934] [047/131] (767s left) kms_feature_discovery (display)
[251.584381] Starting subtest: display
[251.586550] Subtest display: SUCCESS (0.000s)
[251.681158] [048/131] (767s left) gem_eio (in-flight-internal-immediate)
[251.915515] Starting subtest: in-flight-internal-immediate
[252.948989] Subtest in-flight-internal-immediate: SUCCESS (1.034s)
[253.130650] [049/131] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[253.236064] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[257.106340] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.874s)
[258.298283] [050/131] (760s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[258.410343] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[258.414512] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[258.546179] [051/131] (760s left) kms_flip (plain-flip-ts-check-interruptible)
[258.647435] Starting subtest: plain-flip-ts-check-interruptible
[258.649744] Starting dynamic subtest: A-eDP1
[267.453801] Dynamic subtest A-eDP1: SUCCESS (8.804s)
[267.468137] Starting dynamic subtest: B-eDP1
[276.281434] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[276.291770] Starting dynamic subtest: C-eDP1
[285.100633] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[285.110512] Starting dynamic subtest: D-eDP1
[293.931117] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[293.933562] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.285s)
[295.138750] [052/131] (723s left) kms_psr (fbc-psr-cursor-blt)
[295.239177] Starting subtest: fbc-psr-cursor-blt
[295.241085] Starting dynamic subtest: eDP-1
[295.245193] Dynamic subtest eDP-1: SKIP (0.000s)
[295.249296] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[295.337100] [053/131] (723s left) kms_flip (2x-flip-vs-fences-interruptible)
[295.446390] Starting subtest: 2x-flip-vs-fences-interruptible
[295.450890] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[295.582990] [054/131] (723s left) kms_cursor_edge_walk (256x256-left-edge)
[295.682942] Starting subtest: 256x256-left-edge
[295.685259] Starting dynamic subtest: pipe-A-eDP-1
[299.174434] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[299.184335] Starting dynamic subtest: pipe-D-eDP-1
[302.307566] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[302.309826] Subtest 256x256-left-edge: SUCCESS (6.624s)
[303.140474] [055/131] (715s left) gem_exec_store (basic)
[303.205649] Starting subtest: basic
[303.286307] Subtest basic: SUCCESS (0.082s)
[303.485725] [056/131] (715s left) kms_flip (flip-vs-suspend)
[303.594663] Starting subtest: flip-vs-suspend
[303.597087] Starting dynamic subtest: A-eDP1
[336.747374] Dynamic subtest A-eDP1: SUCCESS (7.147s)
[336.763127] Starting dynamic subtest: B-eDP1
[385.772781] Dynamic subtest B-eDP1: SUCCESS (4.519s)
[385.782796] Starting dynamic subtest: C-eDP1
[434.769948] Dynamic subtest C-eDP1: SUCCESS (4.513s)
[434.785598] Starting dynamic subtest: D-eDP1
[483.748253] Dynamic subtest D-eDP1: SUCCESS (4.519s)
[483.750439] Subtest flip-vs-suspend: SUCCESS (20.706s)
[484.965535] [057/131] (534s left) kms_vblank (crtc-id)
[485.078498] Starting subtest: crtc-id
[485.080662] Starting dynamic subtest: pipe-A-eDP-1
[485.523235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[485.537665] Starting dynamic subtest: pipe-D-eDP-1
[486.666653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[486.669043] Subtest crtc-id: SUCCESS (1.581s)
[487.531713] [058/131] (531s left) kms_chamelium_frames (hdmi-crc-multiple)
[487.927546] Subtest hdmi-crc-multiple: SKIP (0.000s)
[488.726475] [059/131] (530s left) perf (non-sampling-read-error)
[488.832933] Starting subtest: non-sampling-read-error
[488.842633] Subtest non-sampling-read-error: SUCCESS (0.007s)
[488.887185] [060/131] (530s left) kms_lease (simple-lease)
[488.985468] Starting subtest: simple-lease
[488.987797] Starting dynamic subtest: pipe-A-eDP-1
[489.506930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.519s)
[489.517222] Starting dynamic subtest: pipe-B-eDP-1
[490.914925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[490.924354] Starting dynamic subtest: pipe-C-eDP-1
[492.310965] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[492.319549] Starting dynamic subtest: pipe-D-eDP-1
[493.714771] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[493.716791] Subtest simple-lease: SUCCESS (4.715s)
[494.542123] [061/131] (524s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[494.655707] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[494.659737] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[494.798017] [062/131] (524s left) kms_psr (psr2-no-drrs)
[494.903367] Starting subtest: psr2-no-drrs
[494.905448] Starting dynamic subtest: eDP-1
[496.489417] Dynamic subtest eDP-1: SUCCESS (1.584s)
[496.491725] Subtest psr2-no-drrs: SUCCESS (1.585s)
[497.311360] [063/131] (522s left) gem_exec_schedule (implicit-boths)
[497.390039] Starting subtest: implicit-boths
[497.391953] Starting dynamic subtest: rcs0
[497.488773] Dynamic subtest rcs0: SUCCESS (0.108s)
[497.500615] Starting dynamic subtest: vcs0
[497.566266] Dynamic subtest vcs0: SUCCESS (0.076s)
[497.578616] Starting dynamic subtest: vcs1
[497.641182] Dynamic subtest vcs1: SUCCESS (0.073s)
[497.652841] Starting dynamic subtest: vecs0
[497.727975] Dynamic subtest vecs0: SUCCESS (0.086s)
[497.741744] Starting dynamic subtest: ccs0
[497.806093] Dynamic subtest ccs0: SUCCESS (0.077s)
[497.808545] Subtest implicit-boths: SUCCESS (0.425s)
[499.437907] [064/131] (520s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[499.648947] Starting subtest: cursor-rapid-movement-128x128
[499.653978] Starting dynamic subtest: pipe-A-eDP-1
[500.208080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[500.236171] Starting dynamic subtest: pipe-D-eDP-1
[501.391473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.159s)
[501.393296] Subtest cursor-rapid-movement-128x128: SUCCESS (1.738s)
[502.273570] [065/131] (517s left) kms_rotation_crc (bad-tiling)
[502.370340] Starting subtest: bad-tiling
[502.374532] Subtest bad-tiling: SKIP (0.001s)
[502.469333] [066/131] (517s left) gem_blits (basic)
[502.541177] Starting subtest: basic
[503.829728] Subtest basic: SUCCESS (1.286s)
[503.992630] [067/131] (515s left) gem_spin_batch (user-each)
[504.065111] Starting subtest: user-each
[507.423077] Subtest user-each: SUCCESS (3.355s)
[509.417295] [068/131] (510s left) gem_exec_params (invalid-ring2)
[509.478382] Starting subtest: invalid-ring2
[509.480639] Subtest invalid-ring2: SUCCESS (0.000s)
[509.606709] [069/131] (510s left) i915_getparams_basic (basic-subslice-total)
[509.659516] Starting subtest: basic-subslice-total
[509.663553] Subtest basic-subslice-total: SUCCESS (0.000s)
[509.775791] [070/131] (509s left) gem_userptr_blits (sync-unmap-cycles)
[509.864042] Starting subtest: sync-unmap-cycles
[515.240231] Subtest sync-unmap-cycles: SUCCESS (5.376s)
[515.416332] [071/131] (504s left) perf_pmu (idle-no-semaphores)
[515.459366] Starting subtest: idle-no-semaphores
[515.461178] Starting dynamic subtest: rcs0
[516.026454] Dynamic subtest rcs0: SUCCESS (0.566s)
[516.038907] Starting dynamic subtest: bcs0
[516.552830] Dynamic subtest bcs0: SUCCESS (0.523s)
[516.565210] Starting dynamic subtest: vcs0
[517.070254] Dynamic subtest vcs0: SUCCESS (0.515s)
[517.081727] Starting dynamic subtest: vcs1
[517.600437] Dynamic subtest vcs1: SUCCESS (0.527s)
[517.612006] Starting dynamic subtest: vecs0
[518.117636] Dynamic subtest vecs0: SUCCESS (0.514s)
[518.129877] Starting dynamic subtest: ccs0
[518.637870] Dynamic subtest ccs0: SUCCESS (0.517s)
[518.640414] Subtest idle-no-semaphores: SUCCESS (3.181s)
[518.784737] [072/131] (501s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[518.891802] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[525.724592] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.837s)
[525.894803] [073/131] (493s left) gem_ctx_shared (q-independent)
[525.959142] Starting subtest: Q-independent
[525.961581] Starting dynamic subtest: rcs0
[526.017359] Dynamic subtest rcs0: SUCCESS (0.057s)
[526.030220] Starting dynamic subtest: vcs0
[526.054722] Dynamic subtest vcs0: SUCCESS (0.037s)
[526.066679] Starting dynamic subtest: vcs1
[526.087687] Dynamic subtest vcs1: SUCCESS (0.032s)
[526.098005] Starting dynamic subtest: vecs0
[526.128324] Dynamic subtest vecs0: SUCCESS (0.040s)
[526.137286] Starting dynamic subtest: ccs0
[526.171281] Dynamic subtest ccs0: SUCCESS (0.042s)
[526.173487] Subtest Q-independent: SUCCESS (0.213s)
[527.381826] [074/131] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[527.481979] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[527.486009] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[527.608420] [075/131] (492s left) syncobj_wait (multi-wait-all-submitted)
[527.664854] Starting subtest: multi-wait-all-submitted
[527.772399] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[527.870574] [076/131] (492s left) kms_big_fb (x-tiled-addfb)
[527.959303] Starting subtest: x-tiled-addfb
[527.961501] Subtest x-tiled-addfb: SUCCESS (0.000s)
[528.094372] [077/131] (491s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[528.186414] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[528.188690] Starting dynamic subtest: A-eDP1
[531.796923] Dynamic subtest A-eDP1: SUCCESS (3.610s)
[531.811126] Starting dynamic subtest: B-eDP1
[535.005959] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[535.015922] Starting dynamic subtest: C-eDP1
[538.117404] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[538.127125] Starting dynamic subtest: D-eDP1
[541.209013] Dynamic subtest D-eDP1: SUCCESS (3.087s)
[541.211389] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.022s)
[542.025028] [078/131] (477s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[542.130351] Starting subtest: crc-primary-basic-yf-tiled-ccs
[542.132661] Starting dynamic subtest: pipe-A-eDP-1
[542.155676] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[542.167421] Starting dynamic subtest: pipe-B-eDP-1
[542.189099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[542.197930] Starting dynamic subtest: pipe-C-eDP-1
[542.219540] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[542.227934] Starting dynamic subtest: pipe-D-eDP-1
[542.249873] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[542.254293] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[544.296707] [079/131] (475s left) sw_sync (timeline_closed_signaled)
[544.328332] Starting subtest: timeline_closed_signaled
[544.330714] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[544.403467] [080/131] (475s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[544.462930] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[544.565335] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[544.665506] [081/131] (475s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[544.754727] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[545.500581] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.748s)
[545.699241] [082/131] (474s left) syncobj_timeline (etime-single-wait-submitted)
[545.767703] Starting subtest: etime-single-wait-submitted
[545.876080] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[545.977740] [083/131] (474s left) gem_eio (in-flight-internal-1us)
[546.209001] Starting subtest: in-flight-internal-1us
[547.359420] Subtest in-flight-internal-1us: SUCCESS (1.151s)
[547.533033] [084/131] (472s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[547.629885] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[547.632250] Starting dynamic subtest: pipe-A-eDP-1
[547.655934] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[547.671235] Starting dynamic subtest: pipe-B-eDP-1
[547.693143] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[547.702274] Starting dynamic subtest: pipe-C-eDP-1
[547.724145] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[547.733086] Starting dynamic subtest: pipe-D-eDP-1
[547.755096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[547.759502] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[549.876037] [085/131] (470s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[549.977073] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[549.981268] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[550.111378] [086/131] (470s left) prime_vgem (fence-flip-hang)
[550.199874] Subtest fence-flip-hang: SKIP (0.000s)
[550.310471] [087/131] (470s left) kms_properties (plane-properties-legacy)
[550.407686] Starting subtest: plane-properties-legacy
[550.409993] Starting dynamic subtest: pipe-A-eDP-1
[550.951300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[550.960762] Starting dynamic subtest: pipe-B-eDP-1
[552.241700] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.287s)
[552.251532] Starting dynamic subtest: pipe-C-eDP-1
[553.548561] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s)
[553.559546] Starting dynamic subtest: pipe-D-eDP-1
[554.788542] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[554.790931] Subtest plane-properties-legacy: SUCCESS (4.383s)
[555.695325] [088/131] (464s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[555.806906] Starting subtest: psr-rgb565-draw-render
[562.873344] Subtest psr-rgb565-draw-render: SUCCESS (7.067s)
[563.034280] [089/131] (457s left) kms_lease (lease-invalid-connector)
[563.128366] Starting subtest: lease-invalid-connector
[563.130550] Starting dynamic subtest: pipe-A-eDP-1
[563.132754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[563.141391] Starting dynamic subtest: pipe-B-eDP-1
[563.143282] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[563.152471] Starting dynamic subtest: pipe-C-eDP-1
[563.154543] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[563.163544] Starting dynamic subtest: pipe-D-eDP-1
[563.165429] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[563.167264] Subtest lease-invalid-connector: SUCCESS (0.004s)
[563.225122] [090/131] (457s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[563.330285] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[563.334469] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[563.474810] [091/131] (457s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[563.578487] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[563.580820] Starting dynamic subtest: pipe-A-default-mode
[566.344501] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[566.346402] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.765s)
[567.236977] [092/131] (453s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[567.337078] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[567.341474] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[567.453067] [093/131] (453s left) gem_exec_balancer (parallel-contexts)
[567.716294] Starting subtest: parallel-contexts
[570.643218] Subtest parallel-contexts: SUCCESS (2.926s)
[571.462545] [094/131] (449s left) kms_debugfs (display-off-read-all)
[571.563390] Starting subtest: display-off-read-all
[571.849198] Subtest display-off-read-all: SUCCESS (0.286s)
[572.669381] [095/131] (448s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[572.772497] Starting subtest: fbc-rgb565-draw-render
[576.972850] Subtest fbc-rgb565-draw-render: SUCCESS (4.202s)
[578.168890] [096/131] (442s left) kms_plane_cursor (overlay)
[578.262475] Starting subtest: overlay
[578.267052] Starting dynamic subtest: pipe-A-eDP-1-size-64
[580.680305] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.417s)
[580.739162] Starting dynamic subtest: pipe-A-eDP-1-size-128
[583.155895] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.426s)
[583.218382] Starting dynamic subtest: pipe-A-eDP-1-size-256
[585.656511] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[586.013219] Starting dynamic subtest: pipe-B-eDP-1-size-64
[589.198017] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.200s)
[589.260859] Starting dynamic subtest: pipe-B-eDP-1-size-128
[591.801247] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.551s)
[591.861962] Starting dynamic subtest: pipe-B-eDP-1-size-256
[594.255146] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.404s)
[594.604772] Starting dynamic subtest: pipe-C-eDP-1-size-64
[597.290250] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.697s)
[597.327763] Starting dynamic subtest: pipe-C-eDP-1-size-128
[599.379036] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.058s)
[599.416955] Starting dynamic subtest: pipe-C-eDP-1-size-256
[601.444173] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.036s)
[601.781330] Starting dynamic subtest: pipe-D-eDP-1-size-64
[604.643791] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.884s)
[604.684937] Starting dynamic subtest: pipe-D-eDP-1-size-128
[606.732432] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[606.772280] Starting dynamic subtest: pipe-D-eDP-1-size-256
[608.854328] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.091s)
[609.174090] Subtest overlay: SUCCESS (30.914s)
[610.075531] [097/131] (410s left) kms_content_protection (srm)
[610.221262] Starting subtest: srm
[610.225974] Subtest srm: SKIP (0.002s)
[610.381262] [098/131] (410s left) prime_busy (hang-wait)
[610.437547] Starting subtest: hang-wait
[610.439876] Starting dynamic subtest: rcs0
[636.746374] Dynamic subtest rcs0: SUCCESS (26.301s)
[636.757028] Starting dynamic subtest: bcs0
[643.881735] Dynamic subtest bcs0: SUCCESS (7.133s)
[643.892925] Starting dynamic subtest: vcs0
[650.851777] Dynamic subtest vcs0: SUCCESS (6.965s)
[650.860827] Starting dynamic subtest: vcs1
[657.896272] Dynamic subtest vcs1: SUCCESS (7.040s)
[657.905928] Starting dynamic subtest: vecs0
[664.869849] Dynamic subtest vecs0: SUCCESS (6.970s)
[664.879202] Starting dynamic subtest: ccs0
[678.770914] Dynamic subtest ccs0: SUCCESS (13.896s)
[678.773274] Subtest hang-wait: SUCCESS (68.318s)
[678.929598] [099/131] (341s left) kms_vblank (ts-continuation-idle)
[679.030185] Starting subtest: ts-continuation-idle
[679.032377] Starting dynamic subtest: pipe-A-eDP-1
[679.429446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[679.443471] Starting dynamic subtest: pipe-D-eDP-1
[680.549669] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s)
[680.551558] Subtest ts-continuation-idle: SUCCESS (1.519s)
[681.449347] [100/131] (339s left) kms_async_flips (alternate-sync-async-flip)
[681.552468] Starting subtest: alternate-sync-async-flip
[681.944939] Starting dynamic subtest: pipe-A-eDP-1
[684.725591] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.781s)
[685.115365] Starting dynamic subtest: pipe-B-eDP-1
[687.856795] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[688.230333] Starting dynamic subtest: pipe-C-eDP-1
[690.990347] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[691.363098] Starting dynamic subtest: pipe-D-eDP-1
[694.117480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[694.119505] Subtest alternate-sync-async-flip: SUCCESS (12.565s)
[695.307820] [101/131] (325s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[695.407674] Starting subtest: fbc-psr2-primary-mmap-cpu
[695.409824] Starting dynamic subtest: eDP-1
[695.414245] Dynamic subtest eDP-1: SKIP (0.000s)
[695.418516] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.002s)
[695.507971] [102/131] (325s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[695.607209] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[695.611381] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[695.731579] [103/131] (325s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[697.452800] Starting subtest: dpms-mode-unset-non-lpsp
[698.618232] Subtest dpms-mode-unset-non-lpsp: SKIP (1.164s)
[699.005409] [104/131] (322s left) gem_pxp (verify-pxp-stale-ctx-execution)
[699.133541] Starting subtest: verify-pxp-stale-ctx-execution
[700.190146] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.059s)
[700.366419] [105/131] (320s left) sysfs_preempt_timeout (idempotent)
[700.434092] Starting subtest: idempotent
[700.436477] Starting dynamic subtest: vecs0
[700.438884] Dynamic subtest vecs0: SUCCESS (0.000s)
[700.450110] Starting dynamic subtest: ccs0
[700.451936] Dynamic subtest ccs0: SUCCESS (0.000s)
[700.460899] Starting dynamic subtest: vcs0
[700.462730] Dynamic subtest vcs0: SUCCESS (0.000s)
[700.471687] Starting dynamic subtest: bcs0
[700.473565] Dynamic subtest bcs0: SUCCESS (0.000s)
[700.482222] Starting dynamic subtest: rcs0
[700.484052] Dynamic subtest rcs0: SUCCESS (0.000s)
[700.492968] Starting dynamic subtest: vcs1
[700.494857] Dynamic subtest vcs1: SUCCESS (0.000s)
[700.496784] Subtest idempotent: SUCCESS (0.006s)
[700.589067] [106/131] (320s left) gem_mmap_gtt (basic-small-bo-tiledy)
[700.651257] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[700.722696] [107/131] (320s left) kms_plane_scaling (intel-max-src-size)
[700.822966] Starting subtest: intel-max-src-size
[700.829892] Subtest intel-max-src-size: SKIP (0.001s)
[700.962115] [108/131] (320s left) kms_color (invalid-gamma-lut-sizes)
[701.061569] Starting subtest: invalid-gamma-lut-sizes
[701.063865] Starting dynamic subtest: pipe-A
[701.353193] Dynamic subtest pipe-A: SUCCESS (0.288s)
[701.374118] Starting dynamic subtest: pipe-B
[701.376861] Dynamic subtest pipe-B: SUCCESS (0.001s)
[701.398061] Starting dynamic subtest: pipe-C
[701.399940] Dynamic subtest pipe-C: SUCCESS (0.001s)
[701.409453] Starting dynamic subtest: pipe-D
[701.411384] Dynamic subtest pipe-D: SUCCESS (0.001s)
[701.413253] Subtest invalid-gamma-lut-sizes: SUCCESS (0.293s)
[702.253193] [109/131] (319s left) kms_psr (fbc-pr-primary-mmap-gtt)
[702.340123] Starting subtest: fbc-pr-primary-mmap-gtt
[702.344058] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[702.437100] [110/131] (318s left) gem_exec_schedule (semaphore-codependency)
[702.500589] Starting subtest: semaphore-codependency
[702.502932] Subtest semaphore-codependency: SUCCESS (0.010s)
[702.870708] [111/131] (318s left) kms_addfb_basic (bad-pitch-63)
[702.927641] Starting subtest: bad-pitch-63
[702.929877] Subtest bad-pitch-63: SUCCESS (0.000s)
[703.096835] [112/131] (318s left) i915_pm_rpm (gem-execbuf)
[705.442280] Starting subtest: gem-execbuf
[705.444980] Starting dynamic subtest: smem0
[706.952579] Dynamic subtest smem0: SUCCESS (1.513s)
[706.955058] Subtest gem-execbuf: SUCCESS (1.515s)
[707.067141] [113/131] (314s left) syncobj_basic (bad-pad-fd-to-handle)
[707.125103] Starting subtest: bad-pad-fd-to-handle
[707.127155] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[707.268788] [114/131] (314s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[707.383674] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[707.387729] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[707.524164] [115/131] (314s left) gem_userptr_blits (process-exit)
[707.594899] Starting subtest: process-exit
[707.600534] Subtest process-exit: SUCCESS (0.006s)
[707.763552] [116/131] (313s left) kms_atomic_interruptible (universal-setplane-cursor)
[707.865193] Starting subtest: universal-setplane-cursor
[707.867438] Starting dynamic subtest: pipe-A-eDP-1
[715.243227] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.377s)
[715.245451] Subtest universal-setplane-cursor: SUCCESS (7.378s)
[716.103939] [117/131] (305s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[716.204386] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[720.313267] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.112s)
[721.505062] [118/131] (300s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[721.569986] Starting subtest: single-wait-all-for-submit-signaled
[721.571880] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[721.701011] [119/131] (300s left) kms_force_connector_basic (force-connector-state)
[721.782212] Starting subtest: force-connector-state
[722.392513] Subtest force-connector-state: SUCCESS (0.610s)
[723.339325] [120/131] (298s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[723.442148] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[723.446171] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[723.561609] [121/131] (298s left) gem_eio (in-flight-immediate)
[723.753163] Starting subtest: in-flight-immediate
[731.748521] Subtest in-flight-immediate: SUCCESS (7.995s)
[731.956705] [122/131] (289s left) gen9_exec_parse (bb-secure)
[732.021405] Subtest bb-secure: SKIP (0.000s)
[732.111665] [123/131] (289s left) gem_spin_batch (engines)
[732.173217] Starting subtest: engines
[732.175555] Starting dynamic subtest: rcs0
[735.413454] Dynamic subtest rcs0: SUCCESS (3.236s)
[735.426127] Starting dynamic subtest: bcs0
[738.650206] Dynamic subtest bcs0: SUCCESS (3.234s)
[738.662477] Starting dynamic subtest: vcs0
[741.882468] Dynamic subtest vcs0: SUCCESS (3.230s)
[741.894856] Starting dynamic subtest: vcs1
[745.116633] Dynamic subtest vcs1: SUCCESS (3.232s)
[745.128807] Starting dynamic subtest: vecs0
[748.352620] Dynamic subtest vecs0: SUCCESS (3.233s)
[748.364820] Starting dynamic subtest: ccs0
[751.592395] Dynamic subtest ccs0: SUCCESS (3.237s)
[751.594942] Subtest engines: SUCCESS (19.417s)
[751.867757] [124/131] (270s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[751.929207] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[752.037623] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[752.141783] [125/131] (269s left) gem_lmem_swapping (heavy-random)
[752.190555] Subtest heavy-random: SKIP (0.000s)
[752.237747] [126/131] (269s left) i915_drm_fdinfo (busy-hang)
[752.279411] Starting subtest: busy-hang
[752.281898] Starting dynamic subtest: rcs0
[752.314449] Dynamic subtest rcs0: SKIP (0.032s)
[752.326909] Starting dynamic subtest: bcs0
[752.331300] Dynamic subtest bcs0: SKIP (0.001s)
[752.343384] Starting dynamic subtest: vcs0
[752.347327] Dynamic subtest vcs0: SKIP (0.001s)
[752.356963] Starting dynamic subtest: vcs1
[752.361201] Dynamic subtest vcs1: SKIP (0.001s)
[752.370373] Starting dynamic subtest: vecs0
[752.374498] Dynamic subtest vecs0: SKIP (0.001s)
[752.383593] Starting dynamic subtest: ccs0
[752.387937] Dynamic subtest ccs0: SKIP (0.001s)
[752.392290] Subtest busy-hang: SKIP (0.043s)
[752.431598] [127/131] (269s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[752.529926] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[759.536820] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.009s)
[759.685719] [128/131] (262s left) kms_psr (psr-suspend)
[759.796947] Starting subtest: psr-suspend
[759.799084] Starting dynamic subtest: eDP-1
[778.175705] Dynamic subtest eDP-1: SUCCESS (2.913s)
[778.178012] Subtest psr-suspend: SUCCESS (2.915s)
[779.010525] [129/131] (243s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[784.062704] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[784.067640] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[784.895714] [130/131] (237s left) gem_exec_balancer (hang)
[785.146595] Starting subtest: hang
[786.764215] Subtest hang: SUCCESS (1.621s)
[786.930142] [131/131] (235s left) gem_exec_params (invalid-ring)
[786.985245] Starting subtest: invalid-ring
[786.987631] Subtest invalid-ring: SUCCESS (0.000s)
[787.124939] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: gem_linear_blits
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: i915_query
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_pxp
results: parsing output: 15/ for test: device_reset
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_joiner
results: parsing output: 24/ for test: gem_render_copy_redux
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_sequence
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_chamelium_audio
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_mmap
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_feature_discovery
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: gem_exec_store
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: gem_blits
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: i915_getparams_basic
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: prime_vgem
results: parsing output: 86/ for test: kms_properties
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_debugfs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_cursor
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: prime_busy
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: sysfs_preempt_timeout
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_atomic_interruptible
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_force_connector_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: gem_spin_batch
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: gem_exec_params
Done.