[57.861226] Initializing watchdogs
[57.861274]   /dev/watchdog0
[57.877059] [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.881536] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.884280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.886129] [001/133] (960s left) gem_exec_fence (syncobj-timeline-export)
[58.472379] Starting subtest: syncobj-timeline-export
[58.475185] Subtest syncobj-timeline-export: SUCCESS (0.013s)
[59.443055] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[59.444953] [002/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[59.546638] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[59.548518] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[59.633723] [003/133] (958s left) kms_cursor_crc (cursor-random-max-size)
[59.943248] Starting subtest: cursor-random-max-size
[59.946052] Subtest cursor-random-max-size: SKIP (0.000s)
[60.076157] [004/133] (958s left) kms_plane_multiple (2x-tiling-x)
[60.163034] Starting subtest: 2x-tiling-x
[60.164935] Subtest 2x-tiling-x: SKIP (0.000s)
[60.234471] [005/133] (958s left) gem_mmap_offset (bad-flags)
[60.293353] Starting subtest: bad-flags
[60.294294] Subtest bad-flags: SUCCESS (0.000s)
[60.399658] [006/133] (958s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[60.453726] Starting subtest: y-tiled-ccs-to-x-tiled
[60.455609] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[60.627950] [007/133] (957s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[60.724647] Starting subtest: psr2-overlay-plane-move-continuous-sf
[60.725566] Starting dynamic subtest: pipe-A-eDP-1
[66.759516] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.031s)
[66.766090] Starting dynamic subtest: pipe-B-eDP-1
[73.405576] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[73.406493] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.675s)
[74.211891] [008/133] (944s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[74.331866] Starting subtest: cursorA-vs-flipB-varying-size
[74.333784] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[74.468905] [009/133] (944s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[74.557896] Starting subtest: plane-use-after-nonblocking-unbind
[74.558979] Starting dynamic subtest: pipe-A-eDP-1
[74.620236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[74.931077] Starting dynamic subtest: pipe-B-eDP-1
[75.715619] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.791s)
[76.014860] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.457s)
[76.869013] [010/133] (941s left) kms_psr (fbc-pr-primary-mmap-gtt)
[76.966181] Starting subtest: fbc-pr-primary-mmap-gtt
[76.967886] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[77.032284] [011/133] (941s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[77.119176] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[77.120152] Starting dynamic subtest: pipe-A-eDP-1
[77.129148] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.136618] Starting dynamic subtest: pipe-B-eDP-1
[77.145281] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.151679] Starting dynamic subtest: pipe-C-eDP-1
[77.159691] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.165839] Starting dynamic subtest: pipe-D-eDP-1
[77.174521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.176125] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[79.351505] [012/133] (939s left) gem_exec_params (invalid-ring2)
[79.405409] Starting subtest: invalid-ring2
[79.406529] Subtest invalid-ring2: SUCCESS (0.000s)
[79.494575] [013/133] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[79.584879] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[79.586511] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[79.681330] [014/133] (939s left) kms_hdr (invalid-hdr)
[79.760354] Starting subtest: invalid-hdr
[81.875786] Starting dynamic subtest: pipe-A-eDP-1
[84.570621] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.694s)
[84.571682] Subtest invalid-hdr: SUCCESS (4.811s)
[84.669815] [015/133] (934s left) kms_atomic (atomic-invalid-params)
[84.782106] Starting subtest: atomic-invalid-params
[84.783056] Starting dynamic subtest: pipe-A-eDP-1
[86.221115] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.438s)
[86.222032] Subtest atomic-invalid-params: SUCCESS (1.439s)
[87.077790] [016/133] (931s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[87.178576] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[87.180271] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[87.269877] [017/133] (931s left) gem_pwrite (basic-exhaustion)
[87.333624] Subtest basic-exhaustion: SKIP (0.000s)
[87.386120] [018/133] (931s left) gem_exec_flush (basic-uc-rw-default)
[87.438509] Starting subtest: basic-uc-rw-default
[92.911984] Subtest basic-uc-rw-default: SUCCESS (5.472s)
[93.091592] [019/133] (925s left) kms_atomic_interruptible (legacy-cursor)
[93.179942] Starting subtest: legacy-cursor
[93.181138] Starting dynamic subtest: pipe-A-eDP-1
[100.594905] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.414s)
[100.596386] Subtest legacy-cursor: SUCCESS (7.415s)
[101.431386] [020/133] (917s left) kms_flip (flip-vs-suspend-interruptible)
[101.527245] Starting subtest: flip-vs-suspend-interruptible
[101.528216] Starting dynamic subtest: A-eDP1
[214.889335] Dynamic subtest A-eDP1: SUCCESS (11.832s)
[214.890484] Subtest flip-vs-suspend-interruptible: SUCCESS (11.835s)
[222.038166] [021/133] (804s left) gem_pipe_control_store_loop (reused-buffer)
[222.096802] Starting subtest: reused-buffer
[224.301115] Subtest reused-buffer: SUCCESS (2.154s)
[224.373812] [022/133] (801s left) prime_self_import (basic-llseek-size)
[224.407781] Starting subtest: basic-llseek-size
[224.424432] Subtest basic-llseek-size: SUCCESS (0.016s)
[224.507018] [023/133] (801s left) sysfs_timeslice_duration (invalid)
[224.561827] Starting subtest: invalid
[224.563278] Starting dynamic subtest: vecs0
[224.564555] Dynamic subtest vecs0: SUCCESS (0.000s)
[224.573952] Starting dynamic subtest: ccs0
[224.575156] Dynamic subtest ccs0: SUCCESS (0.000s)
[224.582841] Starting dynamic subtest: vcs0
[224.584128] Dynamic subtest vcs0: SUCCESS (0.000s)
[224.591643] Starting dynamic subtest: bcs0
[224.593149] Dynamic subtest bcs0: SUCCESS (0.000s)
[224.602855] Starting dynamic subtest: rcs0
[224.604091] Dynamic subtest rcs0: SUCCESS (0.000s)
[224.612019] Starting dynamic subtest: vcs1
[224.613182] Dynamic subtest vcs1: SUCCESS (0.000s)
[224.614450] Subtest invalid: SUCCESS (0.004s)
[224.663498] [024/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[224.763031] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[231.557002] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.782s)
[231.663480] [025/133] (794s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[231.758086] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[236.033334] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.272s)
[237.176779] [026/133] (789s left) gem_exec_whisper (basic-contexts-all)
[237.243960] Starting subtest: basic-contexts-all
[247.333182] Subtest basic-contexts-all: SUCCESS (10.082s)
[247.512417] [027/133] (778s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[247.567810] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[247.568855] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[247.670489] [028/133] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[247.759912] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[247.761697] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[247.839764] [029/133] (778s left) kms_addfb_basic (bad-pitch-128)
[247.894427] Starting subtest: bad-pitch-128
[247.895967] Subtest bad-pitch-128: SUCCESS (0.000s)
[248.023744] [030/133] (778s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[248.129806] Starting subtest: 2x-cursor-vs-flip-atomic
[248.131771] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[248.269399] [031/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[248.353165] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[255.784957] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.432s)
[255.918325] [032/133] (770s left) gem_exec_balancer (bonded-pair)
[255.973451] Starting subtest: bonded-pair
[255.975864] Subtest bonded-pair: SKIP (0.000s)
[256.272357] [033/133] (770s left) gem_close_race (multigpu-basic-process)
[256.334128] Starting subtest: multigpu-basic-process
[256.337071] Subtest multigpu-basic-process: SKIP (0.000s)
[256.554865] [034/133] (769s left) kms_fbcon_fbt (fbc)
[256.611975] Starting subtest: fbc
[262.979005] Subtest fbc: SUCCESS (6.358s)
[264.051465] [035/133] (762s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[264.143465] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[264.144847] Starting dynamic subtest: pipe-A-eDP-1
[264.299497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.152s)
[264.309461] Starting dynamic subtest: pipe-B-eDP-1
[264.319380] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[264.327630] Starting dynamic subtest: pipe-C-eDP-1
[264.346131] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[264.353907] Starting dynamic subtest: pipe-D-eDP-1
[264.363440] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[264.364416] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.160s)
[266.548675] [036/133] (760s left) gen7_exec_parse (bitmasks)
[266.597219] Subtest bitmasks: SKIP (0.000s)
[266.663237] [037/133] (759s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[266.730506] Starting subtest: invalid-single-wait-unsubmitted
[266.732148] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[266.836357] [038/133] (759s left) kms_display_modes (extended-mode-basic)
[266.940393] Starting subtest: extended-mode-basic
[266.942801] Subtest extended-mode-basic: SKIP (0.000s)
[266.982255] [039/133] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[267.071970] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[267.074238] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[267.170508] [040/133] (759s left) gem_exec_schedule (preempt-other)
[267.228781] Starting subtest: preempt-other
[267.229794] Starting dynamic subtest: rcs0
[267.310296] Dynamic subtest rcs0: SUCCESS (0.081s)
[267.319159] Starting dynamic subtest: bcs0
[267.378574] Dynamic subtest bcs0: SUCCESS (0.067s)
[267.390385] Starting dynamic subtest: vcs0
[267.441348] Dynamic subtest vcs0: SUCCESS (0.062s)
[267.452020] Starting dynamic subtest: vcs1
[267.507165] Dynamic subtest vcs1: SUCCESS (0.065s)
[267.519051] Starting dynamic subtest: vecs0
[267.573586] Dynamic subtest vecs0: SUCCESS (0.066s)
[267.586161] Starting dynamic subtest: ccs0
[267.640107] Dynamic subtest ccs0: SUCCESS (0.066s)
[267.641425] Subtest preempt-other: SUCCESS (0.412s)
[268.928955] [041/133] (757s left) dumb_buffer (map-invalid-size)
[268.992446] Starting subtest: map-invalid-size
[268.993998] Subtest map-invalid-size: SUCCESS (0.000s)
[269.082660] [042/133] (757s left) kms_cursor_crc (cursor-sliding-512x170)
[269.372432] Starting subtest: cursor-sliding-512x170
[269.375350] Subtest cursor-sliding-512x170: SKIP (0.001s)
[269.506579] [043/133] (757s left) sw_sync (sync_busy_fork_unixsocket)
[269.542258] Starting subtest: sync_busy_fork_unixsocket
[269.547925] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[269.603650] [044/133] (757s left) perf (non-zero-reason)
[269.718242] Starting subtest: non-zero-reason
[269.719870] Starting dynamic subtest: 0-rcs0
[275.332548] Dynamic subtest 0-rcs0: SUCCESS (5.604s)
[275.344724] Starting dynamic subtest: 1-vecs0
[279.348946] Dynamic subtest 1-vecs0: SUCCESS (4.015s)
[279.350414] Subtest non-zero-reason: SUCCESS (9.621s)
[279.386803] [045/133] (747s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[279.474219] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[279.475186] Starting dynamic subtest: pipe-A-eDP-1
[279.486481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.496185] Starting dynamic subtest: pipe-B-eDP-1
[279.506847] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.516082] Starting dynamic subtest: pipe-C-eDP-1
[279.525715] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.533652] Starting dynamic subtest: pipe-D-eDP-1
[279.543733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.545747] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[281.780346] [046/133] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[281.877007] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[281.879138] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[281.964881] [047/133] (744s left) gem_render_copy_redux (flink)
[282.017104] Starting subtest: flink
[282.769434] Subtest flink: SUCCESS (0.752s)
[282.889114] [048/133] (744s left) sriov_basic (enable-vfs-bind-unbind-each)
[282.940566] Starting subtest: enable-vfs-bind-unbind-each
[282.941662] Starting dynamic subtest: numvfs-1
[282.975793] Dynamic subtest numvfs-1: FAIL (0.017s)
[282.984655] Starting dynamic subtest: numvfs-2
[283.020112] Dynamic subtest numvfs-2: FAIL (0.004s)
[283.032989] Starting dynamic subtest: numvfs-3
[283.063340] Dynamic subtest numvfs-3: FAIL (0.004s)
[283.071497] Starting dynamic subtest: numvfs-4
[283.104455] Dynamic subtest numvfs-4: FAIL (0.004s)
[283.112555] Starting dynamic subtest: numvfs-5
[283.141194] Dynamic subtest numvfs-5: FAIL (0.004s)
[283.149494] Starting dynamic subtest: numvfs-6
[283.177941] Dynamic subtest numvfs-6: FAIL (0.004s)
[283.185774] Starting dynamic subtest: numvfs-7
[283.213380] Dynamic subtest numvfs-7: FAIL (0.004s)
[283.221286] Starting dynamic subtest: numvfs-random
[283.249356] Dynamic subtest numvfs-random: FAIL (0.004s)
[283.250259] Subtest enable-vfs-bind-unbind-each: FAIL (0.047s)
[283.297250] [049/133] (743s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[283.388961] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[284.214334] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[284.368090] [050/133] (742s left) kms_addfb_basic (bad-pitch-256)
[284.413823] Starting subtest: bad-pitch-256
[284.414954] Subtest bad-pitch-256: SUCCESS (0.000s)
[284.552123] [051/133] (742s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[284.648099] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[284.649204] Starting dynamic subtest: pipe-A-eDP-1
[285.124839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[285.133576] Starting dynamic subtest: pipe-B-eDP-1
[286.560227] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[286.568724] Starting dynamic subtest: pipe-C-eDP-1
[287.915427] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s)
[287.924090] Starting dynamic subtest: pipe-D-eDP-1
[289.240160] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[289.241128] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.580s)
[290.345939] [052/133] (736s left) gem_userptr_blits (sync-unmap-after-close)
[290.407259] Starting subtest: sync-unmap-after-close
[290.417067] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[290.540160] [053/133] (736s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[290.631050] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[290.633052] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[290.721832] [054/133] (736s left) gem_exec_async (forked-writes)
[290.790938] Starting subtest: forked-writes
[290.792275] Starting dynamic subtest: rcs0
[290.833833] Dynamic subtest rcs0: SUCCESS (0.042s)
[290.843419] Starting dynamic subtest: bcs0
[290.858189] Dynamic subtest bcs0: SUCCESS (0.023s)
[290.867331] Starting dynamic subtest: vcs0
[290.879965] Dynamic subtest vcs0: SUCCESS (0.021s)
[290.890037] Starting dynamic subtest: vcs1
[290.925051] Dynamic subtest vcs1: SUCCESS (0.044s)
[290.935377] Starting dynamic subtest: vecs0
[290.971945] Dynamic subtest vecs0: SUCCESS (0.045s)
[290.982503] Starting dynamic subtest: ccs0
[290.997941] Dynamic subtest ccs0: SUCCESS (0.024s)
[290.999270] Subtest forked-writes: SUCCESS (0.208s)
[291.207880] [055/133] (736s left) gem_userptr_blits (process-exit-busy)
[291.270936] Starting subtest: process-exit-busy
[291.282811] Subtest process-exit-busy: SUCCESS (0.014s)
[291.400145] [056/133] (735s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[291.452923] Subtest no-spare-fences-busy: SKIP (0.000s)
[291.517761] [057/133] (735s left) kms_flip (busy-flip)
[291.601846] Starting subtest: busy-flip
[291.605114] Starting dynamic subtest: A-eDP1
[293.265281] Dynamic subtest A-eDP1: SUCCESS (1.661s)
[293.277312] Starting dynamic subtest: B-eDP1
[294.996112] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[295.006607] Starting dynamic subtest: C-eDP1
[296.714486] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[296.723360] Starting dynamic subtest: D-eDP1
[298.351828] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[298.355824] Subtest busy-flip: SUCCESS (6.751s)
[299.506191] [058/133] (727s left) vgem_basic (sysfs)
[299.540541] Starting subtest: sysfs
[299.541417] Subtest sysfs: SUCCESS (0.000s)
[299.594793] [059/133] (727s left) gem_exec_balancer (parallel-contexts)
[299.852259] Starting subtest: parallel-contexts
[302.632188] Subtest parallel-contexts: SUCCESS (2.781s)
[302.739753] [060/133] (724s left) api_intel_allocator (fork-simple-stress)
[302.784961] Starting subtest: fork-simple-stress
[308.193618] Subtest fork-simple-stress: SUCCESS (5.398s)
[308.302244] [061/133] (719s left) gem_vm_create (execbuf)
[308.363206] Starting subtest: execbuf
[308.377739] Subtest execbuf: SUCCESS (0.014s)
[308.509598] [062/133] (719s left) gem_ctx_isolation (dirty-create)
[308.563194] Starting subtest: dirty-create
[308.564136] Starting dynamic subtest: rcs0
[308.823399] Dynamic subtest rcs0: SUCCESS (0.260s)
[308.833366] Starting dynamic subtest: bcs0
[309.090058] Dynamic subtest bcs0: SUCCESS (0.265s)
[309.099475] Starting dynamic subtest: vcs0
[309.368166] Dynamic subtest vcs0: SUCCESS (0.277s)
[309.382063] Starting dynamic subtest: vcs1
[311.050584] Dynamic subtest vcs1: SUCCESS (1.680s)
[311.062020] Starting dynamic subtest: vecs0
[313.020000] Dynamic subtest vecs0: SUCCESS (1.968s)
[313.030587] Starting dynamic subtest: ccs0
[315.103540] Dynamic subtest ccs0: SUCCESS (2.082s)
[315.105112] Subtest dirty-create: SUCCESS (6.539s)
[315.326217] [063/133] (712s left) api_intel_bb (intel-bb-blit-none)
[315.374611] Starting subtest: intel-bb-blit-none
[319.509180] Subtest intel-bb-blit-none: SUCCESS (4.127s)
[319.613077] [064/133] (707s left) kms_psr (pr-sprite-render)
[319.704223] Starting subtest: pr-sprite-render
[319.706443] Subtest pr-sprite-render: SKIP (0.000s)
[319.772553] [065/133] (707s left) gem_userptr_blits (sync-unmap-cycles)
[319.833032] Starting subtest: sync-unmap-cycles
[325.210919] Subtest sync-unmap-cycles: SUCCESS (5.380s)
[325.347061] [066/133] (702s left) gem_pxp (reject-modify-context-protection-off-3)
[325.468052] Starting subtest: reject-modify-context-protection-off-3
[325.471227] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[325.570049] [067/133] (702s left) gem_render_copy_redux (interruptible)
[325.621272] Starting subtest: interruptible
[325.996567] Subtest interruptible: SUCCESS (0.375s)
[326.115777] [068/133] (701s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[326.209545] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[326.211189] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[326.284468] [069/133] (701s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[326.369133] Starting subtest: fbc-psr2-sprite-mmap-gtt
[326.370068] Starting dynamic subtest: eDP-1
[326.372102] Dynamic subtest eDP-1: SKIP (0.000s)
[326.373827] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[326.438713] [070/133] (701s left) kms_content_protection (dp-mst-type-1)
[326.566962] Starting subtest: dp-mst-type-1
[326.568737] Subtest dp-mst-type-1: SKIP (0.000s)
[326.683555] [071/133] (701s left) gem_workarounds (reset-fd)
[326.742034] Starting subtest: reset-fd
[326.932577] Subtest reset-fd: SUCCESS (0.191s)
[327.042677] [072/133] (700s left) fbdev (write)
[327.085284] Starting subtest: write
[327.454731] Subtest write: SUCCESS (0.361s)
[327.509670] [073/133] (700s left) kms_chamelium_frames (dp-crc-multiple)
[327.881136] Subtest dp-crc-multiple: SKIP (0.000s)
[328.706247] [074/133] (699s left) kms_lease (lease-invalid-crtc)
[328.791714] Starting subtest: lease-invalid-crtc
[328.792723] Starting dynamic subtest: pipe-A-eDP-1
[328.793547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[328.802322] Starting dynamic subtest: pipe-B-eDP-1
[328.803449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[328.812827] Starting dynamic subtest: pipe-C-eDP-1
[328.813810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[328.822763] Starting dynamic subtest: pipe-D-eDP-1
[328.823770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[328.824831] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[328.863270] [075/133] (699s left) kms_properties (crtc-properties-atomic)
[328.956343] Starting subtest: crtc-properties-atomic
[328.957552] Starting dynamic subtest: pipe-A-eDP-1
[329.401850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[329.412939] Starting dynamic subtest: pipe-B-eDP-1
[330.579830] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s)
[330.591355] Starting dynamic subtest: pipe-C-eDP-1
[331.717241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[331.728447] Starting dynamic subtest: pipe-D-eDP-1
[332.836904] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[332.838411] Subtest crtc-properties-atomic: SUCCESS (3.881s)
[333.641269] [076/133] (694s left) kms_chamelium_color (ctm-0-75)
[333.731783] Subtest ctm-0-75: SKIP (0.000s)
[333.774284] [077/133] (694s left) gem_exec_parallel (userptr)
[333.833492] Starting subtest: userptr
[333.834889] Starting dynamic subtest: rcs0
[335.495799] Dynamic subtest rcs0: SUCCESS (1.664s)
[335.505799] Starting dynamic subtest: bcs0
[337.228963] Dynamic subtest bcs0: SUCCESS (1.732s)
[337.239544] Starting dynamic subtest: vcs0
[338.903701] Dynamic subtest vcs0: SUCCESS (1.665s)
[338.913248] Starting dynamic subtest: vcs1
[340.812506] Dynamic subtest vcs1: SUCCESS (1.907s)
[340.822284] Starting dynamic subtest: vecs0
[342.847395] Dynamic subtest vecs0: SUCCESS (2.032s)
[342.856859] Starting dynamic subtest: ccs0
[344.598743] Dynamic subtest ccs0: SUCCESS (1.759s)
[344.600108] Subtest userptr: SUCCESS (10.770s)
[344.782429] [078/133] (683s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[344.878259] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[344.906708] Starting dynamic subtest: pipe-A-plane-0
[345.340130] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[345.350783] Starting dynamic subtest: pipe-A-plane-3
[345.595509] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[345.606848] Starting dynamic subtest: pipe-A-plane-5
[345.609248] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[346.739300] Starting dynamic subtest: pipe-B-plane-0
[347.174991] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[347.184159] Starting dynamic subtest: pipe-B-plane-3
[347.452448] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[347.469070] Starting dynamic subtest: pipe-B-plane-5
[347.471556] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[347.777792] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.899s)
[349.158703] [079/133] (678s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[349.255278] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[349.257846] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[349.322702] [080/133] (678s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[349.417238] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[350.606977] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.191s)
[350.738582] [081/133] (677s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[350.819778] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[350.821824] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[350.909289] [082/133] (677s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[350.992891] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[350.994753] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[351.089118] [083/133] (677s left) kms_color (ctm-max)
[351.176492] Starting subtest: ctm-max
[351.177375] Starting dynamic subtest: pipe-A-eDP-1
[351.889791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[351.898889] Starting dynamic subtest: pipe-B-eDP-1
[353.265979] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[353.276903] Starting dynamic subtest: pipe-C-eDP-1
[354.662816] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[354.672002] Starting dynamic subtest: pipe-D-eDP-1
[355.988127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[355.989269] Subtest ctm-max: SUCCESS (4.813s)
[356.798150] [084/133] (671s left) kms_cursor_crc (cursor-onscreen-128x128)
[357.029928] Starting subtest: cursor-onscreen-128x128
[357.033979] Starting dynamic subtest: pipe-A-eDP-1
[359.153286] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[359.184556] Starting dynamic subtest: pipe-D-eDP-1
[362.005661] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.829s)
[362.007103] Subtest cursor-onscreen-128x128: SUCCESS (4.975s)
[362.868242] [085/133] (665s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[362.952453] Starting subtest: multiplane-rotation-cropping-bottom
[380.612331] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.660s)
[380.712297] [086/133] (647s left) gem_exec_params (sol-reset-invalid)
[380.762001] Starting subtest: sol-reset-invalid
[380.765234] Subtest sol-reset-invalid: SUCCESS (0.004s)
[381.953494] [087/133] (646s left) gem_eio (reset-stress)
[382.193366] Starting subtest: reset-stress
[382.194736] Starting dynamic subtest: render
[387.275416] Dynamic subtest render: SUCCESS (5.080s)
[387.290687] Starting dynamic subtest: bsd1
[405.400548] Dynamic subtest bsd1: SUCCESS (18.122s)
[405.416560] Starting dynamic subtest: bsd2
[423.378965] Dynamic subtest bsd2: SUCCESS (17.975s)
[423.395225] Starting dynamic subtest: blt
[423.397335] Dynamic subtest blt: SKIP (0.000s)
[423.406014] Starting dynamic subtest: vebox
[441.347681] Dynamic subtest vebox: SUCCESS (17.964s)
[441.349144] Subtest reset-stress: SUCCESS (59.145s)
[442.920491] [088/133] (585s left) gem_softpin (reverse)
[442.984581] Starting subtest: reverse
[442.989968] Subtest reverse: SUCCESS (0.005s)
[443.102993] [089/133] (585s left) perf_pmu (multi-client)
[443.136212] Starting subtest: multi-client
[443.137362] Starting dynamic subtest: rcs0
[444.186558] Dynamic subtest rcs0: SUCCESS (1.041s)
[444.198932] Starting dynamic subtest: bcs0
[445.242452] Dynamic subtest bcs0: SUCCESS (1.053s)
[445.255075] Starting dynamic subtest: vcs0
[446.297020] Dynamic subtest vcs0: SUCCESS (1.052s)
[446.309036] Starting dynamic subtest: vcs1
[447.865494] Dynamic subtest vcs1: SUCCESS (1.566s)
[447.878047] Starting dynamic subtest: vecs0
[449.846531] Dynamic subtest vecs0: SUCCESS (1.978s)
[449.858561] Starting dynamic subtest: ccs0
[451.894817] Dynamic subtest ccs0: SUCCESS (2.045s)
[451.896282] Subtest multi-client: SUCCESS (8.751s)
[452.004088] [090/133] (576s left) gem_mmap (bad-object)
[452.055841] Subtest bad-object: SKIP (0.000s)
[452.115468] [091/133] (576s left) i915_drm_fdinfo (memory-info-purgeable)
[452.153157] Starting subtest: memory-info-purgeable
[452.154145] Starting dynamic subtest: smem0
[455.203065] Dynamic subtest smem0: SUCCESS (3.049s)
[455.204547] Subtest memory-info-purgeable: SUCCESS (3.050s)
[455.283993] [092/133] (573s left) gem_tiled_partial_pwrite_pread (writes)
[455.337914] Subtest writes: SKIP (0.000s)
[455.404866] [093/133] (573s left) kms_joiner (basic-force-big-joiner)
[455.504812] Starting subtest: basic-force-big-joiner
[455.506829] Subtest basic-force-big-joiner: SKIP (0.000s)
[455.573298] [094/133] (573s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[455.652507] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[455.654899] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[455.722882] [095/133] (572s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[455.849090] Starting subtest: y-tiled-8bpp-rotate-180
[455.851495] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[455.948638] [096/133] (572s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[456.050507] Starting subtest: psr-rgb565-draw-blt
[463.249353] Subtest psr-rgb565-draw-blt: SUCCESS (7.198s)
[463.360778] [097/133] (565s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[463.453217] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[470.301295] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.839s)
[470.400831] [098/133] (558s left) gen3_render_mixed_blits
[470.506978] [099/133] (558s left) kms_vblank (wait-forked-hang)
[470.603599] Starting subtest: wait-forked-hang
[470.604817] Starting dynamic subtest: pipe-A-eDP-1
[496.652285] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.046s)
[496.668555] Starting dynamic subtest: pipe-D-eDP-1
[521.600499] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.939s)
[521.601866] Subtest wait-forked-hang: SUCCESS (50.993s)
[522.483365] [100/133] (506s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[522.570982] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[522.572235] Starting dynamic subtest: pipe-A
[522.589447] Dynamic subtest pipe-A: SKIP (0.017s)
[522.598781] Starting dynamic subtest: pipe-B
[522.620996] Dynamic subtest pipe-B: SKIP (0.030s)
[522.630701] Starting dynamic subtest: pipe-C
[522.651843] Dynamic subtest pipe-C: SKIP (0.031s)
[522.660834] Starting dynamic subtest: pipe-D
[522.684060] Dynamic subtest pipe-D: SKIP (0.031s)
[522.685995] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.112s)
[522.776780] [101/133] (506s left) perf_pmu (all-busy-check-all)
[522.828179] Starting subtest: all-busy-check-all
[524.862574] Subtest all-busy-check-all: SUCCESS (2.025s)
[524.957410] [102/133] (504s left) syncobj_timeline (host-signal-points)
[525.016560] Starting subtest: host-signal-points
[525.021091] Subtest host-signal-points: SUCCESS (0.005s)
[525.110815] [103/133] (503s left) kms_fbcon_fbt (fbc-suspend)
[525.154928] Starting subtest: fbc-suspend
[574.939579] Subtest fbc-suspend: SUCCESS (19.807s)
[576.280122] [104/133] (452s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[576.380630] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[583.520546] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.126s)
[583.666441] [105/133] (445s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[583.755754] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[583.758617] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[583.844733] [106/133] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[583.942137] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[583.943825] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[584.055048] [107/133] (445s left) kms_flip (flip-vs-fences-interruptible)
[584.141260] Starting subtest: flip-vs-fences-interruptible
[584.143010] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[584.237110] [108/133] (444s left) kms_plane (plane-position-hole)
[584.336857] Starting subtest: plane-position-hole
[584.861867] Starting dynamic subtest: pipe-A-plane-1
[586.129148] Dynamic subtest pipe-A-plane-1: SUCCESS (1.266s)
[586.138730] Starting dynamic subtest: pipe-A-plane-2
[587.409718] Dynamic subtest pipe-A-plane-2: SUCCESS (1.277s)
[587.418951] Starting dynamic subtest: pipe-A-plane-3
[588.796532] Dynamic subtest pipe-A-plane-3: SUCCESS (1.386s)
[588.807865] Starting dynamic subtest: pipe-A-plane-4
[590.030623] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[590.040061] Starting dynamic subtest: pipe-A-plane-5
[590.058034] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[591.208931] Starting dynamic subtest: pipe-B-plane-1
[592.540216] Dynamic subtest pipe-B-plane-1: SUCCESS (1.339s)
[592.549451] Starting dynamic subtest: pipe-B-plane-2
[593.844504] Dynamic subtest pipe-B-plane-2: SUCCESS (1.301s)
[593.853815] Starting dynamic subtest: pipe-B-plane-3
[595.188131] Dynamic subtest pipe-B-plane-3: SUCCESS (1.342s)
[595.197133] Starting dynamic subtest: pipe-B-plane-4
[596.479570] Dynamic subtest pipe-B-plane-4: SUCCESS (1.289s)
[596.488995] Starting dynamic subtest: pipe-B-plane-5
[596.504683] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[596.505565] Subtest plane-position-hole: SUCCESS (12.156s)
[597.277601] [109/133] (431s left) i915_pm_rpm (gem-evict-pwrite)
[598.921984] Starting subtest: gem-evict-pwrite
[598.924591] Subtest gem-evict-pwrite: SKIP (0.000s)
[599.521160] [110/133] (429s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[599.566344] Starting subtest: etime-multi-wait-all-available-unsubmitted
[599.668872] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[599.754449] [111/133] (429s left) gem_exec_schedule (u-semaphore-resolve)
[599.814713] Starting subtest: u-semaphore-resolve
[599.851109] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[600.203187] [112/133] (429s left) syncobj_timeline (signal-array)
[600.254716] Starting subtest: signal-array
[600.255683] Subtest signal-array: SUCCESS (0.000s)
[600.358459] [113/133] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[600.447420] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[600.449164] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[600.548844] [114/133] (428s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[600.643063] Starting subtest: yf-tiled-16bpp-rotate-0
[600.645033] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[600.736525] [115/133] (428s left) i915_selftest (perf)
[604.047658] Starting subtest: perf
[604.049205] Starting dynamic subtest: engine_cs
[606.804376] Dynamic subtest engine_cs: SUCCESS (2.756s)
[606.813020] Starting dynamic subtest: request
[612.151532] Dynamic subtest request: SUCCESS (5.347s)
[612.161183] Starting dynamic subtest: migrate
[616.493546] Dynamic subtest migrate: SUCCESS (4.342s)
[616.501548] Starting dynamic subtest: region
[622.455255] Dynamic subtest region: SUCCESS (5.960s)
[622.456340] Subtest perf: SUCCESS (18.413s)
[622.477806] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[622.478582] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[622.480606] [116/133] (406s left) kms_panel_fitting (legacy)
[624.066147] Starting subtest: legacy
[624.067015] Starting dynamic subtest: pipe-A-eDP-1
[624.628639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[624.656271] Starting dynamic subtest: pipe-B-eDP-1
[626.173292] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s)
[626.201412] Starting dynamic subtest: pipe-C-eDP-1
[627.762372] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.568s)
[627.788526] Starting dynamic subtest: pipe-D-eDP-1
[629.310904] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.529s)
[629.311951] Subtest legacy: SUCCESS (5.245s)
[630.492964] [FACT kms_panel_fitting (legacy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[630.494255] [FACT kms_panel_fitting (legacy)] new: kernel.kmod_is_loaded.i915: true
[630.496570] [117/133] (399s left) gem_ctx_persistence (legacy-engines-mixed)
[630.555670] Starting subtest: legacy-engines-mixed
[630.556851] Starting dynamic subtest: render
[630.625965] Dynamic subtest render: SUCCESS (0.069s)
[630.638522] Starting dynamic subtest: bsd1
[630.672583] Dynamic subtest bsd1: SUCCESS (0.045s)
[630.682018] Starting dynamic subtest: bsd2
[630.719329] Dynamic subtest bsd2: SUCCESS (0.046s)
[630.730415] Starting dynamic subtest: blt
[630.761510] Dynamic subtest blt: SUCCESS (0.040s)
[630.771059] Starting dynamic subtest: vebox
[630.803537] Dynamic subtest vebox: SUCCESS (0.041s)
[630.804659] Subtest legacy-engines-mixed: SUCCESS (0.248s)
[630.876100] [118/133] (398s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[630.966719] Starting subtest: 4-tiled-8bpp-rotate-270
[630.992142] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.025s)
[631.090713] [119/133] (398s left) kms_busy (extended-modeset-hang-newfb)
[631.183419] Starting subtest: extended-modeset-hang-newfb
[631.184324] Starting dynamic subtest: pipe-A
[665.741364] Dynamic subtest pipe-A: SUCCESS (34.548s)
[665.750723] Starting dynamic subtest: pipe-D
[688.697049] Dynamic subtest pipe-D: SUCCESS (22.955s)
[688.697898] Subtest extended-modeset-hang-newfb: SUCCESS (57.508s)
[689.489672] [120/133] (340s left) kms_mmap_write_crc (main)
[689.581701] Starting subtest: main
[689.582588] Starting dynamic subtest: pipe-A-eDP-1
[693.172272] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.589s)
[693.173019] Subtest main: SUCCESS (3.591s)
[694.029178] [121/133] (335s left) syncobj_wait (multi-wait-submitted-signaled)
[694.087630] Starting subtest: multi-wait-submitted-signaled
[694.088561] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[694.180980] [122/133] (335s left) i915_hangman (engine-engine-error)
[694.234236] Starting subtest: engine-engine-error
[694.235093] Starting dynamic subtest: rcs0
[695.767991] Dynamic subtest rcs0: SUCCESS (1.524s)
[695.779725] Starting dynamic subtest: bcs0
[697.817326] Dynamic subtest bcs0: SUCCESS (2.046s)
[697.828768] Starting dynamic subtest: vcs0
[699.735926] Dynamic subtest vcs0: SUCCESS (1.916s)
[699.747135] Starting dynamic subtest: vcs1
[701.783737] Dynamic subtest vcs1: SUCCESS (2.044s)
[701.794856] Starting dynamic subtest: vecs0
[703.769589] Dynamic subtest vecs0: SUCCESS (1.983s)
[703.780277] Starting dynamic subtest: ccs0
[705.751959] Dynamic subtest ccs0: SUCCESS (1.979s)
[705.753259] Subtest engine-engine-error: SUCCESS (11.510s)
[705.870943] [123/133] (323s left) gem_readwrite (read-bad-handle)
[705.922623] Subtest read-bad-handle: SKIP (0.000s)
[705.986201] [124/133] (323s left) gem_mmap_gtt (fault-concurrent-x)
[706.049771] Subtest fault-concurrent-X: SKIP (0.000s)
[706.119961] [125/133] (323s left) kms_prime (basic-modeset-hybrid)
[706.209833] Subtest basic-modeset-hybrid: SKIP (0.000s)
[706.314915] [126/133] (323s left) gem_lmem_swapping (massive-random)
[706.354363] Subtest massive-random: SKIP (0.000s)
[706.397827] [127/133] (323s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[706.787476] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[707.555648] [128/133] (322s left) kms_pm_backlight (fade-with-suspend)
[707.651322] Starting subtest: fade-with-suspend
[723.856236] Starting dynamic subtest: eDP-1
[726.872205] Dynamic subtest eDP-1: SUCCESS (3.017s)
[726.873315] Subtest fade-with-suspend: SUCCESS (4.613s)
[729.683741] [129/133] (302s left) kms_async_flips (async-flip-suspend-resume)
[729.778379] Starting subtest: async-flip-suspend-resume
[730.145006] Starting dynamic subtest: pipe-A-eDP-1
[748.865733] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[749.253391] Starting dynamic subtest: pipe-B-eDP-1
[767.862536] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[768.242823] Starting dynamic subtest: pipe-C-eDP-1
[786.884001] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.288s)
[787.267452] Starting dynamic subtest: pipe-D-eDP-1
[805.880570] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.290s)
[805.881633] Subtest async-flip-suspend-resume: SUCCESS (14.671s)
[813.117998] [130/133] (224s left) kms_sequence (get-idle)
[813.211712] Starting subtest: get-idle
[813.212764] Starting dynamic subtest: pipe-A-eDP-1
[815.038727] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[815.047041] Starting dynamic subtest: pipe-B-eDP-1
[817.588495] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.541s)
[817.597223] Starting dynamic subtest: pipe-C-eDP-1
[820.079942] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.485s)
[820.088777] Starting dynamic subtest: pipe-D-eDP-1
[822.528860] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.443s)
[822.529659] Subtest get-idle: SUCCESS (9.294s)
[823.348205] [131/133] (214s left) kms_psr (psr2-cursor-plane-move)
[823.444223] Starting subtest: psr2-cursor-plane-move
[823.445032] Starting dynamic subtest: eDP-1
[825.127179] Dynamic subtest eDP-1: SUCCESS (1.680s)
[825.128091] Subtest psr2-cursor-plane-move: SUCCESS (1.681s)
[825.916919] [132/133] (212s left) kms_dsc (dsc-with-output-formats-with-bpc)
[826.002037] Starting subtest: dsc-with-output-formats-with-bpc
[826.022243] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[826.075308] [133/133] (212s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[826.138602] Starting subtest: y-tiled-to-vebox-yf-tiled
[826.140435] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[826.328474] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_plane_multiple
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_atomic
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_pwrite
results: parsing output: 17/ for test: gem_exec_flush
results: parsing output: 18/ for test: kms_atomic_interruptible
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_pipe_control_store_loop
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: sysfs_timeslice_duration
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
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_balancer
results: parsing output: 32/ for test: gem_close_race
results: parsing output: 33/ for test: kms_fbcon_fbt
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gen7_exec_parse
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_display_modes
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: dumb_buffer
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_render_copy_redux
results: parsing output: 47/ for test: sriov_basic
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_async
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: gem_fenced_exec_thrash
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: gem_vm_create
results: parsing output: 61/ for test: gem_ctx_isolation
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: gem_render_copy_redux
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_content_protection
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: fbdev
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: kms_chamelium_color
results: parsing output: 76/ for test: gem_exec_parallel
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: gem_mmap
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 92/ for test: kms_joiner
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gen3_render_mixed_blits
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_fbcon_fbt
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: i915_selftest
results: parsing output: 115/ for test: kms_panel_fitting
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_mmap_write_crc
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_prime
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_pm_backlight
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: kms_sequence
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_dsc
results: parsing output: 132/ for test: gem_render_copy
Done.