[54.886184] Initializing watchdogs
[54.886233]   /dev/watchdog0
[54.903012] [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]
[54.907506] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.909874] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.913204] [001/133] (960s left) perf (oa-formats)
[55.065903] Starting subtest: oa-formats
[55.067843] Starting dynamic subtest: 0-rcs0
[55.079935] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[55.088140] Starting dynamic subtest: 1-vcs1
[55.104241] Dynamic subtest 1-vcs1: SUCCESS (0.024s)
[55.106448] Subtest oa-formats: SUCCESS (0.040s)
[55.153995] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[55.254052] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[55.258070] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[55.365429] [003/133] (960s left) prime_self_import (export-vs-gem_close-race)
[55.399172] Starting subtest: export-vs-gem_close-race
[60.500613] Subtest export-vs-gem_close-race: SUCCESS (5.099s)
[60.597177] [004/133] (954s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[60.725112] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[60.737627] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[60.868277] [005/133] (954s left) kms_cursor_crc (cursor-offscreen-64x21)
[61.085354] Starting subtest: cursor-offscreen-64x21
[61.141444] Subtest cursor-offscreen-64x21: SKIP (0.050s)
[61.409927] [006/133] (954s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_dec)
[61.545584] Subtest plane-XR30-XR30-ctm_3x4_bt709_dec: SKIP (0.000s)
[61.640762] [007/133] (953s left) gem_ctx_param (invalid-ctx-get)
[61.699545] Starting subtest: invalid-ctx-get
[61.701696] Subtest invalid-ctx-get: SUCCESS (0.000s)
[61.782264] [008/133] (953s left) kms_prime (basic-modeset-hybrid)
[61.866535] Subtest basic-modeset-hybrid: SKIP (0.000s)
[61.977490] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[61.980471] [009/133] (953s left) gen9_exec_parse (cmd-crossing-page)
[62.042671] Subtest cmd-crossing-page: SKIP (0.000s)
[62.134437] [010/133] (953s left) i915_fb_tiling (basic-x-tiling)
[62.210206] Subtest basic-x-tiling: SKIP (0.000s)
[62.279691] [011/133] (953s left) gem_caching (writes)
[62.343305] Subtest writes: SKIP (0.000s)
[62.425075] [012/133] (953s left) gem_exec_capture (pi)
[62.497756] Starting subtest: pi
[62.499772] Starting dynamic subtest: rcs0
[66.886617] Dynamic subtest rcs0: SUCCESS (4.392s)
[66.894535] Starting dynamic subtest: bcs0
[71.396131] Dynamic subtest bcs0: SUCCESS (4.507s)
[71.406665] Starting dynamic subtest: vcs0
[75.722538] Dynamic subtest vcs0: SUCCESS (4.328s)
[75.731045] Starting dynamic subtest: vcs1
[79.880349] Dynamic subtest vcs1: SUCCESS (4.157s)
[79.889150] Starting dynamic subtest: vecs0
[84.044945] Dynamic subtest vecs0: SUCCESS (4.164s)
[84.053516] Starting dynamic subtest: ccs0
[88.314283] Dynamic subtest ccs0: SUCCESS (4.268s)
[88.317432] Subtest pi: SUCCESS (25.822s)
[88.417362] [013/133] (927s left) kms_big_fb (linear-64bpp-rotate-0)
[88.569378] Starting subtest: linear-64bpp-rotate-0
[90.226446] Subtest linear-64bpp-rotate-0: SUCCESS (1.658s)
[90.430741] [014/133] (925s left) gem_exec_reloc (basic-concurrent0)
[90.494085] Subtest basic-concurrent0: SKIP (0.000s)
[90.559400] [015/133] (925s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[90.656132] Starting subtest: primary-y-tiled-reflect-x-0
[90.715802] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[90.828839] [016/133] (925s left) gem_tiled_blits (basic)
[90.876304] Subtest basic: SKIP (0.000s)
[90.966190] [017/133] (925s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[91.070071] Starting subtest: plane-upscale-20x20-with-rotation
[91.072230] Starting dynamic subtest: pipe-A
[91.293987] Dynamic subtest pipe-A: SUCCESS (0.226s)
[91.302852] Starting dynamic subtest: pipe-B
[92.574964] Dynamic subtest pipe-B: SUCCESS (1.281s)
[92.583936] Starting dynamic subtest: pipe-C
[93.898295] Dynamic subtest pipe-C: SUCCESS (1.323s)
[93.907289] Starting dynamic subtest: pipe-D
[95.233493] Dynamic subtest pipe-D: SUCCESS (1.335s)
[95.235935] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.166s)
[96.429819] [018/133] (919s left) dmabuf_sync_file (export-wait-after-attach)
[96.472021] Starting subtest: export-wait-after-attach
[96.473876] Subtest export-wait-after-attach: SUCCESS (0.001s)
[96.539075] [019/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[96.646654] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[96.651235] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[96.766660] [020/133] (919s left) kms_flip (flip-vs-modeset-vs-hang)
[96.869560] Starting subtest: flip-vs-modeset-vs-hang
[96.871918] Starting dynamic subtest: A-eDP1
[148.401507] Dynamic subtest A-eDP1: SUCCESS (51.527s)
[148.415772] Starting dynamic subtest: D-eDP1
[198.381146] Dynamic subtest D-eDP1: SUCCESS (49.975s)
[198.384077] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.506s)
[198.784752] [021/133] (817s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[198.876183] Starting subtest: plane-scaler-unity-scaling-with-rotation
[198.878464] Starting dynamic subtest: pipe-A
[199.104739] Dynamic subtest pipe-A: SUCCESS (0.231s)
[199.114375] Starting dynamic subtest: pipe-B
[200.374699] Dynamic subtest pipe-B: SUCCESS (1.270s)
[200.384271] Starting dynamic subtest: pipe-C
[201.697101] Dynamic subtest pipe-C: SUCCESS (1.322s)
[201.706258] Starting dynamic subtest: pipe-D
[203.020445] Dynamic subtest pipe-D: SUCCESS (1.323s)
[203.022809] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.147s)
[204.206776] [022/133] (812s left) kms_cursor_crc (cursor-alpha-transparent)
[204.304990] Starting subtest: cursor-alpha-transparent
[204.307354] Starting dynamic subtest: pipe-A-eDP-1
[204.929044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[204.937632] Starting dynamic subtest: pipe-D-eDP-1
[206.181733] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[206.184405] Subtest cursor-alpha-transparent: SUCCESS (1.876s)
[207.000329] [023/133] (809s left) vgem_basic (dmabuf-mmap)
[207.040733] Starting subtest: dmabuf-mmap
[207.075832] Subtest dmabuf-mmap: SUCCESS (0.037s)
[207.159398] [024/133] (809s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[207.211279] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[207.321059] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[207.407418] [025/133] (808s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[207.498681] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[208.575840] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.077s)
[208.746305] [026/133] (807s left) i915_suspend (fence-restore-untiled)
[208.808323] Starting subtest: fence-restore-untiled
[208.811809] Subtest fence-restore-untiled: SKIP (0.000s)
[208.946909] [027/133] (807s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[209.048927] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[209.875712] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.828s)
[210.096819] [028/133] (806s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[210.203586] Starting subtest: fbc-farfromfence-mmap-gtt
[210.208077] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[210.312813] [029/133] (806s left) kms_plane_multiple (2x-tiling-yf)
[210.399754] Starting subtest: 2x-tiling-yf
[210.404234] Subtest 2x-tiling-yf: SKIP (0.000s)
[210.482935] [030/133] (806s left) kms_chamelium_color (gamma)
[210.578424] Subtest gamma: SKIP (0.000s)
[210.623140] [031/133] (805s left) gem_ctx_shared (q-smoketest)
[210.691594] Starting subtest: Q-smoketest
[210.693918] Starting dynamic subtest: rcs0
[216.239195] Dynamic subtest rcs0: SUCCESS (5.504s)
[216.248842] Starting dynamic subtest: bcs0
[221.747531] Dynamic subtest bcs0: SUCCESS (5.502s)
[221.760367] Starting dynamic subtest: vcs0
[227.229996] Dynamic subtest vcs0: SUCCESS (5.482s)
[227.240386] Starting dynamic subtest: vcs1
[232.701689] Dynamic subtest vcs1: SUCCESS (5.472s)
[232.709721] Starting dynamic subtest: vecs0
[238.173234] Dynamic subtest vecs0: SUCCESS (5.470s)
[238.182194] Starting dynamic subtest: ccs0
[243.679618] Dynamic subtest ccs0: SUCCESS (5.506s)
[243.681584] Subtest Q-smoketest: SUCCESS (32.940s)
[243.828339] [032/133] (772s left) kms_async_flips (test-time-stamp-atomic)
[243.938520] Starting subtest: test-time-stamp-atomic
[244.311940] Starting dynamic subtest: pipe-A-eDP-1
[245.536313] Dynamic subtest pipe-A-eDP-1: FAIL (0.754s)
[245.546286] Starting dynamic subtest: pipe-B-eDP-1
[246.455038] Dynamic subtest pipe-B-eDP-1: FAIL (0.736s)
[246.583020] Starting dynamic subtest: pipe-C-eDP-1
[247.347964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[247.721204] Starting dynamic subtest: pipe-D-eDP-1
[248.473468] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.760s)
[248.475985] Subtest test-time-stamp-atomic: FAIL (4.535s)
[249.658472] [033/133] (767s left) kms_pm_rpm (modeset-lpsp)
[251.188503] Starting subtest: modeset-lpsp
[252.670706] Subtest modeset-lpsp: SUCCESS (1.483s)
[252.808168] [034/133] (763s left) gem_pxp (reject-modify-context-protection-off-1)
[252.935257] Starting subtest: reject-modify-context-protection-off-1
[252.937891] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[253.060845] [035/133] (763s left) kms_chamelium_frames (dp-frame-dump)
[253.437624] Subtest dp-frame-dump: SKIP (0.000s)
[254.238932] [036/133] (762s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[254.343759] Starting subtest: psr-2p-pri-indfb-multidraw
[254.347808] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[254.472122] [037/133] (762s left) api_intel_bb (object-reloc-purge-cache)
[254.527036] Starting subtest: object-reloc-purge-cache
[254.531586] Subtest object-reloc-purge-cache: SKIP (0.002s)
[254.669611] [038/133] (762s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[254.742209] Starting subtest: invalid-bsd1-flag-on-vebox
[254.744255] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[254.865256] [039/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[254.958641] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[254.962792] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[255.093191] [040/133] (761s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[255.192124] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[255.193696] Starting dynamic subtest: pipe-A-eDP-1
[256.506722] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.313s)
[256.788916] Starting dynamic subtest: pipe-B-eDP-1
[257.836145] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[258.109479] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.917s)
[258.972148] [041/133] (758s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[263.945653] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[263.948055] Starting dynamic subtest: pipe-A-eDP-1
[264.730063] Dynamic subtest pipe-A-eDP-1: SKIP (0.779s)
[264.739066] Starting dynamic subtest: pipe-B-eDP-1
[265.850434] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[265.854889] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.903s)
[267.043877] [042/133] (749s left) gem_exec_balancer (bonded-chain)
[267.107508] Starting subtest: bonded-chain
[274.101511] Subtest bonded-chain: SUCCESS (6.992s)
[274.951969] [043/133] (742s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[275.065786] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[275.070206] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[276.185416] [044/133] (740s left) gem_mmap_wc (bad-offset)
[276.243611] Subtest bad-offset: SKIP (0.000s)
[276.306745] [045/133] (740s left) kms_busy (extended-pageflip-hang-oldfb)
[276.395987] Starting subtest: extended-pageflip-hang-oldfb
[276.397904] Starting dynamic subtest: pipe-A
[276.785485] Dynamic subtest pipe-A: SUCCESS (0.388s)
[276.794282] Starting dynamic subtest: pipe-D
[277.909088] Dynamic subtest pipe-D: SUCCESS (1.121s)
[277.911339] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.514s)
[278.746971] [046/133] (738s left) sysfs_heartbeat_interval (nopreempt)
[278.808058] Starting subtest: nopreempt
[278.810405] Starting dynamic subtest: vecs0
[288.926878] Dynamic subtest vecs0: SUCCESS (10.115s)
[288.937215] Starting dynamic subtest: ccs0
[292.973759] Dynamic subtest ccs0: SUCCESS (4.046s)
[292.984278] Starting dynamic subtest: vcs0
[301.940404] Dynamic subtest vcs0: SUCCESS (8.966s)
[301.952317] Starting dynamic subtest: bcs0
[305.935720] Dynamic subtest bcs0: SUCCESS (3.993s)
[305.946527] Starting dynamic subtest: rcs0
[310.057749] Dynamic subtest rcs0: SUCCESS (4.121s)
[310.068059] Starting dynamic subtest: vcs1
[319.893258] Dynamic subtest vcs1: SUCCESS (9.833s)
[319.895808] Subtest nopreempt: SUCCESS (41.085s)
[319.986129] [047/133] (697s left) kms_lease (lease-invalid-plane)
[320.079337] Starting subtest: lease-invalid-plane
[320.081691] Starting dynamic subtest: pipe-A-eDP-1
[320.084043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[320.093806] Starting dynamic subtest: pipe-B-eDP-1
[320.096068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[320.104516] Starting dynamic subtest: pipe-C-eDP-1
[320.106420] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[320.114815] Starting dynamic subtest: pipe-D-eDP-1
[320.117056] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[320.119211] Subtest lease-invalid-plane: SUCCESS (0.004s)
[320.179501] [048/133] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[320.277818] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[327.582363] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.308s)
[327.731270] [049/133] (689s left) api_intel_allocator (alloc-simple)
[327.795407] Starting subtest: alloc-simple
[327.800578] Subtest alloc-simple: SUCCESS (0.005s)
[327.932435] [050/133] (689s left) kms_psr (psr2-cursor-mmap-cpu)
[328.039150] Starting subtest: psr2-cursor-mmap-cpu
[328.041316] Starting dynamic subtest: eDP-1
[329.734174] Dynamic subtest eDP-1: SUCCESS (1.693s)
[329.736479] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.695s)
[330.539911] [051/133] (686s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[330.603485] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[330.608042] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[330.798285] [052/133] (686s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[330.880927] Starting subtest: fbc-psr2-sprite-mmap-cpu
[330.883234] Starting dynamic subtest: eDP-1
[330.887616] Dynamic subtest eDP-1: SKIP (0.000s)
[330.891881] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[330.965907] [053/133] (686s left) gem_exec_reloc (basic-wc-active)
[331.040217] Subtest basic-wc-active: SKIP (0.000s)
[331.124026] [054/133] (686s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[331.240458] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[332.630319] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.389s)
[333.531101] [055/133] (684s left) syncobj_timeline (invalid-wait-bad-flags)
[333.587066] Starting subtest: invalid-wait-bad-flags
[333.589306] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[333.714241] [056/133] (683s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[333.811462] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[333.823903] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[333.914953] [057/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[334.013383] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[334.017374] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[334.120400] [058/133] (683s left) gem_spin_batch (resubmit-new)
[334.188531] Starting subtest: resubmit-new
[334.190752] Starting dynamic subtest: rcs0
[334.197297] Dynamic subtest rcs0: SUCCESS (0.009s)
[334.206936] Starting dynamic subtest: bcs0
[334.209601] Dynamic subtest bcs0: SUCCESS (0.004s)
[334.221364] Starting dynamic subtest: vcs0
[334.223842] Dynamic subtest vcs0: SUCCESS (0.005s)
[334.232078] Starting dynamic subtest: vcs1
[334.234098] Dynamic subtest vcs1: SUCCESS (0.004s)
[334.242095] Starting dynamic subtest: vecs0
[334.244244] Dynamic subtest vecs0: SUCCESS (0.004s)
[334.252495] Starting dynamic subtest: ccs0
[334.254603] Dynamic subtest ccs0: SUCCESS (0.004s)
[334.256672] Subtest resubmit-new: SUCCESS (0.034s)
[335.955766] [059/133] (681s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[336.045858] Starting subtest: basic-modeset-with-all-modifiers-formats
[336.436625] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[337.794418] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: FAIL (0.758s)
[337.803919] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[337.939926] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: FAIL (0.470s)
[337.949757] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[338.063864] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: FAIL (0.018s)
[338.073093] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[338.368192] Dynamic subtest pipe-A-eDP-1-4-RGB565: FAIL (0.560s)
[338.376424] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[338.484105] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: FAIL (0.017s)
[338.493415] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[338.605178] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: FAIL (0.008s)
[338.614860] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[338.725693] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: FAIL (0.010s)
[338.733540] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[338.844775] Dynamic subtest pipe-A-eDP-1-4-YUYV: FAIL (0.408s)
[338.853227] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[338.957781] Dynamic subtest pipe-A-eDP-1-4-Y210: FAIL (0.016s)
[338.966016] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[339.071113] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: FAIL (0.009s)
[339.079305] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[339.186174] Dynamic subtest pipe-A-eDP-1-4-XV30: FAIL (0.016s)
[339.195657] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[339.303211] Dynamic subtest pipe-A-eDP-1-4-XV36: FAIL (0.389s)
[339.312393] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[339.613346] Dynamic subtest pipe-A-eDP-1-x-RGB565: FAIL (0.145s)
[339.623102] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[339.735040] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: FAIL (0.006s)
[339.744752] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[339.851393] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: FAIL (0.411s)
[339.859866] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[339.964834] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: FAIL (0.016s)
[339.972860] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[340.077328] Dynamic subtest pipe-A-eDP-1-x-YUYV: FAIL (0.009s)
[340.084664] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[340.192522] Dynamic subtest pipe-A-eDP-1-x-Y210: FAIL (0.010s)
[340.201635] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[340.310152] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: FAIL (0.393s)
[340.318801] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[340.429882] Dynamic subtest pipe-A-eDP-1-x-XV30: FAIL (0.017s)
[340.439650] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[340.551446] Dynamic subtest pipe-A-eDP-1-x-XV36: FAIL (0.008s)
[340.561566] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[340.843999] Dynamic subtest pipe-A-eDP-1-linear-RGB565: FAIL (0.170s)
[340.854175] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[340.964811] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: FAIL (0.404s)
[340.973602] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[341.078592] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: FAIL (0.015s)
[341.086727] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[341.191509] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: FAIL (0.010s)
[341.199752] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[341.310305] Dynamic subtest pipe-A-eDP-1-linear-YUYV: FAIL (0.400s)
[341.319817] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[341.428138] Dynamic subtest pipe-A-eDP-1-linear-Y210: FAIL (0.019s)
[341.438059] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[341.550706] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: FAIL (0.008s)
[341.560854] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[341.670838] Dynamic subtest pipe-A-eDP-1-linear-XV30: FAIL (0.010s)
[341.681432] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[341.789910] Dynamic subtest pipe-A-eDP-1-linear-XV36: FAIL (0.411s)
[342.014648] Subtest basic-modeset-with-all-modifiers-formats: FAIL (5.970s)
[342.784961] [060/133] (674s left) syncobj_eventfd (invalid-bad-pad)
[342.833970] Starting subtest: invalid-bad-pad
[342.836234] Subtest invalid-bad-pad: SUCCESS (0.000s)
[342.951105] [061/133] (674s left) kms_sequence (get-forked-busy)
[343.035012] Starting subtest: get-forked-busy
[343.037245] Starting dynamic subtest: pipe-A-eDP-1
[344.960939] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[344.970127] Starting dynamic subtest: pipe-B-eDP-1
[347.565968] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.603s)
[347.575530] Starting dynamic subtest: pipe-C-eDP-1
[350.195799] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.630s)
[350.205910] Starting dynamic subtest: pipe-D-eDP-1
[352.832722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s)
[352.835089] Subtest get-forked-busy: SUCCESS (9.798s)
[353.728397] [062/133] (664s left) gem_ctx_param (set-priority-not-supported)
[353.792755] Starting subtest: set-priority-not-supported
[353.797271] Subtest set-priority-not-supported: SKIP (0.000s)
[353.878871] [063/133] (663s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[354.009264] Starting subtest: 2x-flip-vs-cursor-legacy
[354.013893] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[354.167041] [064/133] (663s left) gem_pipe_control_store_loop (fresh-buffer)
[354.230444] Starting subtest: fresh-buffer
[356.386089] Subtest fresh-buffer: SUCCESS (2.154s)
[356.546300] [065/133] (661s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[356.659166] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[356.663143] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[356.783630] [066/133] (661s left) kms_writeback (writeback-check-output)
[356.887127] Subtest writeback-check-output: SKIP (0.000s)
[356.935395] [067/133] (661s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[357.030493] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[357.032648] Starting dynamic subtest: pipe-A-eDP-1
[357.056331] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.066963] Starting dynamic subtest: pipe-B-eDP-1
[357.088562] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.097028] Starting dynamic subtest: pipe-C-eDP-1
[357.118765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.127021] Starting dynamic subtest: pipe-D-eDP-1
[357.149186] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.153186] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[359.299284] [068/133] (658s left) gem_create (busy-create)
[359.370183] Starting subtest: busy-create
[359.372584] Starting dynamic subtest: smem0
[392.956782] Dynamic subtest smem0: SUCCESS (33.585s)
[392.959163] Subtest busy-create: SUCCESS (33.587s)
[393.168736] [069/133] (624s left) gem_eio (wait-immediate)
[393.428846] Starting subtest: wait-immediate
[393.830442] Subtest wait-immediate: SUCCESS (0.401s)
[393.986611] [070/133] (624s left) kms_cursor_crc (cursor-sliding-32x32)
[394.127433] Starting subtest: cursor-sliding-32x32
[394.178265] Subtest cursor-sliding-32x32: SKIP (0.047s)
[394.477435] [071/133] (623s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[394.577581] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[394.579216] Starting dynamic subtest: pipe-A-eDP-1
[395.861933] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.285s)
[395.870395] Starting dynamic subtest: pipe-B-eDP-1
[398.209506] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.345s)
[398.220434] Starting dynamic subtest: pipe-C-eDP-1
[400.539480] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.329s)
[400.548686] Starting dynamic subtest: pipe-D-eDP-1
[402.880376] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.340s)
[402.882670] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.305s)
[404.127360] [072/133] (614s left) gem_userptr_blits (coherency-sync)
[404.194218] Starting subtest: coherency-sync
[404.405074] Subtest coherency-sync: SKIP (0.171s)
[404.530186] [073/133] (613s left) gem_readwrite (write-bad-handle)
[404.634779] Subtest write-bad-handle: SKIP (0.000s)
[404.701399] [074/133] (613s left) gem_wait (busy)
[404.766439] Starting subtest: busy
[404.768834] Starting dynamic subtest: all-engines
[405.909300] Dynamic subtest all-engines: SUCCESS (1.140s)
[405.924900] Starting dynamic subtest: rcs0
[406.450706] Dynamic subtest rcs0: SUCCESS (0.540s)
[406.461061] Starting dynamic subtest: bcs0
[406.991557] Dynamic subtest bcs0: SUCCESS (0.540s)
[407.001561] Starting dynamic subtest: vcs0
[408.916484] Dynamic subtest vcs0: SUCCESS (1.923s)
[408.928350] Starting dynamic subtest: vcs1
[410.900241] Dynamic subtest vcs1: SUCCESS (1.981s)
[410.911124] Starting dynamic subtest: vecs0
[412.883929] Dynamic subtest vecs0: SUCCESS (1.981s)
[412.895890] Starting dynamic subtest: ccs0
[413.428755] Dynamic subtest ccs0: SUCCESS (0.543s)
[413.431782] Subtest busy: SUCCESS (8.662s)
[413.638097] [075/133] (604s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[413.697128] Starting subtest: legacy-engines-hostile-preempt
[413.699283] Starting dynamic subtest: render
[413.804698] Dynamic subtest render: SUCCESS (0.107s)
[413.818232] Starting dynamic subtest: bsd1
[414.939110] Dynamic subtest bsd1: SUCCESS (1.130s)
[414.950065] Starting dynamic subtest: bsd2
[416.891802] Dynamic subtest bsd2: SUCCESS (1.949s)
[416.906493] Starting dynamic subtest: blt
[417.013079] Dynamic subtest blt: SUCCESS (0.119s)
[417.023984] Starting dynamic subtest: vebox
[418.882425] Dynamic subtest vebox: SUCCESS (1.865s)
[418.885076] Subtest legacy-engines-hostile-preempt: SUCCESS (5.185s)
[419.029094] [076/133] (599s left) kms_dsc (dsc-with-bpc)
[419.140993] Starting subtest: dsc-with-bpc
[419.171985] Subtest dsc-with-bpc: SKIP (0.001s)
[419.241172] [077/133] (599s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[419.292707] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[419.401207] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[419.501627] [078/133] (598s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[419.612922] Starting subtest: cursorB-vs-flipA-varying-size
[419.617535] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[419.770169] [079/133] (598s left) gem_exec_whisper (basic-queues-priority-all)
[419.840839] Starting subtest: basic-queues-priority-all
[442.298941] Subtest basic-queues-priority-all: SUCCESS (22.453s)
[442.493271] [080/133] (576s left) kms_psr (psr-sprite-plane-onoff)
[442.597081] Starting subtest: psr-sprite-plane-onoff
[442.599360] Starting dynamic subtest: eDP-1
[444.351748] Dynamic subtest eDP-1: SUCCESS (1.752s)
[444.353702] Subtest psr-sprite-plane-onoff: SUCCESS (1.753s)
[445.184094] [081/133] (573s left) gem_ctx_isolation (clean)
[445.251248] Starting subtest: clean
[445.253410] Starting dynamic subtest: rcs0
[445.316879] Dynamic subtest rcs0: SUCCESS (0.065s)
[445.328059] Starting dynamic subtest: bcs0
[445.416675] Dynamic subtest bcs0: SUCCESS (0.098s)
[445.426506] Starting dynamic subtest: vcs0
[445.499794] Dynamic subtest vcs0: SUCCESS (0.083s)
[445.510405] Starting dynamic subtest: vcs1
[446.979826] Dynamic subtest vcs1: SUCCESS (1.479s)
[446.991614] Starting dynamic subtest: vecs0
[448.925411] Dynamic subtest vecs0: SUCCESS (1.944s)
[448.936035] Starting dynamic subtest: ccs0
[450.942963] Dynamic subtest ccs0: SUCCESS (2.017s)
[450.945517] Subtest clean: SUCCESS (5.692s)
[451.201299] [082/133] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[451.306173] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[451.310500] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[451.443910] [083/133] (567s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[451.547175] Starting subtest: 2x-absolute-wf_vblank-interruptible
[451.558349] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[451.646900] [084/133] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[451.740597] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[456.239599] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.502s)
[457.384478] [085/133] (561s left) kms_joiner (basic-max-non-joiner)
[457.489335] Starting subtest: basic-max-non-joiner
[457.493259] Subtest basic-max-non-joiner: SKIP (0.000s)
[457.565158] [086/133] (561s left) i915_pm_rpm (gem-mmap-type)
[459.133411] Starting subtest: gem-mmap-type
[459.135873] Starting dynamic subtest: wb-smem0
[462.678375] Dynamic subtest wb-smem0: SUCCESS (3.547s)
[462.687350] Starting dynamic subtest: wc-smem0
[465.536212] Dynamic subtest wc-smem0: SUCCESS (2.857s)
[465.545717] Starting dynamic subtest: uc-smem0
[468.405595] Dynamic subtest uc-smem0: SUCCESS (2.868s)
[468.407963] Subtest gem-mmap-type: SUCCESS (9.276s)
[468.502961] [087/133] (550s left) perf_pmu (event-wait)
[468.543484] Starting subtest: event-wait
[468.545667] Starting dynamic subtest: rcs0
[468.550417] Dynamic subtest rcs0: SKIP (0.000s)
[468.554723] Subtest event-wait: SKIP (0.001s)
[468.683722] [088/133] (550s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[468.770149] Starting subtest: fbc-psr2-cursor-plane-onoff
[468.772371] Starting dynamic subtest: eDP-1
[468.776549] Dynamic subtest eDP-1: SKIP (0.000s)
[468.780645] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[468.854164] [089/133] (550s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[468.974320] Starting subtest: modeset-atomic-cursor-hotspot
[468.978733] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[469.145341] [090/133] (549s left) gem_set_tiling_vs_pwrite
[469.268943] [091/133] (549s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[469.366129] Starting subtest: psr-rgb101010-draw-pwrite
[477.014540] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.651s)
[477.163360] [092/133] (541s left) kms_addfb_basic (bad-pitch-63)
[477.221779] Starting subtest: bad-pitch-63
[477.223784] Subtest bad-pitch-63: SUCCESS (0.000s)
[477.394245] [093/133] (541s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[477.448571] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[477.513889] [094/133] (541s left) gem_blits (basic)
[477.575085] Starting subtest: basic
[479.016968] Subtest basic: SUCCESS (1.440s)
[479.157122] [095/133] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[479.258304] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[479.262515] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[479.383470] [096/133] (539s left) gem_exec_whisper (basic-fds-forked)
[479.442065] Starting subtest: basic-fds-forked
[504.615475] Subtest basic-fds-forked: SUCCESS (25.165s)
[504.809496] [097/133] (514s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[504.915465] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[512.361399] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.447s)
[512.535355] [098/133] (506s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[512.642360] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[512.644616] Starting dynamic subtest: pipe-A-eDP-1
[512.653795] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.665473] Starting dynamic subtest: pipe-B-eDP-1
[512.675232] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.685893] Starting dynamic subtest: pipe-C-eDP-1
[512.694538] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[512.703440] Starting dynamic subtest: pipe-D-eDP-1
[512.712154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[512.716566] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[514.968225] [099/133] (504s left) gem_mmap_gtt (fault-concurrent-x)
[515.039215] Subtest fault-concurrent-X: SKIP (0.000s)
[515.099428] [100/133] (504s left) gem_mmap_gtt (basic-small-bo-tiledy)
[515.151154] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[515.213294] [101/133] (504s left) gem_exec_reloc (basic-wc-gtt)
[515.274766] Subtest basic-wc-gtt: SKIP (0.000s)
[515.344838] [102/133] (504s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[515.442736] Starting subtest: stress-xrgb8888-yftiled
[515.447151] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[515.520591] [103/133] (504s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[515.614086] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[515.616352] Starting dynamic subtest: pipe-A-default-mode
[515.904759] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[515.909410] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[516.794533] [104/133] (502s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[516.894228] Starting subtest: x-tiled-64bpp-rotate-0
[518.529778] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.635s)
[518.742686] [105/133] (500s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[518.801631] Starting subtest: single-wait-for-submit-available-submitted
[518.803821] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[518.922543] [106/133] (500s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[519.019183] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[519.023194] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[519.149877] [107/133] (500s left) vgem_basic (second-client)
[519.201166] Starting subtest: second-client
[519.225093] Subtest second-client: SUCCESS (0.021s)
[519.290826] [108/133] (500s left) gem_exec_schedule (pi-distinct-iova)
[519.485736] Starting subtest: pi-distinct-iova
[519.488104] Starting dynamic subtest: rcs0
[519.567376] Dynamic subtest rcs0: SUCCESS (0.085s)
[519.580397] Starting dynamic subtest: vcs0
[519.628649] Dynamic subtest vcs0: SUCCESS (0.059s)
[519.640391] Starting dynamic subtest: vcs1
[519.686070] Dynamic subtest vcs1: SUCCESS (0.057s)
[519.701163] Starting dynamic subtest: vecs0
[519.742331] Dynamic subtest vecs0: SUCCESS (0.055s)
[519.753699] Starting dynamic subtest: ccs0
[519.818691] Dynamic subtest ccs0: SUCCESS (0.074s)
[519.822026] Subtest pi-distinct-iova: SUCCESS (0.338s)
[521.016235] [109/133] (498s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[521.110604] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[521.112915] Starting dynamic subtest: pipe-A-default-mode
[521.407333] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[521.411807] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.295s)
[522.219735] [110/133] (497s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[522.320508] Starting subtest: drrs-dirtyfb-ioctl
[522.333468] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[522.442974] [111/133] (497s left) kms_colorop (plane-xr30-xr30-bypass)
[522.583320] Subtest plane-XR30-XR30-bypass: SKIP (0.000s)
[522.662369] [112/133] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[522.758820] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[526.742951] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.987s)
[527.937276] [113/133] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[528.028639] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[528.032850] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[528.167656] [114/133] (491s left) gem_exec_schedule (timeslicing)
[528.245965] Starting subtest: timeslicing
[528.247954] Starting dynamic subtest: rcs0
[528.261315] Dynamic subtest rcs0: SUCCESS (0.022s)
[528.271915] Starting dynamic subtest: bcs0
[528.283713] Dynamic subtest bcs0: SUCCESS (0.021s)
[528.298441] Starting dynamic subtest: vcs0
[528.305265] Dynamic subtest vcs0: SUCCESS (0.020s)
[528.314875] Starting dynamic subtest: vcs1
[528.326795] Dynamic subtest vcs1: SUCCESS (0.021s)
[528.336574] Starting dynamic subtest: vecs0
[528.347067] Dynamic subtest vecs0: SUCCESS (0.020s)
[528.356810] Starting dynamic subtest: ccs0
[528.367536] Dynamic subtest ccs0: SUCCESS (0.020s)
[528.369876] Subtest timeslicing: SUCCESS (0.129s)
[529.929685] [115/133] (490s left) kms_psr (fbc-psr-sprite-plane-move)
[530.029188] Starting subtest: fbc-psr-sprite-plane-move
[530.031504] Starting dynamic subtest: eDP-1
[530.035841] Dynamic subtest eDP-1: SKIP (0.000s)
[530.040253] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[530.130962] [116/133] (489s left) perf (stress-open-close)
[530.257942] Starting subtest: stress-open-close
[530.260249] Starting dynamic subtest: 0-rcs0
[532.420956] Dynamic subtest 0-rcs0: SUCCESS (2.167s)
[532.430124] Starting dynamic subtest: 1-vecs0
[534.585362] Dynamic subtest 1-vecs0: SUCCESS (2.163s)
[534.587422] Subtest stress-open-close: SUCCESS (4.332s)
[534.636468] [117/133] (485s left) kms_atomic_interruptible (legacy-cursor)
[534.724997] Starting subtest: legacy-cursor
[534.726928] Starting dynamic subtest: pipe-A-eDP-1
[542.133894] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.405s)
[542.136398] Subtest legacy-cursor: SUCCESS (7.407s)
[542.988714] [118/133] (477s left) kms_chamelium_hpd (hdmi-hpd)
[543.373840] Subtest hdmi-hpd: SKIP (0.000s)
[544.184452] [119/133] (476s left) vgem_basic (unload)
[544.218419] Starting subtest: unload
[573.402921] Subtest unload: SUCCESS (29.185s)
[573.512206] [120/133] (446s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[573.606463] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[573.610582] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[573.730044] [121/133] (446s left) kms_getfb (getfb2-handle-protection)
[573.836344] Starting subtest: getfb2-handle-protection
[573.864904] Subtest getfb2-handle-protection: SUCCESS (0.030s)
[574.004774] [122/133] (446s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[574.097942] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[574.102409] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[574.203833] [123/133] (446s left) gem_exec_fence (long-history)
[574.617944] Starting subtest: long-history
[581.618787] Subtest long-history: SUCCESS (7.001s)
[582.481734] [124/133] (437s left) kms_colorop (plane-xr24-xr24-ctm_3x4_bt709_dec)
[582.611852] Subtest plane-XR24-XR24-ctm_3x4_bt709_dec: SKIP (0.000s)
[582.708949] [125/133] (437s left) gem_flink_basic (double-flink)
[582.764764] Starting subtest: double-flink
[582.767091] Subtest double-flink: SUCCESS (0.000s)
[582.888116] [126/133] (437s left) i915_drm_fdinfo (most-busy-check-all)
[582.933565] Starting subtest: most-busy-check-all
[582.936097] Starting dynamic subtest: rcs0
[582.941157] Dynamic subtest rcs0: SKIP (0.005s)
[582.956155] Starting dynamic subtest: bcs0
[582.960572] Dynamic subtest bcs0: SKIP (0.000s)
[582.971317] Starting dynamic subtest: vcs0
[582.975282] Dynamic subtest vcs0: SKIP (0.000s)
[582.983640] Starting dynamic subtest: vcs1
[582.987742] Dynamic subtest vcs1: SKIP (0.000s)
[582.996214] Starting dynamic subtest: vecs0
[583.000358] Dynamic subtest vecs0: SKIP (0.000s)
[583.008915] Starting dynamic subtest: ccs0
[583.012977] Dynamic subtest ccs0: SKIP (0.000s)
[583.017048] Subtest most-busy-check-all: SKIP (0.010s)
[583.055209] [127/133] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[583.187585] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[583.191487] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[583.317083] [128/133] (437s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[583.406125] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[590.237327] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.832s)
[590.384399] [129/133] (430s left) gem_tiled_fence_blits (basic)
[590.437676] Subtest basic: SKIP (0.000s)
[590.514785] [130/133] (430s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[590.569660] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[590.653290] [131/133] (430s left) gem_exec_params (invalid-bsd2-flag-on-render)
[590.716475] Starting subtest: invalid-bsd2-flag-on-render
[590.718444] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[590.837505] [132/133] (429s left) kms_vblank (wait-forked-hang)
[590.928354] Starting subtest: wait-forked-hang
[590.930565] Starting dynamic subtest: pipe-A-eDP-1
[618.637847] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.708s)
[618.653310] Starting dynamic subtest: pipe-D-eDP-1
[633.687288] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.046s)
[633.689575] Subtest wait-forked-hang: SUCCESS (42.759s)
[634.516879] [133/133] (386s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[639.492170] Starting subtest: psr2-cursor-plane-move-continuous-sf
[639.494531] Starting dynamic subtest: pipe-A-eDP-1
[650.564142] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.073s)
[650.577719] Starting dynamic subtest: pipe-B-eDP-1
[661.588837] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.018s)
[661.591375] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.096s)
[662.413987] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_self_import
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_colorop
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: kms_prime
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: i915_fb_tiling
results: parsing output: 10/ for test: gem_caching
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: gem_tiled_blits
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: dmabuf_sync_file
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: i915_suspend
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: gem_ctx_shared
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_chamelium_frames
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_atomic_transition
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: sysfs_heartbeat_interval
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: api_intel_allocator
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_spin_batch
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: syncobj_eventfd
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_pipe_control_store_loop
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_writeback
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: gem_readwrite
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_dsc
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ctx_isolation
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_joiner
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: gem_blits
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_pipe_stress
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_dirtyfb
results: parsing output: 110/ for test: kms_colorop
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_colorop
results: parsing output: 124/ for test: gem_flink_basic
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_frontbuffer_tracking
results: parsing output: 128/ for test: gem_tiled_fence_blits
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_psr2_sf
Done.