[60.578344] Initializing watchdogs
[60.578408]   /dev/watchdog0
[60.598186] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.609284] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.613086] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.615380] [001/131] (960s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[60.693975] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[60.782532] [002/131] (960s left) gem_exec_fence (syncobj-invalid-flags)
[61.333411] Starting subtest: syncobj-invalid-flags
[61.334265] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[61.736960] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[61.738947] [003/131] (959s left) gem_linear_blits (normal)
[62.016415] Starting subtest: normal
[69.959371] Subtest normal: SUCCESS (7.943s)
[70.384516] [004/131] (950s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[70.629989] Starting subtest: flip-vs-cursor-crc-legacy
[71.264260] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.634s)
[71.525973] [005/131] (949s left) gem_exec_reloc (basic-write-read-noreloc)
[71.614300] Subtest basic-write-read-noreloc: SKIP (0.000s)
[71.685674] [006/131] (949s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[71.871697] Starting subtest: cursor-vs-flip-toggle
[104.805494] Subtest cursor-vs-flip-toggle: SUCCESS (32.933s)
[105.112558] [007/131] (916s left) i915_query (engine-info-invalid)
[105.192030] Starting subtest: engine-info-invalid
[105.193037] Subtest engine-info-invalid: SUCCESS (0.000s)
[105.346998] [008/131] (916s left) syncobj_timeline (signal)
[105.427924] Starting subtest: signal
[105.428903] Subtest signal: SUCCESS (0.000s)
[105.563034] [009/131] (915s left) perf (blocking)
[106.013393] Starting subtest: blocking
[106.014244] Starting dynamic subtest: 0-rcs0
[116.032557] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[116.033405] Subtest blocking: SUCCESS (10.019s)
[116.114668] [010/131] (905s left) perf (gen12-unprivileged-single-ctx-counters)
[116.381681] Starting subtest: gen12-unprivileged-single-ctx-counters
[116.382577] Starting dynamic subtest: rcs0
[116.479617] Dynamic subtest rcs0: SUCCESS (0.098s)
[116.480543] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.098s)
[116.531162] [011/131] (905s left) kms_chamelium_hpd (dp-hpd-storm)
[116.849587] Subtest dp-hpd-storm: SKIP (0.000s)
[117.001486] [012/131] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[117.195401] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[117.197038] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[117.370475] [013/131] (904s left) gem_create (hog-create)
[117.451389] Starting subtest: hog-create
[117.452295] Starting dynamic subtest: lmem0
[149.740239] Dynamic subtest lmem0: SUCCESS (32.288s)
[149.749175] Starting dynamic subtest: smem0
[182.041354] Dynamic subtest smem0: SUCCESS (32.300s)
[182.042403] Subtest hog-create: SUCCESS (64.589s)
[182.325277] [014/131] (839s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[182.517671] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[182.519351] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.710054] [015/131] (839s left) gem_pxp (create-regular-buffer)
[185.311238] Starting subtest: create-regular-buffer
[185.313158] Subtest create-regular-buffer: SKIP (0.000s)
[185.441656] [016/131] (836s left) device_reset (unbind-reset-rebind)
[185.527955] Starting subtest: unbind-reset-rebind
[188.141189] Subtest unbind-reset-rebind: SUCCESS (2.613s)
[188.203714] [017/131] (833s left) gem_mmap_gtt (ptrace)
[188.282988] Subtest ptrace: SKIP (0.000s)
[188.350433] [018/131] (833s left) syncobj_wait (multi-wait-for-submit-submitted)
[188.427039] Starting subtest: multi-wait-for-submit-submitted
[188.536955] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[188.708980] [019/131] (833s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[188.896722] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[188.897604] Starting dynamic subtest: pipe-A-DP-3
[188.906095] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[188.915556] Starting dynamic subtest: pipe-B-DP-3
[188.924159] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[188.933533] Starting dynamic subtest: pipe-C-DP-3
[188.941902] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[188.951068] Starting dynamic subtest: pipe-D-DP-3
[188.961371] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[188.963275] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[189.385391] [020/131] (832s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[189.582317] Starting subtest: y-tiled-32bpp-rotate-180
[189.584177] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[189.786179] [021/131] (832s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[189.981581] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[190.029893] [022/131] (832s left) syncobj_wait (reset-signaled)
[190.107967] Starting subtest: reset-signaled
[190.108929] Subtest reset-signaled: SUCCESS (0.000s)
[190.303007] [023/131] (832s left) kms_big_fb (linear-16bpp-rotate-90)
[190.499179] Starting subtest: linear-16bpp-rotate-90
[190.556032] Subtest linear-16bpp-rotate-90: SKIP (0.056s)
[190.803937] [024/131] (831s left) kms_joiner (basic-max-non-joiner)
[190.994802] Starting subtest: basic-max-non-joiner
[190.996380] Subtest basic-max-non-joiner: SKIP (0.000s)
[191.157033] [025/131] (831s left) gem_render_copy_redux (interruptible)
[191.241318] Starting subtest: interruptible
[192.000923] Subtest interruptible: SUCCESS (0.759s)
[192.186522] [026/131] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[192.384558] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[192.386248] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[192.588821] [027/131] (830s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[192.784250] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[192.785166] Starting dynamic subtest: pipe-A-DP-3
[192.793886] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[192.803514] Starting dynamic subtest: pipe-B-DP-3
[192.811978] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[192.821496] Starting dynamic subtest: pipe-C-DP-3
[192.829736] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[192.838990] Starting dynamic subtest: pipe-D-DP-3
[192.849902] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[192.852115] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[193.243889] [028/131] (829s left) kms_sequence (get-forked)
[193.426621] Starting subtest: get-forked
[193.427493] Starting dynamic subtest: pipe-A-DP-3
[195.854492] Dynamic subtest pipe-A-DP-3: SUCCESS (2.426s)
[195.867240] Starting dynamic subtest: pipe-B-DP-3
[198.223325] Dynamic subtest pipe-B-DP-3: SUCCESS (2.368s)
[198.234580] Starting dynamic subtest: pipe-C-DP-3
[200.612439] Dynamic subtest pipe-C-DP-3: SUCCESS (2.388s)
[200.625741] Starting dynamic subtest: pipe-D-DP-3
[202.966233] Dynamic subtest pipe-D-DP-3: SUCCESS (2.352s)
[202.967144] Subtest get-forked: SUCCESS (9.539s)
[203.270981] [029/131] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[203.467298] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[203.468989] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[203.666195] [030/131] (819s left) gem_ctx_persistence (heartbeat-many)
[203.752185] Starting subtest: heartbeat-many
[203.753996] Subtest heartbeat-many: SKIP (0.000s)
[203.944253] [031/131] (819s left) gem_exec_schedule (fairslice)
[204.031386] Starting subtest: fairslice
[204.032377] Starting dynamic subtest: rcs0
[206.082946] Dynamic subtest rcs0: SUCCESS (2.051s)
[206.092619] Starting dynamic subtest: bcs0
[208.101925] Dynamic subtest bcs0: SUCCESS (2.018s)
[208.111962] Starting dynamic subtest: vcs0
[210.122894] Dynamic subtest vcs0: SUCCESS (2.021s)
[210.132575] Starting dynamic subtest: vcs1
[212.141267] Dynamic subtest vcs1: SUCCESS (2.018s)
[212.151417] Starting dynamic subtest: vecs0
[214.161251] Dynamic subtest vecs0: SUCCESS (2.020s)
[214.171207] Starting dynamic subtest: vecs1
[216.179876] Dynamic subtest vecs1: SUCCESS (2.018s)
[216.190159] Starting dynamic subtest: ccs0
[218.198943] Dynamic subtest ccs0: SUCCESS (2.019s)
[218.200069] Subtest fairslice: SUCCESS (14.166s)
[218.634645] [032/131] (804s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[218.724453] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[218.726399] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[219.001263] [033/131] (804s left) api_intel_bb (delta-check)
[219.078065] Starting subtest: delta-check
[219.108221] Subtest delta-check: SUCCESS (0.031s)
[219.335465] [034/131] (804s left) kms_async_flips (invalid-async-flip-atomic)
[219.521958] Starting subtest: invalid-async-flip-atomic
[219.757791] Starting dynamic subtest: pipe-A-DP-3
[220.136729] Dynamic subtest pipe-A-DP-3: SUCCESS (0.379s)
[220.341803] Starting dynamic subtest: pipe-B-DP-3
[220.499380] Dynamic subtest pipe-B-DP-3: SUCCESS (0.167s)
[220.702283] Starting dynamic subtest: pipe-C-DP-3
[220.852589] Dynamic subtest pipe-C-DP-3: SUCCESS (0.160s)
[221.050522] Starting dynamic subtest: pipe-D-DP-3
[221.200808] Dynamic subtest pipe-D-DP-3: SUCCESS (0.161s)
[221.201875] Subtest invalid-async-flip-atomic: SUCCESS (1.679s)
[221.720668] [035/131] (801s left) perf (polling)
[222.142127] Starting subtest: polling
[222.142981] Starting dynamic subtest: 0-rcs0
[232.173735] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[232.174940] Subtest polling: SUCCESS (10.031s)
[232.232251] [036/131] (791s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[232.420754] Starting subtest: plane-upscale-factor-0-25-with-rotation
[232.421548] Starting dynamic subtest: pipe-A
[232.804329] Dynamic subtest pipe-A: SUCCESS (0.383s)
[232.817949] Starting dynamic subtest: pipe-B
[233.269514] Dynamic subtest pipe-B: SUCCESS (0.465s)
[233.291140] Starting dynamic subtest: pipe-C
[233.750394] Dynamic subtest pipe-C: SUCCESS (0.479s)
[233.786026] Starting dynamic subtest: pipe-D
[234.248090] Dynamic subtest pipe-D: SUCCESS (0.496s)
[234.249168] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (1.828s)
[234.609207] [037/131] (788s left) kms_chamelium_audio (dp-audio)
[234.874805] Subtest dp-audio: SKIP (0.000s)
[235.024285] [038/131] (788s left) syncobj_timeline (invalid-query-illegal-handle)
[235.103248] Starting subtest: invalid-query-illegal-handle
[235.104199] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[235.247991] [039/131] (788s left) gem_mmap (big-bo)
[235.332126] Subtest big-bo: SKIP (0.000s)
[235.411850] [040/131] (788s left) gem_exec_params (rsvd2-dirt)
[235.495654] Starting subtest: rsvd2-dirt
[235.497376] Subtest rsvd2-dirt: SKIP (0.000s)
[235.704825] [041/131] (788s left) kms_pm_rpm (modeset-non-lpsp-stress)
[238.035858] Starting subtest: modeset-non-lpsp-stress
[243.822576] Subtest modeset-non-lpsp-stress: SUCCESS (5.786s)
[244.131685] [042/131] (779s left) kms_psr (psr2-basic)
[244.323233] Subtest psr2-basic: SKIP (0.000s)
[244.376810] [043/131] (779s left) gem_mmap_gtt (basic-small-bo)
[244.454993] Subtest basic-small-bo: SKIP (0.000s)
[244.527358] [044/131] (779s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[244.717865] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[247.352402] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.635s)
[247.616819] [045/131] (776s left) gem_ctx_param (vm)
[247.695544] Starting subtest: vm
[247.780170] Subtest vm: SUCCESS (0.085s)
[248.018689] [046/131] (776s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[248.215394] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[248.901406] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.686s)
[249.150416] [047/131] (775s left) kms_feature_discovery (display)
[249.334280] Starting subtest: display
[249.335156] Subtest display: SUCCESS (0.000s)
[249.505396] [048/131] (774s left) gem_eio (in-flight-internal-immediate)
[249.801174] Starting subtest: in-flight-internal-immediate
[250.883381] Subtest in-flight-internal-immediate: SUCCESS (1.082s)
[251.152923] [049/131] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[251.345970] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[255.322045] Subtest fbc-1p-primscrn-cur-indfb-onoff: FAIL (3.633s)
[255.404480] [050/131] (769s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.604588] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[255.606349] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[255.803471] [051/131] (768s left) kms_flip (plain-flip-ts-check-interruptible)
[255.995600] Starting subtest: plain-flip-ts-check-interruptible
[256.000362] Starting dynamic subtest: A-DP3
[264.113794] Dynamic subtest A-DP3: SUCCESS (8.113s)
[264.127955] Starting dynamic subtest: B-DP3
[272.145849] Dynamic subtest B-DP3: SUCCESS (8.031s)
[272.158262] Starting dynamic subtest: C-DP3
[280.183966] Dynamic subtest C-DP3: SUCCESS (8.036s)
[280.197585] Starting dynamic subtest: D-DP3
[288.211463] Dynamic subtest D-DP3: SUCCESS (8.024s)
[288.213626] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.218s)
[288.607965] [052/131] (736s left) kms_psr (fbc-psr-cursor-blt)
[288.793445] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[288.850889] [053/131] (735s left) kms_flip (2x-flip-vs-fences-interruptible)
[289.039935] Starting subtest: 2x-flip-vs-fences-interruptible
[289.041632] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[289.253434] [054/131] (735s left) kms_cursor_edge_walk (256x256-left-edge)
[289.440772] Starting subtest: 256x256-left-edge
[289.442907] Starting dynamic subtest: pipe-A-DP-3
[292.895767] Dynamic subtest pipe-A-DP-3: SUCCESS (3.453s)
[292.912619] Starting dynamic subtest: pipe-D-DP-3
[296.260557] Dynamic subtest pipe-D-DP-3: SUCCESS (3.360s)
[296.261968] Subtest 256x256-left-edge: SUCCESS (6.819s)
[296.558267] [055/131] (728s left) gem_exec_store (basic)
[296.648566] Starting subtest: basic
[296.807171] Subtest basic: SUCCESS (0.158s)
[297.107390] [056/131] (727s left) kms_flip (flip-vs-suspend)
[297.294877] Starting subtest: flip-vs-suspend
[297.299354] Starting dynamic subtest: A-DP3
[336.291232] Dynamic subtest A-DP3: SUCCESS (7.864s)
[336.308457] Starting dynamic subtest: B-DP3
[375.491533] Dynamic subtest B-DP3: SUCCESS (7.314s)
[375.507200] Starting dynamic subtest: C-DP3
[414.742881] Dynamic subtest C-DP3: SUCCESS (7.290s)
[414.775607] Starting dynamic subtest: D-DP3
[453.871060] Dynamic subtest D-DP3: SUCCESS (7.263s)
[453.879394] Subtest flip-vs-suspend: SUCCESS (29.743s)
[454.187596] [057/131] (570s left) kms_vblank (crtc-id)
[454.376564] Starting subtest: crtc-id
[454.378763] Starting dynamic subtest: pipe-A-DP-3
[454.755865] Dynamic subtest pipe-A-DP-3: SUCCESS (0.377s)
[454.772154] Starting dynamic subtest: pipe-D-DP-3
[455.065379] Dynamic subtest pipe-D-DP-3: SUCCESS (0.306s)
[455.066292] Subtest crtc-id: SUCCESS (0.689s)
[455.353372] [058/131] (569s left) kms_chamelium_frames (hdmi-crc-multiple)
[455.631095] Subtest hdmi-crc-multiple: SKIP (0.000s)
[455.787103] [059/131] (569s left) perf (non-sampling-read-error)
[456.071555] Starting subtest: non-sampling-read-error
[456.087503] Subtest non-sampling-read-error: SUCCESS (0.016s)
[456.141447] [060/131] (569s left) kms_lease (simple-lease)
[456.327417] Starting subtest: simple-lease
[456.328337] Starting dynamic subtest: pipe-A-DP-3
[456.804394] Dynamic subtest pipe-A-DP-3: SUCCESS (0.476s)
[456.820927] Starting dynamic subtest: pipe-B-DP-3
[457.192304] Dynamic subtest pipe-B-DP-3: SUCCESS (0.385s)
[457.210197] Starting dynamic subtest: pipe-C-DP-3
[457.583330] Dynamic subtest pipe-C-DP-3: SUCCESS (0.389s)
[457.603914] Starting dynamic subtest: pipe-D-DP-3
[457.971155] Dynamic subtest pipe-D-DP-3: SUCCESS (0.385s)
[457.972140] Subtest simple-lease: SUCCESS (1.646s)
[458.234372] [061/131] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[458.425202] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[458.426925] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[458.617966] [062/131] (566s left) kms_psr (psr2-no-drrs)
[458.807308] Subtest psr2-no-drrs: SKIP (0.000s)
[458.878121] [063/131] (566s left) gem_exec_schedule (implicit-boths)
[458.967341] Starting subtest: implicit-boths
[458.968284] Starting dynamic subtest: rcs0
[459.262498] Dynamic subtest rcs0: SUCCESS (0.294s)
[459.275185] Starting dynamic subtest: bcs0
[459.469147] Dynamic subtest bcs0: SUCCESS (0.205s)
[459.481746] Starting dynamic subtest: vcs0
[459.680301] Dynamic subtest vcs0: SUCCESS (0.210s)
[459.692483] Starting dynamic subtest: vcs1
[459.896283] Dynamic subtest vcs1: SUCCESS (0.215s)
[459.909162] Starting dynamic subtest: vecs0
[460.112017] Dynamic subtest vecs0: SUCCESS (0.215s)
[460.124622] Starting dynamic subtest: vecs1
[460.324584] Dynamic subtest vecs1: SUCCESS (0.211s)
[460.337262] Starting dynamic subtest: ccs0
[460.540606] Dynamic subtest ccs0: SUCCESS (0.214s)
[460.541573] Subtest implicit-boths: SUCCESS (1.573s)
[461.020717] [064/131] (564s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[461.384930] Starting subtest: cursor-rapid-movement-128x128
[461.389369] Starting dynamic subtest: pipe-A-DP-3
[461.846770] Dynamic subtest pipe-A-DP-3: SUCCESS (0.457s)
[461.900544] Starting dynamic subtest: pipe-D-DP-3
[462.264262] Dynamic subtest pipe-D-DP-3: SUCCESS (0.374s)
[462.265301] Subtest cursor-rapid-movement-128x128: SUCCESS (0.879s)
[462.760624] [065/131] (562s left) kms_rotation_crc (bad-tiling)
[462.954304] Starting subtest: bad-tiling
[462.956038] Subtest bad-tiling: SKIP (0.001s)
[463.130038] [066/131] (562s left) gem_blits (basic)
[463.243720] Starting subtest: basic
[469.156334] Subtest basic: SUCCESS (5.912s)
[469.366007] [067/131] (556s left) gem_spin_batch (user-each)
[469.456318] Starting subtest: user-each
[472.879803] Subtest user-each: SUCCESS (3.423s)
[473.253720] [068/131] (552s left) gem_exec_params (invalid-ring2)
[473.348448] Starting subtest: invalid-ring2
[473.349496] Subtest invalid-ring2: SUCCESS (0.000s)
[473.568925] [069/131] (552s left) i915_getparams_basic (basic-subslice-total)
[473.645528] Starting subtest: basic-subslice-total
[473.647340] Subtest basic-subslice-total: SUCCESS (0.000s)
[473.840615] [070/131] (552s left) gem_userptr_blits (sync-unmap-cycles)
[473.928959] Starting subtest: sync-unmap-cycles
[479.303912] Subtest sync-unmap-cycles: SUCCESS (5.374s)
[479.538902] [071/131] (546s left) perf_pmu (idle-no-semaphores)
[479.610049] Starting subtest: idle-no-semaphores
[479.610973] Starting dynamic subtest: rcs0
[480.175344] Dynamic subtest rcs0: SUCCESS (0.564s)
[480.192266] Starting dynamic subtest: bcs0
[480.692303] Dynamic subtest bcs0: SUCCESS (0.512s)
[480.709265] Starting dynamic subtest: vcs0
[481.223590] Dynamic subtest vcs0: SUCCESS (0.527s)
[481.240443] Starting dynamic subtest: vcs1
[481.747515] Dynamic subtest vcs1: SUCCESS (0.520s)
[481.764267] Starting dynamic subtest: vecs0
[482.266331] Dynamic subtest vecs0: SUCCESS (0.514s)
[482.283922] Starting dynamic subtest: vecs1
[482.785331] Dynamic subtest vecs1: SUCCESS (0.514s)
[482.802247] Starting dynamic subtest: ccs0
[483.306248] Dynamic subtest ccs0: SUCCESS (0.516s)
[483.310453] Subtest idle-no-semaphores: SUCCESS (3.698s)
[483.522963] [072/131] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[483.714168] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[483.715962] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[483.925006] [073/131] (542s left) gem_ctx_shared (q-independent)
[484.016967] Starting subtest: Q-independent
[484.017941] Starting dynamic subtest: rcs0
[484.252419] Dynamic subtest rcs0: SUCCESS (0.235s)
[484.267883] Starting dynamic subtest: bcs0
[484.403717] Dynamic subtest bcs0: SUCCESS (0.150s)
[484.417908] Starting dynamic subtest: vcs0
[484.562444] Dynamic subtest vcs0: SUCCESS (0.157s)
[484.576487] Starting dynamic subtest: vcs1
[484.726960] Dynamic subtest vcs1: SUCCESS (0.164s)
[484.740853] Starting dynamic subtest: vecs0
[484.885681] Dynamic subtest vecs0: SUCCESS (0.158s)
[484.899788] Starting dynamic subtest: vecs1
[485.046869] Dynamic subtest vecs1: SUCCESS (0.160s)
[485.060728] Starting dynamic subtest: ccs0
[485.208019] Dynamic subtest ccs0: SUCCESS (0.160s)
[485.209027] Subtest Q-independent: SUCCESS (1.192s)
[485.624949] [074/131] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[485.815173] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[485.816908] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[485.998721] [075/131] (540s left) syncobj_wait (multi-wait-all-submitted)
[486.074543] Starting subtest: multi-wait-all-submitted
[486.176148] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[486.342849] [076/131] (540s left) kms_big_fb (x-tiled-addfb)
[486.545500] Starting subtest: x-tiled-addfb
[486.546441] Subtest x-tiled-addfb: SUCCESS (0.000s)
[486.745287] [077/131] (539s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[486.932081] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[486.936817] Starting dynamic subtest: A-DP3
[487.770841] Dynamic subtest A-DP3: SUCCESS (0.831s)
[487.798095] Starting dynamic subtest: B-DP3
[488.580732] Dynamic subtest B-DP3: SUCCESS (0.808s)
[488.608502] Starting dynamic subtest: C-DP3
[489.368424] Dynamic subtest C-DP3: SUCCESS (0.785s)
[489.396170] Starting dynamic subtest: D-DP3
[490.182630] Dynamic subtest D-DP3: SUCCESS (0.809s)
[490.186189] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.253s)
[490.536460] [078/131] (536s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[490.727602] Starting subtest: crc-primary-basic-yf-tiled-ccs
[490.729957] Starting dynamic subtest: pipe-A-DP-3
[490.738258] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[490.751891] Starting dynamic subtest: pipe-B-DP-3
[490.760303] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[490.773594] Starting dynamic subtest: pipe-C-DP-3
[490.781843] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[490.795387] Starting dynamic subtest: pipe-D-DP-3
[490.806597] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[490.808504] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.009s)
[491.230392] [079/131] (535s left) sw_sync (timeline_closed_signaled)
[491.279613] Starting subtest: timeline_closed_signaled
[491.280462] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[491.424978] [080/131] (535s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[491.501451] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[491.608920] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[491.795808] [081/131] (535s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[491.991439] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[493.027456] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.036s)
[493.299416] [082/131] (533s left) syncobj_timeline (etime-single-wait-submitted)
[493.386497] Starting subtest: etime-single-wait-submitted
[493.488941] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[493.681205] [083/131] (533s left) gem_eio (in-flight-internal-1us)
[493.993159] Starting subtest: in-flight-internal-1us
[495.733424] Subtest in-flight-internal-1us: SUCCESS (1.741s)
[496.031432] [084/131] (531s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[496.220781] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[496.223232] Starting dynamic subtest: pipe-A-DP-3
[496.231482] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[496.245227] Starting dynamic subtest: pipe-B-DP-3
[496.253714] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[496.267153] Starting dynamic subtest: pipe-C-DP-3
[496.275402] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[496.288944] Starting dynamic subtest: pipe-D-DP-3
[496.299581] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[496.301579] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[496.704849] [085/131] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[496.894178] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[496.896021] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[497.107613] [086/131] (530s left) prime_vgem (fence-flip-hang)
[497.209446] Subtest fence-flip-hang: SKIP (0.000s)
[497.406315] [087/131] (530s left) kms_properties (plane-properties-legacy)
[497.594345] Starting subtest: plane-properties-legacy
[497.595243] Starting dynamic subtest: pipe-A-DP-3
[498.103452] Dynamic subtest pipe-A-DP-3: SUCCESS (0.507s)
[498.130359] Starting dynamic subtest: pipe-B-DP-3
[498.640110] Dynamic subtest pipe-B-DP-3: SUCCESS (0.534s)
[498.660668] Starting dynamic subtest: pipe-C-DP-3
[499.138437] Dynamic subtest pipe-C-DP-3: SUCCESS (0.492s)
[499.151771] Starting dynamic subtest: pipe-D-DP-3
[499.655640] Dynamic subtest pipe-D-DP-3: SUCCESS (0.520s)
[499.656452] Subtest plane-properties-legacy: SUCCESS (2.063s)
[499.961996] [088/131] (527s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[500.152220] Starting subtest: psr-rgb565-draw-render
[500.154048] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[500.346011] [089/131] (527s left) kms_lease (lease-invalid-connector)
[500.540477] Starting subtest: lease-invalid-connector
[500.541335] Starting dynamic subtest: pipe-A-DP-3
[500.542221] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[500.556051] Starting dynamic subtest: pipe-B-DP-3
[500.557017] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[500.570197] Starting dynamic subtest: pipe-C-DP-3
[500.570970] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[500.584279] Starting dynamic subtest: pipe-D-DP-3
[500.585465] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[500.586665] Subtest lease-invalid-connector: SUCCESS (0.007s)
[500.693635] [090/131] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[500.885076] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[500.886857] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[501.095565] [091/131] (526s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[501.278783] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[501.281257] Starting dynamic subtest: pipe-A-valid-mode
[503.194037] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.910s)
[503.195458] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.914s)
[503.535494] [092/131] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[503.728273] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[503.730033] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[503.932552] [093/131] (524s left) gem_exec_balancer (parallel-contexts)
[504.290076] Starting subtest: parallel-contexts
[510.678853] Subtest parallel-contexts: SUCCESS (6.398s)
[510.847945] [094/131] (517s left) kms_debugfs (display-off-read-all)
[511.037676] Starting subtest: display-off-read-all
[511.128716] Subtest display-off-read-all: SUCCESS (0.091s)
[511.386321] [095/131] (516s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[511.573326] Starting subtest: fbc-rgb565-draw-render
[515.187702] Subtest fbc-rgb565-draw-render: SUCCESS (3.615s)
[515.420933] [096/131] (512s left) kms_plane_cursor (overlay)
[515.608467] Starting subtest: overlay
[515.610182] Starting dynamic subtest: pipe-A-DP-3-size-64
[518.837604] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.228s)
[518.931480] Starting dynamic subtest: pipe-A-DP-3-size-128
[522.154012] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.249s)
[522.240780] Starting dynamic subtest: pipe-A-DP-3-size-256
[525.453750] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.233s)
[525.602723] Starting dynamic subtest: pipe-B-DP-3-size-64
[528.852533] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.269s)
[528.915508] Starting dynamic subtest: pipe-B-DP-3-size-128
[532.119999] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.217s)
[532.183539] Starting dynamic subtest: pipe-B-DP-3-size-256
[535.402461] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.233s)
[535.544982] Starting dynamic subtest: pipe-C-DP-3-size-64
[538.828912] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.298s)
[538.911704] Starting dynamic subtest: pipe-C-DP-3-size-128
[542.113105] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.233s)
[542.176523] Starting dynamic subtest: pipe-C-DP-3-size-256
[545.428842] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.266s)
[545.580386] Starting dynamic subtest: pipe-D-DP-3-size-64
[548.851287] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.290s)
[548.939093] Starting dynamic subtest: pipe-D-DP-3-size-128
[552.118625] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.215s)
[552.193875] Starting dynamic subtest: pipe-D-DP-3-size-256
[555.467934] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.299s)
[555.595613] Subtest overlay: SUCCESS (39.990s)
[555.915570] [097/131] (472s left) kms_content_protection (srm)
[556.172918] Starting subtest: srm
[556.201200] Starting dynamic subtest: pipe-A-DP-3
[677.257307] Dynamic subtest pipe-A-DP-3: FAIL (120.896s)
[677.258209] Subtest srm: FAIL (121.022s)
[677.495995] [098/131] (351s left) prime_busy (hang-wait)
[677.582275] Starting subtest: hang-wait
[677.584464] Starting dynamic subtest: rcs0
[703.340706] Dynamic subtest rcs0: SUCCESS (25.754s)
[703.354737] Starting dynamic subtest: bcs0
[710.488210] Dynamic subtest bcs0: SUCCESS (7.147s)
[710.502244] Starting dynamic subtest: vcs0
[717.475840] Dynamic subtest vcs0: SUCCESS (6.985s)
[717.489873] Starting dynamic subtest: vcs1
[724.442122] Dynamic subtest vcs1: SUCCESS (6.965s)
[724.455954] Starting dynamic subtest: vecs0
[731.495970] Dynamic subtest vecs0: SUCCESS (7.054s)
[731.511498] Starting dynamic subtest: vecs1
[738.462492] Dynamic subtest vecs1: SUCCESS (6.964s)
[738.476590] Starting dynamic subtest: ccs0
[752.353893] Dynamic subtest ccs0: SUCCESS (13.890s)
[752.354805] Subtest hang-wait: SUCCESS (74.769s)
[752.538727] [099/131] (276s left) kms_vblank (ts-continuation-idle)
[752.723769] Starting subtest: ts-continuation-idle
[752.726244] Starting dynamic subtest: pipe-A-DP-3
[753.058309] Dynamic subtest pipe-A-DP-3: SUCCESS (0.333s)
[753.084055] Starting dynamic subtest: pipe-D-DP-3
[753.328705] Dynamic subtest pipe-D-DP-3: SUCCESS (0.263s)
[753.329638] Subtest ts-continuation-idle: SUCCESS (0.605s)
[753.630095] [100/131] (275s left) kms_async_flips (alternate-sync-async-flip)
[753.822543] Starting subtest: alternate-sync-async-flip
[754.051823] Starting dynamic subtest: pipe-A-DP-3
[756.351982] Dynamic subtest pipe-A-DP-3: SUCCESS (2.300s)
[756.598505] Starting dynamic subtest: pipe-B-DP-3
[758.720668] Dynamic subtest pipe-B-DP-3: SUCCESS (2.135s)
[758.940490] Starting dynamic subtest: pipe-C-DP-3
[761.062724] Dynamic subtest pipe-C-DP-3: SUCCESS (2.136s)
[761.276492] Starting dynamic subtest: pipe-D-DP-3
[763.396674] Dynamic subtest pipe-D-DP-3: SUCCESS (2.134s)
[763.397789] Subtest alternate-sync-async-flip: SUCCESS (9.576s)
[763.930215] [101/131] (264s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[764.117208] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[764.191367] [102/131] (264s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[764.381253] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[764.383027] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[764.580595] [103/131] (264s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[766.891786] Starting subtest: dpms-mode-unset-non-lpsp
[768.279124] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.391s)
[768.733593] [104/131] (260s left) gem_pxp (verify-pxp-stale-ctx-execution)
[771.341674] Starting subtest: verify-pxp-stale-ctx-execution
[771.343454] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[771.486590] [105/131] (257s left) sysfs_preempt_timeout (idempotent)
[771.574416] Starting subtest: idempotent
[771.575336] Starting dynamic subtest: vecs0
[771.576235] Dynamic subtest vecs0: SUCCESS (0.001s)
[771.590718] Starting dynamic subtest: ccs0
[771.591748] Dynamic subtest ccs0: SUCCESS (0.001s)
[771.605597] Starting dynamic subtest: vcs0
[771.606701] Dynamic subtest vcs0: SUCCESS (0.001s)
[771.620124] Starting dynamic subtest: bcs0
[771.621200] Dynamic subtest bcs0: SUCCESS (0.001s)
[771.634961] Starting dynamic subtest: vecs1
[771.636266] Dynamic subtest vecs1: SUCCESS (0.001s)
[771.649897] Starting dynamic subtest: rcs0
[771.650812] Dynamic subtest rcs0: SUCCESS (0.001s)
[771.664017] Starting dynamic subtest: vcs1
[771.665253] Dynamic subtest vcs1: SUCCESS (0.001s)
[771.666555] Subtest idempotent: SUCCESS (0.013s)
[771.735793] [106/131] (257s left) gem_mmap_gtt (basic-small-bo-tiledy)
[771.814275] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[771.898323] [107/131] (257s left) kms_plane_scaling (intel-max-src-size)
[772.090220] Starting subtest: intel-max-src-size
[772.095621] Starting dynamic subtest: pipe-A-DP-3
[772.298769] Dynamic subtest pipe-A-DP-3: SUCCESS (0.202s)
[772.304659] Subtest intel-max-src-size: SUCCESS (0.211s)
[772.762634] [108/131] (256s left) kms_color (invalid-gamma-lut-sizes)
[772.951465] Starting subtest: invalid-gamma-lut-sizes
[772.952329] Starting dynamic subtest: pipe-A
[773.038576] Dynamic subtest pipe-A: SUCCESS (0.087s)
[773.058903] Starting dynamic subtest: pipe-B
[773.059867] Dynamic subtest pipe-B: SUCCESS (0.001s)
[773.074340] Starting dynamic subtest: pipe-C
[773.075260] Dynamic subtest pipe-C: SUCCESS (0.001s)
[773.089104] Starting dynamic subtest: pipe-D
[773.089967] Dynamic subtest pipe-D: SUCCESS (0.001s)
[773.090889] Subtest invalid-gamma-lut-sizes: SUCCESS (0.097s)
[773.309003] [109/131] (256s left) kms_psr (fbc-pr-primary-mmap-gtt)
[773.495617] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[773.551295] [110/131] (255s left) gem_exec_schedule (semaphore-codependency)
[773.646815] Starting subtest: semaphore-codependency
[773.688205] Subtest semaphore-codependency: SUCCESS (0.041s)
[774.141323] [111/131] (255s left) kms_addfb_basic (bad-pitch-63)
[774.219077] Starting subtest: bad-pitch-63
[774.219974] Subtest bad-pitch-63: SUCCESS (0.000s)
[774.523015] [112/131] (255s left) i915_pm_rpm (gem-execbuf)
[776.936953] Starting subtest: gem-execbuf
[776.938820] Starting dynamic subtest: lmem0
[778.518199] Dynamic subtest lmem0: SUCCESS (1.583s)
[778.555972] Starting dynamic subtest: smem0
[779.810791] Dynamic subtest smem0: SUCCESS (1.287s)
[779.813626] Subtest gem-execbuf: SUCCESS (2.880s)
[780.286159] [113/131] (249s left) syncobj_basic (bad-pad-fd-to-handle)
[780.364412] Starting subtest: bad-pad-fd-to-handle
[780.365312] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[780.568678] [114/131] (249s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[780.763955] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[780.767260] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[780.971498] [115/131] (248s left) gem_userptr_blits (process-exit)
[781.068514] Starting subtest: process-exit
[781.078368] Subtest process-exit: SUCCESS (0.010s)
[781.322618] [116/131] (248s left) kms_atomic_interruptible (universal-setplane-cursor)
[781.506321] Starting subtest: universal-setplane-cursor
[781.508478] Starting dynamic subtest: pipe-A-DP-3
[787.827330] Dynamic subtest pipe-A-DP-3: SUCCESS (6.319s)
[787.828222] Subtest universal-setplane-cursor: SUCCESS (6.321s)
[788.120177] [117/131] (241s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[788.314216] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[790.861777] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.548s)
[791.130029] [118/131] (239s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[791.208402] Starting subtest: single-wait-all-for-submit-signaled
[791.209361] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[791.416558] [119/131] (238s left) kms_force_connector_basic (force-connector-state)
[791.523696] Starting subtest: force-connector-state
[791.881629] Subtest force-connector-state: SUCCESS (0.358s)
[792.317598] [120/131] (237s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[792.511190] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[792.512923] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[792.719201] [121/131] (237s left) gem_eio (in-flight-immediate)
[793.045180] Starting subtest: in-flight-immediate
[798.143320] Subtest in-flight-immediate: SUCCESS (5.099s)
[798.425594] [122/131] (232s left) gen9_exec_parse (bb-secure)
[798.509647] Subtest bb-secure: SKIP (0.000s)
[798.599307] [123/131] (231s left) gem_spin_batch (engines)
[798.684713] Starting subtest: engines
[798.685612] Starting dynamic subtest: rcs0
[801.950787] Dynamic subtest rcs0: SUCCESS (3.263s)
[801.970262] Starting dynamic subtest: bcs0
[805.187772] Dynamic subtest bcs0: SUCCESS (3.231s)
[805.207513] Starting dynamic subtest: vcs0
[808.425756] Dynamic subtest vcs0: SUCCESS (3.232s)
[808.445399] Starting dynamic subtest: vcs1
[811.664145] Dynamic subtest vcs1: SUCCESS (3.233s)
[811.681722] Starting dynamic subtest: vecs0
[814.899759] Dynamic subtest vecs0: SUCCESS (3.230s)
[814.923244] Starting dynamic subtest: vecs1
[818.142684] Dynamic subtest vecs1: SUCCESS (3.237s)
[818.160269] Starting dynamic subtest: ccs0
[821.461520] Dynamic subtest ccs0: SUCCESS (3.315s)
[821.462432] Subtest engines: SUCCESS (22.776s)
[821.770236] [124/131] (208s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[821.849704] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[821.951242] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[822.089038] [125/131] (208s left) gem_lmem_swapping (heavy-random)
[825.045681] Starting subtest: heavy-random
[825.046558] Starting dynamic subtest: lmem0
[830.690714] Dynamic subtest lmem0: SUCCESS (5.645s)
[830.691627] Subtest heavy-random: SUCCESS (5.646s)
[831.843964] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[831.844921] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true
[831.846818] [126/131] (198s left) i915_drm_fdinfo (busy-hang)
[833.530176] Starting subtest: busy-hang
[833.530938] Starting dynamic subtest: rcs0
[833.552198] Dynamic subtest rcs0: SKIP (0.021s)
[833.564387] Starting dynamic subtest: bcs0
[833.566277] Dynamic subtest bcs0: SKIP (0.001s)
[833.578291] Starting dynamic subtest: vcs0
[833.580259] Dynamic subtest vcs0: SKIP (0.001s)
[833.592166] Starting dynamic subtest: vcs1
[833.594174] Dynamic subtest vcs1: SKIP (0.001s)
[833.605771] Starting dynamic subtest: vecs0
[833.607980] Dynamic subtest vecs0: SKIP (0.000s)
[833.619818] Starting dynamic subtest: vecs1
[833.621846] Dynamic subtest vecs1: SKIP (0.001s)
[833.633669] Starting dynamic subtest: ccs0
[833.635914] Dynamic subtest ccs0: SKIP (0.001s)
[833.638092] Subtest busy-hang: SKIP (0.032s)
[833.680250] [FACT i915_drm_fdinfo (busy-hang)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[833.682843] [FACT i915_drm_fdinfo (busy-hang)] new: kernel.kmod_is_loaded.i915: true
[833.685803] [127/131] (197s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[833.880951] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[833.882631] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[834.073448] [128/131] (196s left) kms_psr (psr-suspend)
[834.259302] Subtest psr-suspend: SKIP (0.000s)
[834.320022] [129/131] (196s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[834.515416] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[834.570347] [130/131] (196s left) gem_exec_balancer (hang)
[834.965027] Starting subtest: hang
[838.326426] Subtest hang: SUCCESS (3.362s)
[838.526431] [131/131] (192s left) gem_exec_params (invalid-ring)
[838.607079] Starting subtest: invalid-ring
[838.607972] Subtest invalid-ring: SUCCESS (0.000s)
[838.804845] 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.