[57.567379] Initializing watchdogs
[57.567428]   /dev/watchdog0
[57.582465] [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]
[57.587274] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.590066] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.593417] [001/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[57.715685] Starting subtest: primary-yf-tiled-reflect-x-180
[57.797224] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.081s)
[57.908703] [002/133] (960s left) kms_plane (plane-panning-top-left)
[58.007718] Starting subtest: plane-panning-top-left
[58.009948] Starting dynamic subtest: pipe-A
[59.696646] Dynamic subtest pipe-A: SUCCESS (1.688s)
[59.708629] Starting dynamic subtest: pipe-B
[62.050786] Dynamic subtest pipe-B: SUCCESS (2.354s)
[62.053123] Subtest plane-panning-top-left: SUCCESS (4.044s)
[62.862164] [003/133] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[62.958673] Starting subtest: psr-rgb565-draw-mmap-gtt
[62.962790] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[63.064841] [004/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[63.168451] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[63.172517] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[63.286402] [005/133] (954s left) gem_exec_reloc (basic-wc-active)
[63.347191] Subtest basic-wc-active: SKIP (0.000s)
[63.404130] [006/133] (954s left) gem_partial_pwrite_pread (write)
[63.464268] Subtest write: SKIP (0.000s)
[63.538782] [007/133] (954s left) kms_invalid_mode (bad-hsync-start)
[63.624601] Starting subtest: bad-hsync-start
[63.626999] Starting dynamic subtest: pipe-A-eDP-1
[63.908060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[63.916903] Starting dynamic subtest: pipe-B-eDP-1
[63.919177] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[63.926276] Starting dynamic subtest: pipe-C-eDP-1
[63.928613] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[63.935799] Starting dynamic subtest: pipe-D-eDP-1
[63.938175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[63.940558] Subtest bad-hsync-start: SUCCESS (0.288s)
[64.782597] [008/133] (953s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[64.887196] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[64.889418] Starting dynamic subtest: pipe-A-eDP-1
[64.911909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.921596] Starting dynamic subtest: pipe-B-eDP-1
[64.942473] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.949643] Starting dynamic subtest: pipe-C-eDP-1
[64.971366] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.978150] Starting dynamic subtest: pipe-D-eDP-1
[65.000945] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.005491] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[67.193390] [009/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[67.370320] Subtest too-many-fences: SKIP (0.000s)
[67.573781] [010/133] (950s left) kms_content_protection (suspend-resume)
[67.837505] Starting subtest: suspend-resume
[67.842258] Subtest suspend-resume: SKIP (0.000s)
[68.068858] [011/133] (950s left) kms_cursor_legacy (torture-bo)
[68.182497] Starting subtest: torture-bo
[68.184944] Starting dynamic subtest: pipe-A
[74.074953] Dynamic subtest pipe-A: SUCCESS (5.889s)
[74.089771] Starting dynamic subtest: pipe-B
[81.259949] Dynamic subtest pipe-B: SUCCESS (7.186s)
[81.273064] Starting dynamic subtest: pipe-C
[87.855396] Dynamic subtest pipe-C: SUCCESS (6.594s)
[87.865653] Starting dynamic subtest: pipe-D
[95.287690] Dynamic subtest pipe-D: SUCCESS (7.431s)
[95.296434] Starting dynamic subtest: all-pipes
[101.578906] Dynamic subtest all-pipes: SUCCESS (6.290s)
[101.581316] Subtest torture-bo: SUCCESS (33.394s)
[101.742630] [012/133] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[101.839686] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[101.844029] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[101.929081] [013/133] (916s left) core_setmaster (master-drop-set-user)
[102.016946] Starting subtest: master-drop-set-user
[102.031795] Subtest master-drop-set-user: SUCCESS (0.015s)
[102.069946] [014/133] (916s left) i915_selftest (live)
[103.786296] Starting subtest: live
[103.788514] Starting dynamic subtest: sanitycheck
[108.085514] Dynamic subtest sanitycheck: SUCCESS (4.302s)
[108.094394] Starting dynamic subtest: uncore
[112.382983] Dynamic subtest uncore: SUCCESS (4.296s)
[112.391988] Starting dynamic subtest: workarounds
[115.433492] Dynamic subtest workarounds: SUCCESS (3.050s)
[115.442542] Starting dynamic subtest: gt_engines
[118.529998] Dynamic subtest gt_engines: SUCCESS (3.096s)
[118.543310] Starting dynamic subtest: gt_timelines
[134.550989] Dynamic subtest gt_timelines: SUCCESS (16.019s)
[134.560259] Starting dynamic subtest: gt_contexts
[138.878514] Dynamic subtest gt_contexts: SUCCESS (4.327s)
[138.887368] Starting dynamic subtest: gt_lrc
[143.209610] Dynamic subtest gt_lrc: SUCCESS (4.331s)
[143.222281] Starting dynamic subtest: gt_mocs
[146.144935] Dynamic subtest gt_mocs: SUCCESS (2.934s)
[146.153759] Starting dynamic subtest: gt_pm
[152.855778] Dynamic subtest gt_pm: SUCCESS (6.709s)
[152.864806] Starting dynamic subtest: gt_heartbeat
[157.185484] Dynamic subtest gt_heartbeat: SUCCESS (4.328s)
[157.194714] Starting dynamic subtest: gt_tlb
[166.493599] Dynamic subtest gt_tlb: SUCCESS (9.306s)
[166.502903] Starting dynamic subtest: requests
[179.964208] Dynamic subtest requests: SUCCESS (13.468s)
[179.973474] Starting dynamic subtest: migrate
[185.788929] Dynamic subtest migrate: SUCCESS (5.822s)
[185.797656] Starting dynamic subtest: active
[188.471838] Dynamic subtest active: SUCCESS (2.681s)
[188.480802] Starting dynamic subtest: objects
[193.216529] Dynamic subtest objects: SUCCESS (4.744s)
[193.224847] Starting dynamic subtest: mman
[198.056043] Dynamic subtest mman: SUCCESS (4.838s)
[198.064846] Starting dynamic subtest: dmabuf
[202.446536] Dynamic subtest dmabuf: SUCCESS (4.389s)
[202.455520] Starting dynamic subtest: vma
[206.769033] Dynamic subtest vma: SUCCESS (4.322s)
[206.777539] Starting dynamic subtest: coherency
[212.145252] Dynamic subtest coherency: SUCCESS (5.374s)
[212.154442] Starting dynamic subtest: gtt
[222.113749] Dynamic subtest gtt: SUCCESS (9.967s)
[222.123743] Starting dynamic subtest: gem
[227.614467] Dynamic subtest gem: SUCCESS (5.500s)
[227.623341] Starting dynamic subtest: evict
[233.110986] Dynamic subtest evict: SUCCESS (5.495s)
[233.121136] Starting dynamic subtest: hugepages
[241.967054] Dynamic subtest hugepages: SUCCESS (8.854s)
[241.976408] Starting dynamic subtest: gem_contexts
[270.961957] Dynamic subtest gem_contexts: SUCCESS (28.993s)
[270.972738] Starting dynamic subtest: client
[275.283972] Dynamic subtest client: SUCCESS (4.321s)
[275.292695] Starting dynamic subtest: gem_migrate
[279.606051] Dynamic subtest gem_migrate: SUCCESS (4.320s)
[279.615462] Starting dynamic subtest: reset
[282.423078] Dynamic subtest reset: SUCCESS (2.815s)
[282.437886] Starting dynamic subtest: memory_region
[286.852362] Dynamic subtest memory_region: SUCCESS (4.428s)
[286.861802] Starting dynamic subtest: hangcheck
[300.208016] Dynamic subtest hangcheck: SUCCESS (13.352s)
[300.221542] Starting dynamic subtest: execlists
[304.559096] Dynamic subtest execlists: SUCCESS (4.349s)
[304.568401] Starting dynamic subtest: ring_submission
[308.951939] Dynamic subtest ring_submission: SUCCESS (4.391s)
[308.963031] Starting dynamic subtest: perf
[313.302356] Dynamic subtest perf: SUCCESS (4.349s)
[313.310261] Starting dynamic subtest: slpc
[327.328442] Dynamic subtest slpc: SUCCESS (14.023s)
[327.340332] Starting dynamic subtest: guc
[331.278416] Dynamic subtest guc: SUCCESS (3.947s)
[331.288034] Starting dynamic subtest: guc_multi_lrc
[333.981964] Dynamic subtest guc_multi_lrc: SUCCESS (2.702s)
[333.991248] Starting dynamic subtest: guc_hang
[338.898414] Dynamic subtest guc_hang: SUCCESS (4.915s)
[338.907868] Starting dynamic subtest: late_gt_pm
[341.598317] Dynamic subtest late_gt_pm: SUCCESS (2.697s)
[341.601012] Subtest live: SUCCESS (237.803s)
[341.627908] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[341.631154] [015/133] (677s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[343.190743] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[343.193045] Starting dynamic subtest: pipe-A
[343.285728] Dynamic subtest pipe-A: SUCCESS (0.098s)
[343.293462] Starting dynamic subtest: pipe-B
[344.451087] Dynamic subtest pipe-B: SUCCESS (1.164s)
[344.458932] Starting dynamic subtest: pipe-C
[345.557811] Dynamic subtest pipe-C: SUCCESS (1.105s)
[345.565592] Starting dynamic subtest: pipe-D
[346.685285] Dynamic subtest pipe-D: SUCCESS (1.127s)
[346.687662] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.498s)
[347.817465] [FACT kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)] new: kernel.kmod_is_loaded.i915: true
[347.821255] [016/133] (670s left) gen7_exec_parse (basic-rejected)
[347.901277] Subtest basic-rejected: SKIP (0.000s)
[347.974961] [017/133] (670s left) gem_exec_schedule (u-semaphore-noskip)
[348.052879] Starting subtest: u-semaphore-noskip
[348.453355] Subtest u-semaphore-noskip: SUCCESS (0.406s)
[348.791870] [018/133] (670s left) kms_rmfb (close-fd)
[348.875383] Starting subtest: close-fd
[348.877314] Starting dynamic subtest: pipe-A-eDP-1
[348.983228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[348.993135] Starting dynamic subtest: pipe-B-eDP-1
[350.200680] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[350.210255] Starting dynamic subtest: pipe-C-eDP-1
[351.347446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.146s)
[351.356234] Starting dynamic subtest: pipe-D-eDP-1
[352.469082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[352.471234] Subtest close-fd: SUCCESS (3.594s)
[353.682342] [019/133] (665s left) api_intel_bb (object-noreloc-purge-cache-simple)
[353.740842] Starting subtest: object-noreloc-purge-cache-simple
[353.745482] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.007s)
[353.884916] [020/133] (665s left) vgem_basic (sysfs)
[353.949965] Starting subtest: sysfs
[353.952207] Subtest sysfs: SUCCESS (0.001s)
[354.005609] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[354.009087] [021/133] (664s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[354.112652] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[354.114855] Starting dynamic subtest: A-eDP1
[363.041951] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[363.049857] Starting dynamic subtest: B-eDP1
[371.978950] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[371.989091] Starting dynamic subtest: C-eDP1
[380.894329] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[380.906654] Starting dynamic subtest: D-eDP1
[389.819864] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[389.824967] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.711s)
[391.049461] [022/133] (627s left) kms_cursor_crc (cursor-offscreen-32x10)
[391.208153] Starting subtest: cursor-offscreen-32x10
[391.267652] Subtest cursor-offscreen-32x10: SKIP (0.053s)
[391.533441] [023/133] (627s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[391.628555] Starting subtest: stress-xrgb8888-ytiled
[391.632986] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[391.701167] [024/133] (627s left) gem_mmap_offset (partial-remap)
[391.756070] Starting subtest: partial-remap
[391.757981] Starting dynamic subtest: smem0
[391.766925] Dynamic subtest smem0: SUCCESS (0.004s)
[391.769153] Subtest partial-remap: SUCCESS (0.005s)
[391.890442] [025/133] (627s left) gen7_exec_parse (basic-allocation)
[391.951195] Subtest basic-allocation: SKIP (0.000s)
[392.016674] [026/133] (627s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[392.105361] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[392.108867] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[392.175691] [027/133] (626s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[392.264949] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[393.356903] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.091s)
[393.509979] [028/133] (625s left) syncobj_basic (illegal-fd-to-handle)
[393.580923] Starting subtest: illegal-fd-to-handle
[393.582583] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[393.690407] [029/133] (625s left) gem_flink_race (flink_name)
[393.730700] Starting subtest: flink_name
[399.153699] Subtest flink_name: SUCCESS (5.421s)
[399.266849] [030/133] (620s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[399.400422] Starting subtest: cursorB-vs-flipA-atomic
[399.404758] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[399.542943] [031/133] (619s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[399.649502] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[399.653724] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[399.737865] [032/133] (619s left) gem_exec_reloc (basic-wc-read-noreloc)
[399.805151] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[399.901631] [033/133] (619s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[399.994150] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[399.996410] Starting dynamic subtest: pipe-A-eDP-1
[400.015954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[400.025634] Starting dynamic subtest: pipe-B-eDP-1
[400.045158] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[400.052884] Starting dynamic subtest: pipe-C-eDP-1
[400.072204] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[400.079800] Starting dynamic subtest: pipe-D-eDP-1
[400.099354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[400.101580] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[402.304308] [034/133] (617s left) kms_legacy_colorkey (invalid-plane)
[402.401076] Starting subtest: invalid-plane
[402.403286] Starting dynamic subtest: zero-id
[402.405470] Dynamic subtest zero-id: SUCCESS (0.000s)
[402.413677] Starting dynamic subtest: outrange-id
[402.415892] Dynamic subtest outrange-id: SUCCESS (0.000s)
[402.417743] Subtest invalid-plane: SUCCESS (0.001s)
[402.478740] [035/133] (617s left) kms_dsc (dsc-with-bpc)
[402.580925] Starting subtest: dsc-with-bpc
[402.610350] Subtest dsc-with-bpc: SKIP (0.001s)
[402.652141] [036/133] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[402.739819] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[406.306322] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.570s)
[407.508786] [037/133] (612s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[407.570579] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[407.673639] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[407.761675] [038/133] (611s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[407.854109] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[407.856553] Starting dynamic subtest: pipe-A-eDP-1
[407.948574] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[407.956904] Starting dynamic subtest: pipe-B-eDP-1
[409.075492] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[409.079780] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.227s)
[410.259838] [039/133] (609s left) api_intel_allocator (reserve-simple)
[410.314051] Starting subtest: reserve-simple
[410.316275] Subtest reserve-simple: SUCCESS (0.003s)
[410.427979] [040/133] (609s left) gem_exec_params (no-bsd)
[410.479910] Starting subtest: no-bsd
[410.485309] Subtest no-bsd: SUCCESS (0.003s)
[411.937282] [041/133] (607s left) syncobj_wait (wait-for-submit-snapshot)
[411.991964] Starting subtest: wait-for-submit-snapshot
[412.073082] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[412.154377] [042/133] (607s left) gem_ctx_persistence (hang)
[412.214249] Starting subtest: hang
[412.218922] Subtest hang: SKIP (0.000s)
[412.334899] [043/133] (607s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[412.417094] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[412.419235] Starting dynamic subtest: pipe-A-eDP-1
[412.477542] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[412.487286] Starting dynamic subtest: pipe-B-eDP-1
[412.544903] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[412.554391] Starting dynamic subtest: pipe-C-eDP-1
[412.613132] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[412.622506] Starting dynamic subtest: pipe-D-eDP-1
[412.681651] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[412.685848] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[414.639452] [044/133] (605s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[414.698691] Starting subtest: invalid-multi-wait-unsubmitted
[414.700695] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[414.805370] [045/133] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[414.903509] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[414.907928] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[415.008967] [046/133] (604s left) syncobj_wait (invalid-reset-zero-handles)
[415.078745] Starting subtest: invalid-reset-zero-handles
[415.081154] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[415.178817] [047/133] (604s left) gem_madvise (dontneed-before-exec)
[415.215523] Starting subtest: dontneed-before-exec
[415.236733] Subtest dontneed-before-exec: SKIP (0.020s)
[415.306957] [048/133] (604s left) perf (stress-open-close)
[415.429800] Starting subtest: stress-open-close
[415.432079] Starting dynamic subtest: 0-rcs0
[417.597326] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[417.605566] Starting dynamic subtest: 1-vecs0
[419.761262] Dynamic subtest 1-vecs0: SUCCESS (2.164s)
[419.763202] Subtest stress-open-close: SUCCESS (4.334s)
[419.807704] [049/133] (600s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[419.902295] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[420.002943] [050/133] (600s left) gem_ctx_persistence (engines-mixed)
[420.058213] Starting subtest: engines-mixed
[420.060163] Starting dynamic subtest: rcs0
[420.129730] Dynamic subtest rcs0: SUCCESS (0.070s)
[420.140643] Starting dynamic subtest: bcs0
[420.186366] Dynamic subtest bcs0: SUCCESS (0.056s)
[420.196981] Starting dynamic subtest: vcs0
[420.245303] Dynamic subtest vcs0: SUCCESS (0.057s)
[420.255082] Starting dynamic subtest: vcs1
[420.301347] Dynamic subtest vcs1: SUCCESS (0.054s)
[420.312481] Starting dynamic subtest: vecs0
[420.351189] Dynamic subtest vecs0: SUCCESS (0.048s)
[420.360158] Starting dynamic subtest: ccs0
[420.398143] Dynamic subtest ccs0: SUCCESS (0.045s)
[420.400032] Subtest engines-mixed: SUCCESS (0.340s)
[420.473639] [051/133] (599s left) kms_vrr (flip-suspend)
[420.559709] Starting subtest: flip-suspend
[420.564859] Subtest flip-suspend: SKIP (0.000s)
[420.626661] [052/133] (599s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[420.849347] Starting subtest: cursor-rapid-movement-128x128
[420.851375] Starting dynamic subtest: pipe-A-eDP-1
[421.416254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[421.445181] Starting dynamic subtest: pipe-D-eDP-1
[422.627123] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s)
[422.629229] Subtest cursor-rapid-movement-128x128: SUCCESS (1.777s)
[423.478404] [053/133] (596s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[423.539496] Starting subtest: wait-all-for-submit-delayed-submit
[423.643245] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[423.736998] [054/133] (596s left) gem_exec_fence (submit-chain)
[423.912751] Starting subtest: submit-chain
[423.930693] Subtest submit-chain: SUCCESS (0.020s)
[426.009436] [055/133] (594s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[426.111530] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[432.798027] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.688s)
[432.924133] [056/133] (587s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[433.030905] Starting subtest: fbc-rgb101010-draw-mmap-wc
[437.604260] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.577s)
[438.713969] [057/133] (581s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[438.819340] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[438.823364] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[438.924909] [058/133] (581s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[439.049993] Starting subtest: basic-busy-flip-before-cursor-varying-size
[439.054543] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[439.199468] [059/133] (581s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[439.295858] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[446.677302] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.385s)
[446.813069] [060/133] (573s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[446.910117] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[446.914223] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[446.996629] [061/133] (573s left) kms_properties (crtc-properties-atomic)
[447.085908] Starting subtest: crtc-properties-atomic
[447.087883] Starting dynamic subtest: pipe-A-eDP-1
[447.532620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[447.541896] Starting dynamic subtest: pipe-B-eDP-1
[448.702860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[448.711712] Starting dynamic subtest: pipe-C-eDP-1
[449.837465] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[449.846531] Starting dynamic subtest: pipe-D-eDP-1
[450.955024] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[450.957409] Subtest crtc-properties-atomic: SUCCESS (3.870s)
[451.767926] [062/133] (568s left) gem_exec_balancer (bonded-true-hang)
[452.035549] Starting subtest: bonded-true-hang
[452.040046] Subtest bonded-true-hang: SKIP (0.000s)
[452.135611] [063/133] (568s left) kms_plane (pixel-format-yf-tiled-modifier)
[452.239059] Starting subtest: pixel-format-yf-tiled-modifier
[452.243256] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[452.309698] [064/133] (568s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[452.402771] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[452.406795] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[452.491470] [065/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[452.581795] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[452.585796] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[452.679227] [066/133] (568s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[452.774810] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[453.587941] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[453.760261] [067/133] (567s left) gem_exec_suspend (basic)
[453.823766] Starting subtest: basic
[453.826083] Starting dynamic subtest: smem
[455.894403] Dynamic subtest smem: SUCCESS (2.068s)
[455.897213] Subtest basic: SUCCESS (2.070s)
[456.090272] [068/133] (564s left) kms_chamelium_frames (hdmi-frame-dump)
[456.465487] Subtest hdmi-frame-dump: SKIP (0.000s)
[457.269389] [069/133] (563s left) syncobj_timeline (multi-wait-all-signaled)
[457.324823] Starting subtest: multi-wait-all-signaled
[457.327275] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[457.425062] [070/133] (563s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[457.526756] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[457.531042] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[457.624338] [071/133] (563s left) gem_exec_flush (basic-uc-ro-default)
[457.682508] Starting subtest: basic-uc-ro-default
[463.141801] Subtest basic-uc-ro-default: SUCCESS (5.461s)
[463.342465] [072/133] (557s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[463.397923] Starting subtest: invalid-multi-wait-all-unsubmitted
[463.400141] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[463.477933] [073/133] (557s left) kms_color (invalid-ctm-matrix-sizes)
[463.577695] Starting subtest: invalid-ctm-matrix-sizes
[463.579742] Starting dynamic subtest: pipe-A
[463.581582] Dynamic subtest pipe-A: SUCCESS (0.002s)
[463.590120] Starting dynamic subtest: pipe-B
[463.592348] Dynamic subtest pipe-B: SUCCESS (0.003s)
[463.600307] Starting dynamic subtest: pipe-C
[463.602244] Dynamic subtest pipe-C: SUCCESS (0.003s)
[463.610576] Starting dynamic subtest: pipe-D
[463.612665] Dynamic subtest pipe-D: SUCCESS (0.004s)
[463.614729] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[463.661093] [074/133] (557s left) gem_exec_big (single)
[463.723911] Starting subtest: single
[467.343890] Subtest single: FAIL (3.560s)
[467.384625] [075/133] (553s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[467.548764] Starting subtest: fbc-modesetfrombusy
[471.359443] Subtest fbc-modesetfrombusy: SUCCESS (3.815s)
[472.546839] [076/133] (548s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[472.650265] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[472.652401] Starting dynamic subtest: pipe-A-eDP-1
[473.394073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[473.403827] Starting dynamic subtest: pipe-B-eDP-1
[475.177570] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.782s)
[475.187362] Starting dynamic subtest: pipe-C-eDP-1
[476.996191] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.817s)
[477.007022] Starting dynamic subtest: pipe-D-eDP-1
[478.821882] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.824s)
[478.824298] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.164s)
[479.947970] [077/133] (541s left) kms_atomic (plane-invalid-params)
[480.043420] Starting subtest: plane-invalid-params
[480.045781] Starting dynamic subtest: pipe-A-eDP-1
[480.474596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[480.476809] Subtest plane-invalid-params: SUCCESS (0.431s)
[481.289242] [078/133] (540s left) gem_spin_batch (resubmit-all)
[481.357348] Starting subtest: resubmit-all
[481.359728] Starting dynamic subtest: rcs0
[481.369685] Dynamic subtest rcs0: SUCCESS (0.013s)
[481.381614] Starting dynamic subtest: bcs0
[481.384046] Dynamic subtest bcs0: SUCCESS (0.002s)
[481.392764] Starting dynamic subtest: vcs0
[481.394955] Dynamic subtest vcs0: SUCCESS (0.002s)
[481.403519] Starting dynamic subtest: vcs1
[481.405733] Dynamic subtest vcs1: SUCCESS (0.002s)
[481.414208] Starting dynamic subtest: vecs0
[481.416366] Dynamic subtest vecs0: SUCCESS (0.002s)
[481.424803] Starting dynamic subtest: ccs0
[481.427027] Dynamic subtest ccs0: SUCCESS (0.002s)
[481.429205] Subtest resubmit-all: SUCCESS (0.028s)
[482.945348] [079/133] (538s left) gem_exec_params (invalid-fence-in-submit)
[483.001734] Starting subtest: invalid-fence-in-submit
[483.007953] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[483.142096] [080/133] (538s left) kms_psr (fbc-pr-cursor-blt)
[483.247511] Starting subtest: fbc-pr-cursor-blt
[483.251965] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[483.317978] [081/133] (538s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[483.417293] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[483.421715] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[483.491544] [082/133] (537s left) kms_flip (absolute-wf_vblank-interruptible)
[483.593079] Starting subtest: absolute-wf_vblank-interruptible
[483.595424] Starting dynamic subtest: A-eDP1
[492.335159] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[492.347701] Starting dynamic subtest: B-eDP1
[501.068210] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[501.077508] Starting dynamic subtest: C-eDP1
[509.789627] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[509.800289] Starting dynamic subtest: D-eDP1
[518.517078] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[518.522091] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.926s)
[519.750158] [083/133] (501s left) kms_vrr (flip-basic)
[519.859268] Starting subtest: flip-basic
[519.865432] Subtest flip-basic: SKIP (0.000s)
[519.929264] [084/133] (501s left) kms_flip (2x-flip-vs-expired-vblank)
[520.024374] Starting subtest: 2x-flip-vs-expired-vblank
[520.033181] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[520.118310] [085/133] (501s left) syncobj_wait (invalid-reset-one-illegal-handle)
[520.186075] Starting subtest: invalid-reset-one-illegal-handle
[520.188582] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[520.305795] [086/133] (501s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[520.361366] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[520.466448] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[520.556934] [087/133] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[520.652467] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[520.656711] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[520.735326] [088/133] (500s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[520.824865] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[520.827231] Starting dynamic subtest: pipe-A-eDP-1
[520.836350] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[520.846979] Starting dynamic subtest: pipe-B-eDP-1
[520.856065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[520.865137] Starting dynamic subtest: pipe-C-eDP-1
[520.873178] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[520.881439] Starting dynamic subtest: pipe-D-eDP-1
[520.889836] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[520.893965] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[523.088235] [089/133] (498s left) i915_hangman (engine-engine-hang)
[523.165322] Starting subtest: engine-engine-hang
[523.167229] Starting dynamic subtest: rcs0
[524.919482] Dynamic subtest rcs0: SUCCESS (1.753s)
[524.931856] Starting dynamic subtest: bcs0
[526.900361] Dynamic subtest bcs0: SUCCESS (1.978s)
[526.921808] Starting dynamic subtest: vcs0
[528.884889] Dynamic subtest vcs0: SUCCESS (1.980s)
[528.897081] Starting dynamic subtest: vcs1
[530.868608] Dynamic subtest vcs1: SUCCESS (1.981s)
[530.880422] Starting dynamic subtest: vecs0
[532.852390] Dynamic subtest vecs0: SUCCESS (1.981s)
[532.864633] Starting dynamic subtest: ccs0
[534.836422] Dynamic subtest ccs0: SUCCESS (1.981s)
[534.838928] Subtest engine-engine-hang: SUCCESS (11.672s)
[534.924235] [090/133] (486s left) gem_mmap_gtt (basic-small-copy-odd)
[534.980461] Subtest basic-small-copy-odd: SKIP (0.000s)
[535.047575] [091/133] (486s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[535.151248] Starting subtest: y-tiled-32bpp-rotate-90
[535.155284] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[535.250477] [092/133] (486s left) kms_psr (fbc-psr-sprite-blt)
[535.354083] Starting subtest: fbc-psr-sprite-blt
[535.356399] Starting dynamic subtest: eDP-1
[535.360687] Dynamic subtest eDP-1: SKIP (0.000s)
[535.364702] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[535.428019] [093/133] (486s left) gem_lmem_swapping (massive-random)
[535.475565] Subtest massive-random: SKIP (0.000s)
[535.515179] [094/133] (486s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[535.614347] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[535.618564] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[535.696322] [095/133] (486s left) gem_mmap_gtt (big-copy)
[535.765361] Subtest big-copy: SKIP (0.000s)
[535.842391] [096/133] (486s left) gem_exec_reloc (basic-gtt-cpu-active)
[535.901344] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[535.971298] [097/133] (486s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[536.080227] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[537.116666] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.036s)
[537.236817] [098/133] (484s left) gem_exec_reloc (basic-wc-cpu-active)
[537.285328] Subtest basic-wc-cpu-active: SKIP (0.000s)
[537.352569] [099/133] (484s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[537.446111] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[541.467087] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.023s)
[542.596247] [100/133] (479s left) syncobj_wait (wait-all-interrupted)
[542.647145] Starting subtest: wait-all-interrupted
[542.749122] Subtest wait-all-interrupted: SUCCESS (0.102s)
[542.835478] [101/133] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[542.938157] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[542.942204] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[543.038835] [102/133] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[543.139098] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[543.143061] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[543.239626] [103/133] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[543.337650] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[550.599387] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.267s)
[550.723013] [104/133] (471s left) gem_create (hog-create)
[550.786153] Starting subtest: hog-create
[550.788516] Starting dynamic subtest: smem0
[583.890322] Dynamic subtest smem0: SUCCESS (33.101s)
[583.892912] Subtest hog-create: SUCCESS (33.103s)
[584.091902] [105/133] (438s left) i915_pm_rps (fence-order)
[584.172313] Starting subtest: fence-order
[587.134155] Subtest fence-order: SUCCESS (2.959s)
[587.243906] [106/133] (435s left) kms_psr (psr-primary-blt)
[587.354073] Starting subtest: psr-primary-blt
[587.356421] Starting dynamic subtest: eDP-1
[589.100619] Dynamic subtest eDP-1: SUCCESS (1.745s)
[589.103060] Subtest psr-primary-blt: SUCCESS (1.747s)
[589.961296] [107/133] (432s left) gem_exec_schedule (pi-common)
[590.160707] Starting subtest: pi-common
[590.163190] Starting dynamic subtest: rcs0
[590.212621] Dynamic subtest rcs0: SUCCESS (0.053s)
[590.230956] Starting dynamic subtest: bcs0
[590.253019] Dynamic subtest bcs0: SUCCESS (0.040s)
[590.267821] Starting dynamic subtest: vcs0
[590.287014] Dynamic subtest vcs0: SUCCESS (0.033s)
[590.300912] Starting dynamic subtest: vcs1
[590.315374] Dynamic subtest vcs1: SUCCESS (0.028s)
[590.328239] Starting dynamic subtest: vecs0
[590.345522] Dynamic subtest vecs0: SUCCESS (0.029s)
[590.359310] Starting dynamic subtest: ccs0
[590.373696] Dynamic subtest ccs0: SUCCESS (0.027s)
[590.375990] Subtest pi-common: SUCCESS (0.216s)
[590.609166] [108/133] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[590.721620] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[590.725785] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[590.842961] [109/133] (431s left) gem_exec_store (dword)
[590.899420] Starting subtest: dword
[590.901723] Starting dynamic subtest: rcs0
[590.975405] Dynamic subtest rcs0: SUCCESS (0.078s)
[590.988265] Starting dynamic subtest: bcs0
[591.016755] Dynamic subtest bcs0: SUCCESS (0.040s)
[591.028187] Starting dynamic subtest: vcs0
[591.058625] Dynamic subtest vcs0: SUCCESS (0.040s)
[591.069197] Starting dynamic subtest: vcs1
[591.100430] Dynamic subtest vcs1: SUCCESS (0.040s)
[591.111223] Starting dynamic subtest: vecs0
[591.142866] Dynamic subtest vecs0: SUCCESS (0.040s)
[591.153829] Starting dynamic subtest: ccs0
[591.186037] Dynamic subtest ccs0: SUCCESS (0.041s)
[591.188478] Subtest dword: SUCCESS (0.291s)
[591.385973] [110/133] (431s left) kms_pm_dc (dc5-dpms-negative)
[592.489357] Starting subtest: dc5-dpms-negative
[592.493745] Subtest dc5-dpms-negative: SKIP (0.000s)
[592.583546] [111/133] (430s left) gem_mmap_gtt (basic-read-write-distinct)
[592.642048] Subtest basic-read-write-distinct: SKIP (0.000s)
[592.702662] [112/133] (430s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[592.802051] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[592.806338] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[592.871115] [113/133] (429s left) gem_render_copy (yf-tiled)
[592.931575] Starting subtest: yf-tiled
[592.936075] Subtest yf-tiled: SKIP (0.000s)
[593.116717] [114/133] (429s left) kms_pm_rpm (legacy-planes)
[595.040392] Starting subtest: legacy-planes
[595.043236] Starting dynamic subtest: plane-65
[603.316533] Dynamic subtest plane-65: SUCCESS (8.275s)
[603.329522] Starting dynamic subtest: plane-95
[611.620785] Dynamic subtest plane-95: SUCCESS (8.302s)
[611.631810] Starting dynamic subtest: plane-125
[619.933717] Dynamic subtest plane-125: SUCCESS (8.310s)
[619.945502] Starting dynamic subtest: plane-135
[628.244688] Dynamic subtest plane-135: SUCCESS (8.309s)
[628.247205] Subtest legacy-planes: SUCCESS (33.206s)
[628.632645] [115/133] (394s left) perf_pmu (gt-awake)
[628.679026] Starting subtest: gt-awake
[636.888191] Subtest gt-awake: SUCCESS (8.208s)
[637.021385] [116/133] (385s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[637.141268] Starting subtest: 2x-long-cursor-vs-flip-legacy
[637.145686] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[637.292350] [117/133] (385s left) kms_psr (pr-sprite-mmap-gtt)
[637.388788] Starting subtest: pr-sprite-mmap-gtt
[637.393217] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[637.462831] [118/133] (385s left) kms_psr (fbc-psr2-no-drrs)
[637.548166] Starting subtest: fbc-psr2-no-drrs
[637.550472] Starting dynamic subtest: eDP-1
[637.554850] Dynamic subtest eDP-1: SKIP (0.000s)
[637.559240] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[637.621245] [119/133] (385s left) i915_drm_fdinfo (virtual-busy)
[637.668495] Starting subtest: virtual-busy
[637.672802] Subtest virtual-busy: SKIP (0.000s)
[637.734568] [120/133] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[637.832061] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[637.836191] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[637.944175] [121/133] (385s left) kms_vblank (query-busy-hang)
[638.046618] Starting subtest: query-busy-hang
[638.048574] Starting dynamic subtest: pipe-A-eDP-1
[664.662635] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.613s)
[664.677266] Starting dynamic subtest: pipe-D-eDP-1
[689.677131] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s)
[689.679625] Subtest query-busy-hang: SUCCESS (51.631s)
[690.489533] [122/133] (332s left) gem_ctx_shared (single-timeline)
[690.559394] Starting subtest: single-timeline
[690.579668] Subtest single-timeline: SUCCESS (0.012s)
[690.803285] [123/133] (332s left) kms_psr (psr2-primary-page-flip)
[690.896251] Starting subtest: psr2-primary-page-flip
[690.898607] Starting dynamic subtest: eDP-1
[692.648834] Dynamic subtest eDP-1: SUCCESS (1.753s)
[692.651141] Subtest psr2-primary-page-flip: SUCCESS (1.754s)
[693.534610] [124/133] (329s left) syncobj_timeline (wait-zero-handles)
[693.607258] Starting subtest: wait-zero-handles
[693.609596] Subtest wait-zero-handles: SUCCESS (0.000s)
[693.729435] [125/133] (329s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[693.849703] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[701.157599] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.310s)
[701.273629] [126/133] (322s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[701.671232] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[702.460143] [127/133] (320s left) dumb_buffer (map-uaf)
[702.515711] Starting subtest: map-uaf
[702.520663] Subtest map-uaf: SUCCESS (0.006s)
[702.629184] [128/133] (320s left) kms_atomic_transition (plane-all-modeset-transition)
[702.724253] Starting subtest: plane-all-modeset-transition
[702.728645] Subtest plane-all-modeset-transition: SKIP (0.000s)
[702.797086] [129/133] (320s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[702.862061] Starting subtest: yf-tiled-ccs-to-y-tiled
[702.867052] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[703.061111] [130/133] (320s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[703.114424] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[703.116777] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[703.231080] [131/133] (320s left) syncobj_timeline (wait-all-for-submit-complex)
[703.282348] Starting subtest: wait-all-for-submit-complex
[703.495855] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[703.584619] [132/133] (320s left) gem_pxp (fail-invalid-protected-context)
[703.706039] Starting subtest: fail-invalid-protected-context
[703.708757] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[703.834414] [133/133] (319s left) gem_mmap_gtt (fault-concurrent-x)
[703.884585] Subtest fault-concurrent-X: SKIP (0.000s)
[703.933990] 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.