[58.178313] Initializing watchdogs
[58.178363]   /dev/watchdog0
[58.193088] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.197551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.199840] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.203482] [001/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[58.329381] Starting subtest: primary-yf-tiled-reflect-x-180
[58.412961] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.081s)
[58.513341] [002/133] (960s left) kms_plane (plane-panning-top-left)
[58.619674] Starting subtest: plane-panning-top-left
[58.622109] Starting dynamic subtest: pipe-A
[60.334921] Dynamic subtest pipe-A: SUCCESS (1.715s)
[60.344064] Starting dynamic subtest: pipe-B
[62.714664] Dynamic subtest pipe-B: SUCCESS (2.378s)
[62.716996] Subtest plane-panning-top-left: SUCCESS (4.096s)
[63.598161] [003/133] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[63.702658] Starting subtest: psr-rgb565-draw-mmap-gtt
[63.707073] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[63.787191] [004/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[63.887216] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[63.891104] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[63.987072] [005/133] (954s left) gem_exec_reloc (basic-wc-active)
[64.049286] Subtest basic-wc-active: SKIP (0.000s)
[64.124952] [006/133] (954s left) gem_partial_pwrite_pread (write)
[64.179074] Subtest write: SKIP (0.000s)
[64.248807] [007/133] (954s left) kms_invalid_mode (bad-hsync-start)
[64.335734] Starting subtest: bad-hsync-start
[64.338117] Starting dynamic subtest: pipe-A-eDP-1
[64.620068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[64.627804] Starting dynamic subtest: pipe-B-eDP-1
[64.629891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[64.636626] Starting dynamic subtest: pipe-C-eDP-1
[64.638683] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[64.645618] Starting dynamic subtest: pipe-D-eDP-1
[64.647814] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[64.650085] Subtest bad-hsync-start: SUCCESS (0.288s)
[65.438778] [008/133] (953s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[65.528227] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[65.530617] Starting dynamic subtest: pipe-A-eDP-1
[65.553851] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.561644] Starting dynamic subtest: pipe-B-eDP-1
[65.583769] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.590904] Starting dynamic subtest: pipe-C-eDP-1
[65.611781] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.618817] Starting dynamic subtest: pipe-D-eDP-1
[65.640312] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.644335] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[67.706034] [009/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[67.800015] Subtest too-many-fences: SKIP (0.000s)
[67.922026] [010/133] (951s left) kms_content_protection (suspend-resume)
[68.128972] Starting subtest: suspend-resume
[68.133619] Subtest suspend-resume: SKIP (0.000s)
[68.266605] [011/133] (950s left) kms_cursor_legacy (torture-bo)
[68.406580] Starting subtest: torture-bo
[68.408806] Starting dynamic subtest: pipe-A
[74.378106] Dynamic subtest pipe-A: SUCCESS (5.968s)
[74.387229] Starting dynamic subtest: pipe-B
[80.841931] Dynamic subtest pipe-B: SUCCESS (6.465s)
[80.852640] Starting dynamic subtest: pipe-C
[88.380908] Dynamic subtest pipe-C: SUCCESS (7.537s)
[88.390214] Starting dynamic subtest: pipe-D
[94.997781] Dynamic subtest pipe-D: SUCCESS (6.615s)
[95.011236] Starting dynamic subtest: all-pipes
[103.238144] Dynamic subtest all-pipes: SUCCESS (8.240s)
[103.240715] Subtest torture-bo: SUCCESS (34.827s)
[103.391590] [012/133] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[103.503510] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[103.507788] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[103.596310] [013/133] (915s left) core_setmaster (master-drop-set-user)
[103.683967] Starting subtest: master-drop-set-user
[103.696348] Subtest master-drop-set-user: SUCCESS (0.015s)
[103.731859] [014/133] (915s left) i915_selftest (live)
[105.432309] Starting subtest: live
[105.434794] Starting dynamic subtest: sanitycheck
[109.750895] Dynamic subtest sanitycheck: SUCCESS (4.319s)
[109.759308] Starting dynamic subtest: uncore
[114.088721] Dynamic subtest uncore: SUCCESS (4.338s)
[114.094801] Starting dynamic subtest: workarounds
[131.875154] Dynamic subtest workarounds: FAIL (17.654s)
[131.883490] Starting dynamic subtest: gt_engines
[136.267961] Dynamic subtest gt_engines: SUCCESS (4.524s)
[136.276741] Starting dynamic subtest: gt_timelines
[152.044359] Dynamic subtest gt_timelines: SUCCESS (15.775s)
[152.053274] Starting dynamic subtest: gt_contexts
[156.340036] Dynamic subtest gt_contexts: SUCCESS (4.294s)
[156.350861] Starting dynamic subtest: gt_lrc
[162.456982] Dynamic subtest gt_lrc: SUCCESS (6.116s)
[162.466333] Starting dynamic subtest: gt_mocs
[165.374314] Dynamic subtest gt_mocs: SUCCESS (2.916s)
[165.383635] Starting dynamic subtest: gt_pm
[172.170194] Dynamic subtest gt_pm: SUCCESS (6.794s)
[172.178481] Starting dynamic subtest: gt_heartbeat
[176.530549] Dynamic subtest gt_heartbeat: SUCCESS (4.359s)
[176.539782] Starting dynamic subtest: gt_tlb
[185.764045] Dynamic subtest gt_tlb: SUCCESS (9.232s)
[185.771503] Starting dynamic subtest: requests
[197.413052] Dynamic subtest requests: SUCCESS (11.647s)
[197.421928] Starting dynamic subtest: migrate
[205.176741] Dynamic subtest migrate: SUCCESS (7.763s)
[205.185348] Starting dynamic subtest: active
[209.514209] Dynamic subtest active: SUCCESS (4.336s)
[209.523090] Starting dynamic subtest: objects
[214.247092] Dynamic subtest objects: SUCCESS (4.732s)
[214.255479] Starting dynamic subtest: mman
[219.040944] Dynamic subtest mman: SUCCESS (4.792s)
[219.050822] Starting dynamic subtest: dmabuf
[223.364941] Dynamic subtest dmabuf: SUCCESS (4.323s)
[223.374119] Starting dynamic subtest: vma
[227.721947] Dynamic subtest vma: SUCCESS (4.356s)
[227.729765] Starting dynamic subtest: coherency
[232.698587] Dynamic subtest coherency: SUCCESS (4.975s)
[232.707129] Starting dynamic subtest: gtt
[244.570163] Dynamic subtest gtt: SUCCESS (11.870s)
[244.579299] Starting dynamic subtest: gem
[252.651646] Dynamic subtest gem: SUCCESS (8.080s)
[252.659736] Starting dynamic subtest: evict
[258.139332] Dynamic subtest evict: SUCCESS (5.487s)
[258.148572] Starting dynamic subtest: hugepages
[266.848816] Dynamic subtest hugepages: SUCCESS (8.708s)
[266.858065] Starting dynamic subtest: gem_contexts
[295.078260] Dynamic subtest gem_contexts: SUCCESS (28.227s)
[295.086749] Starting dynamic subtest: client
[299.474985] Dynamic subtest client: SUCCESS (4.395s)
[299.482754] Starting dynamic subtest: gem_migrate
[303.808832] Dynamic subtest gem_migrate: SUCCESS (4.331s)
[303.818275] Starting dynamic subtest: reset
[308.150496] Dynamic subtest reset: SUCCESS (4.340s)
[308.163928] Starting dynamic subtest: memory_region
[312.525201] Dynamic subtest memory_region: SUCCESS (4.373s)
[312.534243] Starting dynamic subtest: hangcheck
[325.905918] Dynamic subtest hangcheck: SUCCESS (13.368s)
[325.913906] Starting dynamic subtest: execlists
[330.243254] Dynamic subtest execlists: SUCCESS (4.346s)
[330.249980] Starting dynamic subtest: ring_submission
[334.584618] Dynamic subtest ring_submission: SUCCESS (4.338s)
[334.593708] Starting dynamic subtest: perf
[338.928984] Dynamic subtest perf: SUCCESS (4.343s)
[338.938635] Starting dynamic subtest: slpc
[350.971229] Dynamic subtest slpc: SUCCESS (12.040s)
[350.980144] Starting dynamic subtest: guc
[355.179508] Dynamic subtest guc: SUCCESS (4.206s)
[355.189481] Starting dynamic subtest: guc_multi_lrc
[359.553826] Dynamic subtest guc_multi_lrc: SUCCESS (4.373s)
[359.562573] Starting dynamic subtest: guc_hang
[364.433241] Dynamic subtest guc_hang: SUCCESS (4.878s)
[364.442605] Starting dynamic subtest: late_gt_pm
[367.182679] Dynamic subtest late_gt_pm: SUCCESS (2.747s)
[367.185546] Subtest live: FAIL (261.742s)
[367.213136] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[367.216268] [015/133] (652s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[368.808186] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[368.810659] Starting dynamic subtest: pipe-A
[368.904644] Dynamic subtest pipe-A: SUCCESS (0.099s)
[368.913800] Starting dynamic subtest: pipe-B
[370.062269] Dynamic subtest pipe-B: SUCCESS (1.156s)
[370.072084] Starting dynamic subtest: pipe-C
[371.162086] Dynamic subtest pipe-C: SUCCESS (1.099s)
[371.170225] Starting dynamic subtest: pipe-D
[372.299120] Dynamic subtest pipe-D: SUCCESS (1.136s)
[372.301490] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.494s)
[373.434081] [FACT kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)] new: kernel.kmod_is_loaded.i915: true
[373.437844] [016/133] (645s left) gen7_exec_parse (basic-rejected)
[373.510428] Subtest basic-rejected: SKIP (0.000s)
[373.582074] [017/133] (645s left) gem_exec_schedule (u-semaphore-noskip)
[373.656952] Starting subtest: u-semaphore-noskip
[374.059541] Subtest u-semaphore-noskip: SUCCESS (0.409s)
[374.399344] [018/133] (644s left) kms_rmfb (close-fd)
[374.499068] Starting subtest: close-fd
[374.500981] Starting dynamic subtest: pipe-A-eDP-1
[374.605785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[374.613522] Starting dynamic subtest: pipe-B-eDP-1
[375.828562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[375.838328] Starting dynamic subtest: pipe-C-eDP-1
[377.042476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[377.052128] Starting dynamic subtest: pipe-D-eDP-1
[378.180159] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[378.182512] Subtest close-fd: SUCCESS (3.684s)
[379.387385] [019/133] (640s left) api_intel_bb (object-noreloc-purge-cache-simple)
[379.444082] Starting subtest: object-noreloc-purge-cache-simple
[379.446775] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[379.561409] [020/133] (639s left) vgem_basic (sysfs)
[379.633899] Starting subtest: sysfs
[379.636276] Subtest sysfs: SUCCESS (0.000s)
[379.692448] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[379.695771] [021/133] (639s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[379.787033] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[379.789372] Starting dynamic subtest: A-eDP1
[388.726340] Dynamic subtest A-eDP1: SUCCESS (8.938s)
[388.736265] Starting dynamic subtest: B-eDP1
[397.646890] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[397.655614] Starting dynamic subtest: C-eDP1
[406.564856] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[406.573082] Starting dynamic subtest: D-eDP1
[415.417840] Dynamic subtest D-eDP1: SUCCESS (8.852s)
[415.423680] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.637s)
[416.650599] [022/133] (602s left) kms_cursor_crc (cursor-offscreen-32x10)
[416.806572] Starting subtest: cursor-offscreen-32x10
[416.854618] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[417.120818] [023/133] (602s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[417.223324] Starting subtest: stress-xrgb8888-ytiled
[417.227970] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[417.283401] [024/133] (602s left) gem_mmap_offset (partial-remap)
[417.342445] Starting subtest: partial-remap
[417.344680] Starting dynamic subtest: smem0
[417.353587] Dynamic subtest smem0: SUCCESS (0.004s)
[417.355519] Subtest partial-remap: SUCCESS (0.005s)
[417.478227] [025/133] (602s left) gen7_exec_parse (basic-allocation)
[417.540449] Subtest basic-allocation: SKIP (0.000s)
[417.612097] [026/133] (602s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[417.698422] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[417.701817] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[417.780639] [027/133] (601s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[417.887927] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[418.889549] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.001s)
[419.010575] [028/133] (600s left) syncobj_basic (illegal-fd-to-handle)
[419.072838] Starting subtest: illegal-fd-to-handle
[419.075082] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[419.164737] [029/133] (600s left) gem_flink_race (flink_name)
[419.201070] Starting subtest: flink_name
[424.601703] Subtest flink_name: SUCCESS (5.399s)
[424.720950] [030/133] (595s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[424.841305] Starting subtest: cursorB-vs-flipA-atomic
[424.845570] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[424.985464] [031/133] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[425.094842] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[425.098984] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[425.195356] [032/133] (594s left) gem_exec_reloc (basic-wc-read-noreloc)
[425.258084] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[425.327896] [033/133] (594s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[425.416186] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[425.418437] Starting dynamic subtest: pipe-A-eDP-1
[425.439059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[425.447855] Starting dynamic subtest: pipe-B-eDP-1
[425.466837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[425.474667] Starting dynamic subtest: pipe-C-eDP-1
[425.493756] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[425.503090] Starting dynamic subtest: pipe-D-eDP-1
[425.522724] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[425.524682] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[427.605175] [034/133] (592s left) kms_legacy_colorkey (invalid-plane)
[427.691041] Starting subtest: invalid-plane
[427.693240] Starting dynamic subtest: zero-id
[427.695075] Dynamic subtest zero-id: SUCCESS (0.000s)
[427.703424] Starting dynamic subtest: outrange-id
[427.705615] Dynamic subtest outrange-id: SUCCESS (0.000s)
[427.707809] Subtest invalid-plane: SUCCESS (0.001s)
[427.761387] [035/133] (592s left) kms_dsc (dsc-with-bpc)
[427.860400] Starting subtest: dsc-with-bpc
[427.891983] Subtest dsc-with-bpc: SKIP (0.001s)
[427.931922] [036/133] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[428.036623] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[431.626475] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.591s)
[432.846194] [037/133] (587s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[432.895552] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[433.003694] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[433.079166] [038/133] (587s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[433.193474] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[433.195700] Starting dynamic subtest: pipe-A-eDP-1
[433.289829] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[433.302156] Starting dynamic subtest: pipe-B-eDP-1
[434.481923] Dynamic subtest pipe-B-eDP-1: SKIP (1.190s)
[434.486273] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.293s)
[435.682194] [039/133] (584s left) api_intel_allocator (reserve-simple)
[435.748971] Starting subtest: reserve-simple
[435.754804] Subtest reserve-simple: SUCCESS (0.006s)
[435.864383] [040/133] (584s left) gem_exec_params (no-bsd)
[435.921541] Starting subtest: no-bsd
[435.923898] Subtest no-bsd: SUCCESS (0.002s)
[437.984214] [041/133] (582s left) syncobj_wait (wait-for-submit-snapshot)
[438.043721] Starting subtest: wait-for-submit-snapshot
[438.124540] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[438.216866] [042/133] (582s left) gem_ctx_persistence (hang)
[438.280565] Starting subtest: hang
[438.285152] Subtest hang: SKIP (0.000s)
[438.403245] [043/133] (582s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[438.498999] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[438.501338] Starting dynamic subtest: pipe-A-eDP-1
[438.559531] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[438.569052] Starting dynamic subtest: pipe-B-eDP-1
[438.629336] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[438.640320] Starting dynamic subtest: pipe-C-eDP-1
[438.697565] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[438.706485] Starting dynamic subtest: pipe-D-eDP-1
[438.763180] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[438.767201] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[440.735266] [044/133] (579s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[440.798649] Starting subtest: invalid-multi-wait-unsubmitted
[440.800896] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[440.905395] [045/133] (579s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[441.002458] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[441.006561] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[441.085484] [046/133] (579s left) syncobj_wait (invalid-reset-zero-handles)
[441.142079] Starting subtest: invalid-reset-zero-handles
[441.144239] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[441.237525] [047/133] (579s left) gem_madvise (dontneed-before-exec)
[441.283278] Starting subtest: dontneed-before-exec
[441.313734] Subtest dontneed-before-exec: SKIP (0.030s)
[441.376349] [048/133] (579s left) perf (stress-open-close)
[441.504674] Starting subtest: stress-open-close
[441.506547] Starting dynamic subtest: 0-rcs0
[443.671441] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[443.681809] Starting dynamic subtest: 1-vcs1
[445.833865] Dynamic subtest 1-vcs1: SUCCESS (2.162s)
[445.840225] Subtest stress-open-close: SUCCESS (4.332s)
[445.881867] [049/133] (574s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[445.981069] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[446.081835] [050/133] (574s left) gem_ctx_persistence (engines-mixed)
[446.152762] Starting subtest: engines-mixed
[446.154815] Starting dynamic subtest: rcs0
[446.233820] Dynamic subtest rcs0: SUCCESS (0.080s)
[446.244489] Starting dynamic subtest: bcs0
[446.296263] Dynamic subtest bcs0: SUCCESS (0.061s)
[446.308275] Starting dynamic subtest: vcs0
[446.350159] Dynamic subtest vcs0: SUCCESS (0.052s)
[446.363190] Starting dynamic subtest: vcs1
[446.393166] Dynamic subtest vcs1: SUCCESS (0.041s)
[446.402429] Starting dynamic subtest: vecs0
[446.439086] Dynamic subtest vecs0: SUCCESS (0.045s)
[446.449779] Starting dynamic subtest: ccs0
[446.481267] Dynamic subtest ccs0: SUCCESS (0.041s)
[446.483310] Subtest engines-mixed: SUCCESS (0.329s)
[446.561651] [051/133] (574s left) kms_vrr (flip-suspend)
[446.641355] Starting subtest: flip-suspend
[446.646375] Subtest flip-suspend: SKIP (0.000s)
[446.712957] [052/133] (574s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[446.913994] Starting subtest: cursor-rapid-movement-128x128
[446.915917] Starting dynamic subtest: pipe-A-eDP-1
[447.457796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[447.485676] Starting dynamic subtest: pipe-D-eDP-1
[448.663758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s)
[448.665765] Subtest cursor-rapid-movement-128x128: SUCCESS (1.750s)
[449.505380] [053/133] (571s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[449.564268] Starting subtest: wait-all-for-submit-delayed-submit
[449.667672] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[449.744595] [054/133] (571s left) gem_exec_fence (submit-chain)
[449.922850] Starting subtest: submit-chain
[449.938940] Subtest submit-chain: SUCCESS (0.019s)
[452.020890] [055/133] (568s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[452.119075] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[458.798611] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.682s)
[458.927913] [056/133] (562s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[459.037760] Starting subtest: fbc-rgb101010-draw-mmap-wc
[463.610607] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.576s)
[464.726129] [057/133] (556s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[464.841797] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[464.846521] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[464.944858] [058/133] (556s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[465.061670] Starting subtest: basic-busy-flip-before-cursor-varying-size
[465.066279] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[465.221681] [059/133] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[465.318775] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[472.716308] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.400s)
[472.861705] [060/133] (548s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[472.960225] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[472.964730] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[473.032907] [061/133] (548s left) kms_properties (crtc-properties-atomic)
[473.120052] Starting subtest: crtc-properties-atomic
[473.122433] Starting dynamic subtest: pipe-A-eDP-1
[473.555844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[473.565608] Starting dynamic subtest: pipe-B-eDP-1
[474.686465] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[474.695268] Starting dynamic subtest: pipe-C-eDP-1
[475.811082] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[475.820569] Starting dynamic subtest: pipe-D-eDP-1
[476.949407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[476.951378] Subtest crtc-properties-atomic: SUCCESS (3.828s)
[477.769555] [062/133] (543s left) gem_exec_balancer (bonded-true-hang)
[478.033020] Starting subtest: bonded-true-hang
[478.038528] Subtest bonded-true-hang: SKIP (0.000s)
[478.138957] [063/133] (543s left) kms_plane (pixel-format-yf-tiled-modifier)
[478.238174] Starting subtest: pixel-format-yf-tiled-modifier
[478.242295] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[478.328429] [064/133] (542s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[478.426641] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[478.431109] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[478.534157] [065/133] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[478.628680] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[478.632944] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[478.715973] [066/133] (542s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[478.810389] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[479.646042] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[479.810437] [067/133] (541s left) gem_exec_suspend (basic)
[479.866904] Starting subtest: basic
[479.869276] Starting dynamic subtest: smem
[481.942957] Dynamic subtest smem: SUCCESS (2.073s)
[481.945884] Subtest basic: SUCCESS (2.076s)
[482.124015] [068/133] (539s left) kms_chamelium_frames (hdmi-frame-dump)
[482.496252] Subtest hdmi-frame-dump: SKIP (0.000s)
[483.259288] [069/133] (538s left) syncobj_timeline (multi-wait-all-signaled)
[483.326891] Starting subtest: multi-wait-all-signaled
[483.329441] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[483.460338] [070/133] (538s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[483.561726] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[483.566169] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[483.658724] [071/133] (537s left) gem_exec_flush (basic-uc-ro-default)
[483.729687] Starting subtest: basic-uc-ro-default
[489.187285] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[489.379352] [072/133] (532s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[489.444225] Starting subtest: invalid-multi-wait-all-unsubmitted
[489.446705] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[489.533893] [073/133] (532s left) kms_color (invalid-ctm-matrix-sizes)
[489.637070] Starting subtest: invalid-ctm-matrix-sizes
[489.639306] Starting dynamic subtest: pipe-A
[489.641216] Dynamic subtest pipe-A: SUCCESS (0.002s)
[489.649830] Starting dynamic subtest: pipe-B
[489.652231] Dynamic subtest pipe-B: SUCCESS (0.003s)
[489.660167] Starting dynamic subtest: pipe-C
[489.662063] Dynamic subtest pipe-C: SUCCESS (0.003s)
[489.670268] Starting dynamic subtest: pipe-D
[489.672436] Dynamic subtest pipe-D: SUCCESS (0.004s)
[489.674660] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[489.722473] [074/133] (531s left) gem_exec_big (single)
[489.787415] Starting subtest: single
[493.377766] Subtest single: FAIL (3.525s)
[493.421713] [075/133] (528s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[493.571728] Starting subtest: fbc-modesetfrombusy
[497.355990] Subtest fbc-modesetfrombusy: SUCCESS (3.788s)
[498.521263] [076/133] (523s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[498.630082] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[498.632374] Starting dynamic subtest: pipe-A-eDP-1
[499.376970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[499.385613] Starting dynamic subtest: pipe-B-eDP-1
[501.389326] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.011s)
[501.399094] Starting dynamic subtest: pipe-C-eDP-1
[503.206975] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.814s)
[503.217218] Starting dynamic subtest: pipe-D-eDP-1
[505.051804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.844s)
[505.054122] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.416s)
[506.189910] [077/133] (515s left) kms_atomic (plane-invalid-params)
[506.287080] Starting subtest: plane-invalid-params
[506.288894] Starting dynamic subtest: pipe-A-eDP-1
[506.711277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[506.713670] Subtest plane-invalid-params: SUCCESS (0.425s)
[507.527997] [078/133] (514s left) gem_spin_batch (resubmit-all)
[507.603300] Starting subtest: resubmit-all
[507.605731] Starting dynamic subtest: rcs0
[507.623927] Dynamic subtest rcs0: SUCCESS (0.023s)
[507.635248] Starting dynamic subtest: bcs0
[507.637688] Dynamic subtest bcs0: SUCCESS (0.003s)
[507.646502] Starting dynamic subtest: vcs0
[507.648557] Dynamic subtest vcs0: SUCCESS (0.004s)
[507.657444] Starting dynamic subtest: vcs1
[507.659769] Dynamic subtest vcs1: SUCCESS (0.004s)
[507.668068] Starting dynamic subtest: vecs0
[507.670359] Dynamic subtest vecs0: SUCCESS (0.004s)
[507.678737] Starting dynamic subtest: ccs0
[507.681078] Dynamic subtest ccs0: SUCCESS (0.004s)
[507.683293] Subtest resubmit-all: SUCCESS (0.056s)
[508.927413] [079/133] (513s left) gem_exec_params (invalid-fence-in-submit)
[508.981608] Starting subtest: invalid-fence-in-submit
[508.987149] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[509.116832] [080/133] (512s left) kms_psr (fbc-pr-cursor-blt)
[509.207379] Starting subtest: fbc-pr-cursor-blt
[509.211544] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[509.276512] [081/133] (512s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[509.383356] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[509.387455] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[509.456517] [082/133] (512s left) kms_flip (absolute-wf_vblank-interruptible)
[509.547295] Starting subtest: absolute-wf_vblank-interruptible
[509.549528] Starting dynamic subtest: A-eDP1
[518.287762] Dynamic subtest A-eDP1: SUCCESS (8.739s)
[518.301164] Starting dynamic subtest: B-eDP1
[527.010528] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[527.023788] Starting dynamic subtest: C-eDP1
[535.736740] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[535.748478] Starting dynamic subtest: D-eDP1
[544.460564] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[544.468482] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.918s)
[545.669871] [083/133] (476s left) kms_vrr (flip-basic)
[545.775430] Starting subtest: flip-basic
[545.782115] Subtest flip-basic: SKIP (0.000s)
[545.849997] [084/133] (476s left) kms_flip (2x-flip-vs-expired-vblank)
[545.938199] Starting subtest: 2x-flip-vs-expired-vblank
[545.948855] Subtest 2x-flip-vs-expired-vblank: SKIP (0.013s)
[546.029457] [085/133] (476s left) syncobj_wait (invalid-reset-one-illegal-handle)
[546.080086] Starting subtest: invalid-reset-one-illegal-handle
[546.082430] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[546.176160] [086/133] (476s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[546.237831] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[546.347064] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.109s)
[546.423400] [087/133] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[546.510077] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[546.514042] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[546.597333] [088/133] (475s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[546.696428] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[546.698777] Starting dynamic subtest: pipe-A-eDP-1
[546.709248] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[546.720993] Starting dynamic subtest: pipe-B-eDP-1
[546.730791] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[546.740865] Starting dynamic subtest: pipe-C-eDP-1
[546.749519] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[546.757832] Starting dynamic subtest: pipe-D-eDP-1
[546.767651] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[546.771837] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[548.933584] [089/133] (473s left) i915_hangman (engine-engine-hang)
[549.009450] Starting subtest: engine-engine-hang
[549.011519] Starting dynamic subtest: rcs0
[550.900904] Dynamic subtest rcs0: SUCCESS (1.890s)
[550.912738] Starting dynamic subtest: bcs0
[552.884639] Dynamic subtest bcs0: SUCCESS (1.982s)
[552.896533] Starting dynamic subtest: vcs0
[554.869659] Dynamic subtest vcs0: SUCCESS (1.981s)
[554.881093] Starting dynamic subtest: vcs1
[556.853112] Dynamic subtest vcs1: SUCCESS (1.980s)
[556.865034] Starting dynamic subtest: vecs0
[558.903036] Dynamic subtest vecs0: SUCCESS (2.047s)
[558.923066] Starting dynamic subtest: ccs0
[560.884386] Dynamic subtest ccs0: SUCCESS (1.979s)
[560.887065] Subtest engine-engine-hang: SUCCESS (11.875s)
[561.017570] [090/133] (461s left) gem_mmap_gtt (basic-small-copy-odd)
[561.074722] Subtest basic-small-copy-odd: SKIP (0.000s)
[561.129244] [091/133] (461s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[561.227596] Starting subtest: y-tiled-32bpp-rotate-90
[561.231993] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[561.316300] [092/133] (461s left) kms_psr (fbc-psr-sprite-blt)
[561.412137] Starting subtest: fbc-psr-sprite-blt
[561.414427] Starting dynamic subtest: eDP-1
[561.418659] Dynamic subtest eDP-1: SKIP (0.000s)
[561.422975] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[561.499852] [093/133] (460s left) gem_lmem_swapping (massive-random)
[561.543951] Subtest massive-random: SKIP (0.000s)
[561.584652] [094/133] (460s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[561.688308] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[561.692719] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[561.780723] [095/133] (460s left) gem_mmap_gtt (big-copy)
[561.836716] Subtest big-copy: SKIP (0.000s)
[561.893941] [096/133] (460s left) gem_exec_reloc (basic-gtt-cpu-active)
[561.955465] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[562.029908] [097/133] (460s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[562.123334] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[563.203683] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.079s)
[563.315413] [098/133] (459s left) gem_exec_reloc (basic-wc-cpu-active)
[563.381054] Subtest basic-wc-cpu-active: SKIP (0.000s)
[563.451168] [099/133] (459s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[563.541848] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[567.551983] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.013s)
[568.737231] [100/133] (454s left) syncobj_wait (wait-all-interrupted)
[568.807245] Starting subtest: wait-all-interrupted
[568.915333] Subtest wait-all-interrupted: SUCCESS (0.108s)
[568.991621] [101/133] (453s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[569.085733] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[569.090131] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[569.186828] [102/133] (453s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[569.282274] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[569.286579] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[569.380046] [103/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[569.469132] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[576.971236] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.506s)
[577.096600] [104/133] (445s left) gem_create (hog-create)
[577.147026] Starting subtest: hog-create
[577.149328] Starting dynamic subtest: smem0
[610.911299] Dynamic subtest smem0: SUCCESS (33.762s)
[610.914419] Subtest hog-create: SUCCESS (33.763s)
[611.103474] [105/133] (411s left) i915_pm_rps (fence-order)
[611.169733] Starting subtest: fence-order
[614.125260] Subtest fence-order: SUCCESS (2.952s)
[614.250367] [106/133] (408s left) kms_psr (psr-primary-blt)
[614.340464] Starting subtest: psr-primary-blt
[614.342866] Starting dynamic subtest: eDP-1
[616.079798] Dynamic subtest eDP-1: SUCCESS (1.740s)
[616.082104] Subtest psr-primary-blt: SUCCESS (1.741s)
[616.948079] [107/133] (406s left) gem_exec_schedule (pi-common)
[617.123766] Starting subtest: pi-common
[617.126063] Starting dynamic subtest: rcs0
[617.159773] Dynamic subtest rcs0: SUCCESS (0.039s)
[617.170498] Starting dynamic subtest: bcs0
[617.202281] Dynamic subtest bcs0: SUCCESS (0.041s)
[617.213107] Starting dynamic subtest: vcs0
[617.238487] Dynamic subtest vcs0: SUCCESS (0.035s)
[617.251458] Starting dynamic subtest: vcs1
[617.270226] Dynamic subtest vcs1: SUCCESS (0.031s)
[617.283196] Starting dynamic subtest: vecs0
[617.300188] Dynamic subtest vecs0: SUCCESS (0.029s)
[617.311981] Starting dynamic subtest: ccs0
[617.330146] Dynamic subtest ccs0: SUCCESS (0.029s)
[617.332418] Subtest pi-common: SUCCESS (0.211s)
[617.557502] [108/133] (405s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[617.659334] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[617.663625] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[617.755289] [109/133] (405s left) gem_exec_store (dword)
[617.817575] Starting subtest: dword
[617.819593] Starting dynamic subtest: rcs0
[617.871442] Dynamic subtest rcs0: SUCCESS (0.055s)
[617.882798] Starting dynamic subtest: bcs0
[617.912820] Dynamic subtest bcs0: SUCCESS (0.039s)
[617.923190] Starting dynamic subtest: vcs0
[617.954142] Dynamic subtest vcs0: SUCCESS (0.039s)
[617.964117] Starting dynamic subtest: vcs1
[617.997036] Dynamic subtest vcs1: SUCCESS (0.041s)
[618.006905] Starting dynamic subtest: vecs0
[618.038947] Dynamic subtest vecs0: SUCCESS (0.039s)
[618.049099] Starting dynamic subtest: ccs0
[618.080313] Dynamic subtest ccs0: SUCCESS (0.040s)
[618.082543] Subtest dword: SUCCESS (0.266s)
[618.269577] [110/133] (404s left) kms_pm_dc (dc5-dpms-negative)
[619.366334] Starting subtest: dc5-dpms-negative
[619.370968] Subtest dc5-dpms-negative: SKIP (0.000s)
[619.439842] [111/133] (403s left) gem_mmap_gtt (basic-read-write-distinct)
[619.492172] Subtest basic-read-write-distinct: SKIP (0.000s)
[619.553334] [112/133] (403s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[619.648579] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[619.652658] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[619.715330] [113/133] (403s left) gem_render_copy (yf-tiled)
[619.780090] Starting subtest: yf-tiled
[619.784403] Subtest yf-tiled: SKIP (0.000s)
[619.966482] [114/133] (403s left) kms_pm_rpm (legacy-planes)
[622.097662] Starting subtest: legacy-planes
[622.099895] Starting dynamic subtest: plane-65
[630.398313] Dynamic subtest plane-65: SUCCESS (8.302s)
[630.409096] Starting dynamic subtest: plane-95
[638.831068] Dynamic subtest plane-95: SUCCESS (8.429s)
[638.843043] Starting dynamic subtest: plane-125
[647.133886] Dynamic subtest plane-125: SUCCESS (8.300s)
[647.146070] Starting dynamic subtest: plane-135
[655.394217] Dynamic subtest plane-135: SUCCESS (8.258s)
[655.397052] Subtest legacy-planes: SUCCESS (33.300s)
[655.782297] [115/133] (367s left) perf_pmu (gt-awake)
[655.836867] Starting subtest: gt-awake
[664.921334] Subtest gt-awake: SUCCESS (9.082s)
[665.026675] [116/133] (358s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[665.144215] Starting subtest: 2x-long-cursor-vs-flip-legacy
[665.149235] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[665.291520] [117/133] (358s left) kms_psr (pr-sprite-mmap-gtt)
[665.398230] Starting subtest: pr-sprite-mmap-gtt
[665.402721] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[665.484175] [118/133] (358s left) kms_psr (fbc-psr2-no-drrs)
[665.576397] Starting subtest: fbc-psr2-no-drrs
[665.578633] Starting dynamic subtest: eDP-1
[665.582676] Dynamic subtest eDP-1: SKIP (0.000s)
[665.586674] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[665.650469] [119/133] (357s left) i915_drm_fdinfo (virtual-busy)
[665.692693] Starting subtest: virtual-busy
[665.697244] Subtest virtual-busy: SKIP (0.000s)
[665.764931] [120/133] (357s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[665.855354] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[665.859352] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[665.950661] [121/133] (357s left) kms_vblank (query-busy-hang)
[666.048666] Starting subtest: query-busy-hang
[666.050507] Starting dynamic subtest: pipe-A-eDP-1
[692.701431] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.652s)
[692.716070] Starting dynamic subtest: pipe-D-eDP-1
[717.655721] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.950s)
[717.658123] Subtest query-busy-hang: SUCCESS (51.606s)
[718.532737] [122/133] (305s left) gem_ctx_shared (single-timeline)
[718.589051] Starting subtest: single-timeline
[718.606627] Subtest single-timeline: SUCCESS (0.013s)
[718.824661] [123/133] (304s left) kms_psr (psr2-primary-page-flip)
[718.915107] Starting subtest: psr2-primary-page-flip
[718.917450] Starting dynamic subtest: eDP-1
[720.606919] Dynamic subtest eDP-1: SUCCESS (1.692s)
[720.609401] Subtest psr2-primary-page-flip: SUCCESS (1.693s)
[721.487794] [124/133] (302s left) syncobj_timeline (wait-zero-handles)
[721.552660] Starting subtest: wait-zero-handles
[721.555102] Subtest wait-zero-handles: SUCCESS (0.000s)
[721.651483] [125/133] (302s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[721.752921] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[729.145022] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.396s)
[729.268598] [126/133] (294s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[729.674940] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[730.525072] [127/133] (293s left) dumb_buffer (map-uaf)
[730.595614] Starting subtest: map-uaf
[730.600472] Subtest map-uaf: SUCCESS (0.005s)
[730.716198] [128/133] (293s left) kms_atomic_transition (plane-all-modeset-transition)
[730.815169] Starting subtest: plane-all-modeset-transition
[730.822227] Subtest plane-all-modeset-transition: SKIP (0.000s)
[730.887625] [129/133] (293s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[730.951823] Starting subtest: yf-tiled-ccs-to-y-tiled
[730.955808] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[731.133291] [130/133] (292s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[731.193349] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[731.195625] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[731.294022] [131/133] (292s left) syncobj_timeline (wait-all-for-submit-complex)
[731.359522] Starting subtest: wait-all-for-submit-complex
[731.572891] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[731.649436] [132/133] (292s left) gem_pxp (fail-invalid-protected-context)
[731.769225] Starting subtest: fail-invalid-protected-context
[731.771686] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[731.876133] [133/133] (292s left) gem_mmap_gtt (fault-concurrent-x)
[731.935523] Subtest fault-concurrent-X: SKIP (0.000s)
[732.007860] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_partial_pwrite_pread
results: parsing output: 6/ for test: kms_invalid_mode
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_fenced_exec_thrash
results: parsing output: 9/ for test: kms_content_protection
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: i915_selftest
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: gen7_exec_parse
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_rmfb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_pipe_stress
results: parsing output: 23/ for test: gem_mmap_offset
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_basic
results: parsing output: 28/ for test: gem_flink_race
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_legacy_colorkey
results: parsing output: 34/ for test: kms_dsc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_madvise
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_vrr
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_properties
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_exec_suspend
results: parsing output: 67/ for test: kms_chamelium_frames
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_exec_flush
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: gem_exec_big
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: gem_spin_batch
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: i915_hangman
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: i915_pm_rps
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_store
results: parsing output: 109/ for test: kms_pm_dc
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: dumb_buffer
results: parsing output: 127/ for test: kms_atomic_transition
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: gem_mmap_gtt
Done.