[62.514335] Initializing watchdogs
[62.514403]   /dev/watchdog0
[62.530223] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[62.535903] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.538433] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.540750] [001/132] (960s left) gem_madvise (dontneed-before-pwrite)
[62.576843] Starting subtest: dontneed-before-pwrite
[62.578230] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[62.718332] [002/132] (960s left) perf_pmu (busy-start)
[62.757309] Starting subtest: busy-start
[62.758016] Starting dynamic subtest: rcs0
[65.305250] Dynamic subtest rcs0: SUCCESS (2.511s)
[65.313545] Starting dynamic subtest: bcs0
[67.823976] Dynamic subtest bcs0: SUCCESS (2.535s)
[67.832324] Starting dynamic subtest: vcs0
[70.367613] Dynamic subtest vcs0: SUCCESS (2.513s)
[70.376393] Starting dynamic subtest: vcs1
[72.886641] Dynamic subtest vcs1: SUCCESS (2.514s)
[72.895313] Starting dynamic subtest: vecs0
[75.405955] Dynamic subtest vecs0: SUCCESS (2.519s)
[75.406875] Subtest busy-start: SUCCESS (12.594s)
[75.480745] [003/132] (947s left) gem_exec_fence (syncobj-repeat)
[75.827303] Starting subtest: syncobj-repeat
[76.104313] Subtest syncobj-repeat: SUCCESS (0.268s)
[76.411264] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[76.413726] [004/132] (946s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[76.501158] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[76.553597] [005/132] (946s left) kms_pm_rpm (drm-resources-equal)
[77.972410] Starting subtest: drm-resources-equal
[80.659624] Subtest drm-resources-equal: SUCCESS (2.687s)
[80.806486] [006/132] (942s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[80.890554] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[80.891939] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[80.992653] [007/132] (942s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[81.088212] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[81.555418] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.467s)
[81.755945] [008/132] (941s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[81.847972] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[82.999132] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.150s)
[83.160352] [009/132] (940s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[83.256654] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[83.258039] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[83.364159] [010/132] (940s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[83.447491] Starting subtest: plane-downscale-factor-0-75-with-rotation
[83.448221] Starting dynamic subtest: pipe-A
[83.952286] Dynamic subtest pipe-A: SKIP (0.502s)
[83.958719] Starting dynamic subtest: pipe-B
[84.460875] Dynamic subtest pipe-B: SKIP (0.509s)
[84.467278] Starting dynamic subtest: pipe-C
[84.958739] Dynamic subtest pipe-C: SKIP (0.497s)
[84.965181] Starting dynamic subtest: pipe-D
[85.462962] Dynamic subtest pipe-D: SKIP (0.504s)
[85.464325] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (2.013s)
[85.647031] [011/132] (937s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[85.736471] Starting subtest: cursorB-vs-flipB-legacy
[85.738682] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[85.818142] [012/132] (937s left) gem_exec_nop (basic-series)
[85.861291] Starting subtest: basic-series
[89.151466] Subtest basic-series: SUCCESS (3.279s)
[89.381867] [013/132] (934s left) gem_exec_fence (basic-wait-all)
[89.423880] Starting subtest: basic-wait-all
[89.476437] Subtest basic-wait-all: SUCCESS (0.052s)
[90.090456] [014/132] (933s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[90.176632] Starting subtest: primary-yf-tiled-reflect-x-0
[90.282924] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.105s)
[90.398434] [015/132] (933s left) gem_lmem_swapping (massive)
[90.435169] Subtest massive: SKIP (0.000s)
[90.485562] [016/132] (933s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[90.519483] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[90.521009] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[90.614860] [017/132] (933s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[90.703512] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[90.704877] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[90.824105] [018/132] (932s left) kms_chamelium_hpd (dp-hpd-storm)
[90.953978] Subtest dp-hpd-storm: SKIP (0.000s)
[91.035379] [019/132] (932s left) kms_addfb_basic (size-max)
[91.120764] Starting subtest: size-max
[91.121446] Subtest size-max: SUCCESS (0.000s)
[91.260101] [020/132] (932s left) gem_exec_params (invalid-fence-in-submit)
[91.297666] Starting subtest: invalid-fence-in-submit
[91.298581] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[91.432663] [021/132] (932s left) gem_ctx_persistence (file)
[91.469633] Starting subtest: file
[91.550816] Subtest file: SUCCESS (0.081s)
[91.677903] [022/132] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[91.766968] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[91.768438] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[91.885961] [023/132] (932s left) api_intel_bb (object-noreloc-purge-cache-simple)
[91.919528] Starting subtest: object-noreloc-purge-cache-simple
[91.922288] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.003s)
[92.075897] [024/132] (931s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[92.114086] Starting subtest: basic-gtt-wc-noreloc
[92.117906] Subtest basic-gtt-wc-noreloc: SUCCESS (0.004s)
[92.264490] [025/132] (931s left) kms_rotation_crc (multiplane-rotation)
[92.347790] Starting subtest: multiplane-rotation
[144.860767] Subtest multiplane-rotation: SUCCESS (52.504s)
[145.022657] [026/132] (879s left) syncobj_basic (bad-pad-handle-to-fd)
[145.060040] Starting subtest: bad-pad-handle-to-fd
[145.060723] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[145.173147] [027/132] (878s left) sw_sync (alloc_fence_invalid_timeline)
[145.206028] Starting subtest: alloc_fence_invalid_timeline
[145.206822] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[145.305895] [028/132] (878s left) kms_psr (fbc-psr-cursor-plane-move)
[145.393522] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[145.440134] [029/132] (878s left) syncobj_wait (wait-all-interrupted)
[145.474191] Starting subtest: wait-all-interrupted
[145.587960] Subtest wait-all-interrupted: SUCCESS (0.108s)
[145.685958] [030/132] (878s left) gem_ccs (suspend-resume)
[145.722531] Starting subtest: suspend-resume
[145.724030] Subtest suspend-resume: SKIP (0.000s)
[145.817855] [031/132] (878s left) syncobj_wait (signal)
[145.851880] Starting subtest: signal
[145.852577] Subtest signal: SUCCESS (0.000s)
[145.950783] [032/132] (878s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[146.039020] Starting subtest: 2x-absolute-wf_vblank-interruptible
[146.048614] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.009s)
[146.138971] [033/132] (878s left) kms_vblank (query-busy-hang)
[146.225090] Starting subtest: query-busy-hang
[146.226896] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.904703] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.679s)
[160.916175] Starting dynamic subtest: pipe-D-HDMI-A-1
[174.721451] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.813s)
[174.722213] Subtest query-busy-hang: SUCCESS (28.498s)
[174.889214] [034/132] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[174.980937] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[174.982334] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[175.101617] [035/132] (849s left) kms_lease (lease-get)
[175.186083] Starting subtest: lease-get
[175.186787] Starting dynamic subtest: pipe-A-HDMI-A-1
[175.187462] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[175.197267] Starting dynamic subtest: pipe-B-HDMI-A-1
[175.198005] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[175.204683] Starting dynamic subtest: pipe-C-HDMI-A-1
[175.205407] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[175.212062] Starting dynamic subtest: pipe-D-HDMI-A-1
[175.212738] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[175.213376] Subtest lease-get: SUCCESS (0.010s)
[175.288480] [036/132] (849s left) kms_addfb_basic (too-wide)
[175.374195] Starting subtest: too-wide
[175.374912] Subtest too-wide: SUCCESS (0.000s)
[175.519328] [037/132] (849s left) gem_ctx_param (invalid-get-engines)
[175.553935] Starting subtest: invalid-get-engines
[175.554756] Subtest invalid-get-engines: SUCCESS (0.000s)
[175.651379] [038/132] (848s left) dumb_buffer (invalid-bpp)
[175.685353] Starting subtest: invalid-bpp
[175.686034] Subtest invalid-bpp: SUCCESS (0.000s)
[175.783228] [039/132] (848s left) kms_cdclk (mode-transition)
[175.816565] Subtest mode-transition: SKIP (0.000s)
[175.865805] [040/132] (848s left) gem_exec_params (secure-non-master)
[175.903610] Starting subtest: secure-non-master
[175.905075] Subtest secure-non-master: SKIP (0.000s)
[176.024472] [041/132] (848s left) kms_flip (2x-flip-vs-dpms-on-nop)
[176.108782] Starting subtest: 2x-flip-vs-dpms-on-nop
[176.117388] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[176.220787] [042/132] (848s left) gem_mmap_wc (bad-size)
[176.253914] Starting subtest: bad-size
[176.254598] Subtest bad-size: SUCCESS (0.001s)
[176.373197] [043/132] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[176.460552] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[176.461949] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[176.580758] [044/132] (848s left) kms_cursor_legacy (torture-bo)
[176.666164] Starting subtest: torture-bo
[176.666859] Starting dynamic subtest: pipe-A
[182.245932] Dynamic subtest pipe-A: SUCCESS (5.546s)
[182.255385] Starting dynamic subtest: pipe-B
[187.693958] Dynamic subtest pipe-B: SUCCESS (5.481s)
[187.702709] Starting dynamic subtest: pipe-C
[193.197948] Dynamic subtest pipe-C: SUCCESS (5.502s)
[193.204562] Starting dynamic subtest: pipe-D
[198.795290] Dynamic subtest pipe-D: SUCCESS (5.596s)
[198.802209] Starting dynamic subtest: all-pipes
[204.278207] Dynamic subtest all-pipes: SUCCESS (5.482s)
[204.278910] Subtest torture-bo: SUCCESS (27.612s)
[204.400849] [045/132] (820s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[204.493306] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[206.401131] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SUCCESS (1.908s)
[206.560679] [046/132] (818s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[207.964429] Starting subtest: gem-execbuf-stress-pc8
[208.023747] Subtest gem-execbuf-stress-pc8: SKIP (0.044s)
[208.214117] [047/132] (816s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[208.301173] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[208.302536] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[208.404307] [048/132] (816s left) kms_psr (fbc-pr-no-drrs)
[208.489561] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[208.539127] [049/132] (816s left) gem_mmap_gtt (basic)
[208.572898] Starting subtest: basic
[208.573591] Subtest basic: SUCCESS (0.001s)
[208.700745] [050/132] (816s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[208.795425] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[209.153476] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.358s)
[209.315486] [051/132] (815s left) gem_tiled_swapping (non-threaded)
[222.011375] Starting subtest: non-threaded
[225.866379] Subtest non-threaded: SUCCESS (3.850s)
[228.307216] [052/132] (796s left) syncobj_timeline (wait-all-interrupted)
[228.398995] Starting subtest: wait-all-interrupted
[228.502746] Subtest wait-all-interrupted: SUCCESS (0.103s)
[228.614425] [053/132] (796s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[228.717109] Starting subtest: cursor-rapid-movement-256x85
[228.722056] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.163419] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.441s)
[229.194154] Starting dynamic subtest: pipe-D-HDMI-A-1
[229.482010] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.295s)
[229.482775] Subtest cursor-rapid-movement-256x85: SUCCESS (0.766s)
[229.659359] [054/132] (795s left) gem_unref_active_buffers
[229.902806] [055/132] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[229.996884] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[229.998277] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[230.112523] [056/132] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[230.203496] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[230.204855] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.321730] [057/132] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[230.411716] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[230.413088] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[230.548752] [058/132] (794s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[230.646859] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[231.998109] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.351s)
[232.180630] [059/132] (793s left) gem_render_copy_redux (flink)
[232.219746] Starting subtest: flink
[232.986756] Subtest flink: SUCCESS (0.768s)
[233.129881] [060/132] (792s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[233.222744] Starting subtest: psr-rgb101010-draw-mmap-gtt
[233.224149] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[233.350684] [061/132] (792s left) kms_vblank (query-forked-busy-hang)
[233.437275] Starting subtest: query-forked-busy-hang
[233.439114] Starting dynamic subtest: pipe-A-HDMI-A-1
[247.432278] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.993s)
[247.444186] Starting dynamic subtest: pipe-D-HDMI-A-1
[261.766791] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.329s)
[261.768648] Subtest query-forked-busy-hang: SUCCESS (28.330s)
[261.981750] [062/132] (763s left) prime_mmap (test_invalid_sync_flags)
[262.018993] Starting subtest: test_invalid_sync_flags
[262.019715] Starting dynamic subtest: test_invalid_sync_flags-smem
[262.020384] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[262.021066] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[262.146737] [063/132] (763s left) i915_drm_fdinfo (memory-info-idle)
[262.183350] Starting subtest: memory-info-idle
[262.184183] Starting dynamic subtest: smem0
[262.216797] Dynamic subtest smem0: SUCCESS (0.033s)
[262.217479] Subtest memory-info-idle: SUCCESS (0.034s)
[262.321611] [064/132] (763s left) kms_content_protection (suspend-resume)
[262.415103] Starting subtest: suspend-resume
[262.420275] Subtest suspend-resume: SKIP (0.004s)
[262.568033] [065/132] (763s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[262.661982] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[262.663360] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[262.826968] [066/132] (762s left) gem_exec_schedule (semaphore-codependency)
[262.873787] Starting subtest: semaphore-codependency
[262.880213] Subtest semaphore-codependency: SUCCESS (0.007s)
[263.210333] [067/132] (762s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[263.300735] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[263.302086] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[263.453789] [068/132] (762s left) perf (gen12-unprivileged-single-ctx-counters)
[263.592587] Starting subtest: gen12-unprivileged-single-ctx-counters
[263.593326] Starting dynamic subtest: rcs0
[264.068604] Dynamic subtest rcs0: SUCCESS (0.476s)
[264.069313] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.477s)
[264.132646] [069/132] (761s left) kms_setmode (basic)
[264.167440] Starting subtest: basic
[264.223162] Starting dynamic subtest: pipe-A-HDMI-A-1
[266.609818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.351s)
[266.676549] Starting dynamic subtest: pipe-B-HDMI-A-1
[269.061133] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.359s)
[269.092467] Subtest basic: SUCCESS (4.924s)
[269.252691] [070/132] (756s left) prime_vgem (basic-gtt)
[269.320996] Starting subtest: basic-gtt
[269.336577] Subtest basic-gtt: SUCCESS (0.015s)
[269.462192] [071/132] (756s left) kms_cursor_crc (cursor-offscreen-128x42)
[269.555145] Starting subtest: cursor-offscreen-128x42
[269.560015] Starting dynamic subtest: pipe-A-HDMI-A-1
[272.270675] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.711s)
[272.310302] Starting dynamic subtest: pipe-D-HDMI-A-1
[274.921714] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.618s)
[274.922393] Subtest cursor-offscreen-128x42: SUCCESS (5.368s)
[275.098898] [072/132] (750s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[275.133881] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[275.243406] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[275.346194] [073/132] (750s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[275.444588] Starting subtest: 4-tiled-8bpp-rotate-90
[275.445957] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[275.575066] [074/132] (750s left) gem_mmap_wc (write-read)
[275.609453] Starting subtest: write-read
[275.610920] Subtest write-read: SUCCESS (0.002s)
[275.744911] [075/132] (750s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[275.835483] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[275.836830] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[275.973755] [076/132] (750s left) gem_ccs (block-multicopy-inplace)
[276.011328] Starting subtest: block-multicopy-inplace
[276.012790] Subtest block-multicopy-inplace: SKIP (0.000s)
[276.102104] [077/132] (750s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[276.137764] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[276.138795] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[276.255281] [078/132] (750s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[276.342175] Starting subtest: addfb25-x-tiled-mismatch-legacy
[276.342890] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[276.466289] [079/132] (749s left) gem_exec_schedule (pi-ringfull)
[276.630621] Starting subtest: pi-ringfull
[276.631713] Starting dynamic subtest: rcs0
[276.666667] Dynamic subtest rcs0: SUCCESS (0.035s)
[276.676563] Starting dynamic subtest: bcs0
[276.692647] Dynamic subtest bcs0: SUCCESS (0.025s)
[276.702373] Starting dynamic subtest: vcs0
[276.718613] Dynamic subtest vcs0: SUCCESS (0.025s)
[276.729134] Starting dynamic subtest: vcs1
[276.744131] Dynamic subtest vcs1: SUCCESS (0.024s)
[276.753785] Starting dynamic subtest: vecs0
[276.769708] Dynamic subtest vecs0: SUCCESS (0.024s)
[276.770458] Subtest pi-ringfull: SUCCESS (0.140s)
[276.979978] [080/132] (749s left) syncobj_timeline (etime-single-wait-submitted)
[277.016028] Starting subtest: etime-single-wait-submitted
[277.118676] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[277.225525] [081/132] (749s left) gem_eio (context-create)
[277.272537] Starting subtest: context-create
[277.302950] Subtest context-create: SUCCESS (0.033s)
[277.450777] [082/132] (749s left) kms_color (deep-color)
[277.538081] Starting subtest: deep-color
[277.544465] Subtest deep-color: SKIP (0.003s)
[277.660791] [083/132] (748s left) kms_psr (pr-dpms)
[277.747373] Subtest pr-dpms: SKIP (0.000s)
[277.796871] [084/132] (748s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[277.838100] Starting subtest: tiled-to-untiled
[277.951359] Subtest tiled-to-untiled: SUCCESS (0.113s)
[278.078879] [085/132] (748s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[278.168552] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[278.169984] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[278.287614] [086/132] (748s left) kms_psr (psr2-cursor-mmap-cpu)
[278.374300] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[278.421782] [087/132] (748s left) kms_atomic (crtc-invalid-params)
[278.510305] Starting subtest: crtc-invalid-params
[278.512062] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.647064] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.136s)
[278.647787] Subtest crtc-invalid-params: SUCCESS (0.138s)
[278.808069] [088/132] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[278.898861] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[278.900258] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.037030] [089/132] (747s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[279.124109] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[279.125852] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.132545] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[279.141184] Starting dynamic subtest: pipe-B-HDMI-A-1
[279.147945] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[279.156281] Starting dynamic subtest: pipe-C-HDMI-A-1
[279.162883] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[279.170817] Starting dynamic subtest: pipe-D-HDMI-A-1
[279.177573] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[279.178923] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[279.399678] [090/132] (747s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[279.487759] Starting subtest: flip-vs-dpms-off-vs-modeset
[279.489818] Starting dynamic subtest: A-HDMI-A1
[280.243620] Dynamic subtest A-HDMI-A1: SUCCESS (0.753s)
[280.254188] Starting dynamic subtest: B-HDMI-A1
[280.929074] Dynamic subtest B-HDMI-A1: SUCCESS (0.684s)
[280.938843] Starting dynamic subtest: C-HDMI-A1
[281.622714] Dynamic subtest C-HDMI-A1: SUCCESS (0.692s)
[281.632186] Starting dynamic subtest: D-HDMI-A1
[282.323238] Dynamic subtest D-HDMI-A1: SUCCESS (0.699s)
[282.325073] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.838s)
[282.492600] [091/132] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[282.588767] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[282.590146] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[282.738115] [092/132] (744s left) sysfs_heartbeat_interval (idempotent)
[282.776417] Starting subtest: idempotent
[282.778321] Starting dynamic subtest: vecs0
[282.779026] Dynamic subtest vecs0: SUCCESS (0.001s)
[282.787714] Starting dynamic subtest: vcs0
[282.788460] Dynamic subtest vcs0: SUCCESS (0.001s)
[282.796776] Starting dynamic subtest: bcs0
[282.797456] Dynamic subtest bcs0: SUCCESS (0.001s)
[282.805354] Starting dynamic subtest: rcs0
[282.806053] Dynamic subtest rcs0: SUCCESS (0.001s)
[282.813922] Starting dynamic subtest: vcs1
[282.814613] Dynamic subtest vcs1: SUCCESS (0.001s)
[282.815290] Subtest idempotent: SUCCESS (0.011s)
[282.947073] [093/132] (744s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[283.034145] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[283.034834] Starting dynamic subtest: pipe-A
[283.206742] Dynamic subtest pipe-A: SUCCESS (0.172s)
[283.223858] Starting dynamic subtest: pipe-B
[283.367187] Dynamic subtest pipe-B: SUCCESS (0.158s)
[283.384343] Starting dynamic subtest: pipe-C
[283.526031] Dynamic subtest pipe-C: SUCCESS (0.157s)
[283.543060] Starting dynamic subtest: pipe-D
[283.686029] Dynamic subtest pipe-D: SUCCESS (0.158s)
[283.687213] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.654s)
[283.894667] [094/132] (743s left) kms_atomic_transition (plane-all-transition-fencing)
[283.983188] Starting subtest: plane-all-transition-fencing
[283.984987] Starting dynamic subtest: pipe-A-HDMI-A-1
[288.322378] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.338s)
[288.395129] Starting dynamic subtest: pipe-B-HDMI-A-1
[292.814473] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.428s)
[292.857961] Subtest plane-all-transition-fencing: SUCCESS (8.875s)
[293.020819] [095/132] (734s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[293.065356] Starting subtest: y-tiled-to-vebox-x-tiled
[293.066102] Starting dynamic subtest: smem
[293.159689] Dynamic subtest smem: SUCCESS (0.095s)
[293.160455] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.096s)
[293.362604] [096/132] (733s left) drm_read (short-buffer-block)
[293.484045] Starting subtest: short-buffer-block
[293.484801] Subtest short-buffer-block: SUCCESS (0.000s)
[293.647849] [097/132] (733s left) kms_plane_multiple (2x-tiling-4)
[293.735222] Starting subtest: 2x-tiling-4
[293.736615] Subtest 2x-tiling-4: SKIP (0.000s)
[293.854716] [098/132] (733s left) i915_selftest (live)
[294.765547] Starting subtest: live
[294.766545] Starting dynamic subtest: sanitycheck
[296.028584] Dynamic subtest sanitycheck: SUCCESS (1.254s)
[296.041270] Starting dynamic subtest: uncore
[297.195478] Dynamic subtest uncore: SUCCESS (1.165s)
[297.202856] Starting dynamic subtest: workarounds
[298.720436] Dynamic subtest workarounds: SUCCESS (1.523s)
[298.728243] Starting dynamic subtest: gt_engines
[300.486427] Dynamic subtest gt_engines: SUCCESS (1.764s)
[300.494151] Starting dynamic subtest: gt_timelines
[309.131569] Dynamic subtest gt_timelines: SUCCESS (8.643s)
[309.142175] Starting dynamic subtest: gt_contexts
[310.489469] Dynamic subtest gt_contexts: SUCCESS (1.356s)
[310.497017] Starting dynamic subtest: gt_lrc
[314.654676] Dynamic subtest gt_lrc: SUCCESS (4.163s)
[314.662048] Starting dynamic subtest: gt_mocs
[316.003490] Dynamic subtest gt_mocs: SUCCESS (1.347s)
[316.014244] Starting dynamic subtest: gt_pm
[337.404643] Dynamic subtest gt_pm: SUCCESS (21.399s)
[337.417380] Starting dynamic subtest: gt_heartbeat
[338.602598] Dynamic subtest gt_heartbeat: SUCCESS (1.196s)
[338.610855] Starting dynamic subtest: gt_tlb
[342.040542] Dynamic subtest gt_tlb: SUCCESS (3.436s)
[342.048677] Starting dynamic subtest: requests
[350.627488] Dynamic subtest requests: SUCCESS (8.585s)
[350.635131] Starting dynamic subtest: migrate
[354.989570] Dynamic subtest migrate: SUCCESS (4.360s)
[355.000225] Starting dynamic subtest: active
[356.210646] Dynamic subtest active: SUCCESS (1.219s)
[356.218742] Starting dynamic subtest: objects
[357.889557] Dynamic subtest objects: SUCCESS (1.677s)
[357.900214] Starting dynamic subtest: mman
[362.734452] Dynamic subtest mman: SUCCESS (4.843s)
[362.744914] Starting dynamic subtest: dmabuf
[363.972426] Dynamic subtest dmabuf: SUCCESS (1.236s)
[363.980620] Starting dynamic subtest: vma
[365.200357] Dynamic subtest vma: SUCCESS (1.226s)
[365.211144] Starting dynamic subtest: coherency
[368.101498] Dynamic subtest coherency: SUCCESS (2.899s)
[368.109542] Starting dynamic subtest: gtt
[376.504499] Dynamic subtest gtt: SUCCESS (8.401s)
[376.514201] Starting dynamic subtest: gem
[378.670486] Dynamic subtest gem: SUCCESS (2.164s)
[378.678224] Starting dynamic subtest: evict
[380.952489] Dynamic subtest evict: SUCCESS (2.280s)
[380.960387] Starting dynamic subtest: hugepages
[388.636540] Dynamic subtest hugepages: SUCCESS (7.682s)
[388.647349] Starting dynamic subtest: gem_contexts
[404.172571] Dynamic subtest gem_contexts: SUCCESS (15.534s)
[404.184117] Starting dynamic subtest: client
[405.439603] Dynamic subtest client: SUCCESS (1.265s)
[405.447555] Starting dynamic subtest: gem_migrate
[406.637939] Dynamic subtest gem_migrate: SUCCESS (1.205s)
[406.650765] Starting dynamic subtest: reset
[411.570728] Dynamic subtest reset: SUCCESS (4.922s)
[411.581315] Starting dynamic subtest: memory_region
[412.759555] Dynamic subtest memory_region: SUCCESS (1.187s)
[412.767569] Starting dynamic subtest: hangcheck
[442.729491] Dynamic subtest hangcheck: SUCCESS (29.967s)
[442.737218] Starting dynamic subtest: execlists
[456.449478] Dynamic subtest execlists: SUCCESS (13.718s)
[456.457540] Starting dynamic subtest: ring_submission
[457.648659] Dynamic subtest ring_submission: SUCCESS (1.197s)
[457.659343] Starting dynamic subtest: perf
[458.906557] Dynamic subtest perf: SUCCESS (1.256s)
[458.917496] Starting dynamic subtest: slpc
[460.091640] Dynamic subtest slpc: SUCCESS (1.183s)
[460.106496] Starting dynamic subtest: guc
[461.261560] Dynamic subtest guc: SUCCESS (1.168s)
[461.269496] Starting dynamic subtest: guc_multi_lrc
[462.453498] Dynamic subtest guc_multi_lrc: SUCCESS (1.190s)
[462.461160] Starting dynamic subtest: guc_hang
[463.625417] Dynamic subtest guc_hang: SUCCESS (1.170s)
[463.633755] Starting dynamic subtest: late_gt_pm
[464.873376] Dynamic subtest late_gt_pm: SUCCESS (1.246s)
[464.874331] Subtest live: SUCCESS (170.097s)
[464.904428] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[464.905669] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[464.908958] [099/132] (562s left) kms_cursor_crc (cursor-sliding-max-size)
[466.089823] Starting subtest: cursor-sliding-max-size
[466.091958] Subtest cursor-sliding-max-size: SKIP (0.000s)
[466.260887] [FACT kms_cursor_crc (cursor-sliding-max-size)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[466.262228] [FACT kms_cursor_crc (cursor-sliding-max-size)] new: kernel.kmod_is_loaded.i915: true
[466.264960] [100/132] (561s left) syncobj_timeline (invalid-signal-zero-handles)
[466.300322] Starting subtest: invalid-signal-zero-handles
[466.301044] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[466.431142] [101/132] (560s left) syncobj_wait (invalid-signal-one-illegal-handle)
[466.465118] Starting subtest: invalid-signal-one-illegal-handle
[466.465844] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[466.602237] [102/132] (560s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[466.689113] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[466.689790] Starting dynamic subtest: pipe-A-HDMI-A-1
[466.692363] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[466.700037] Starting dynamic subtest: pipe-B-HDMI-A-1
[466.702702] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[466.710256] Starting dynamic subtest: pipe-C-HDMI-A-1
[466.712885] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[466.720423] Starting dynamic subtest: pipe-D-HDMI-A-1
[466.723058] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[466.724344] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[466.921655] [103/132] (560s left) kms_invalid_mode (bad-vsync-start)
[467.008666] Starting subtest: bad-vsync-start
[467.009349] Starting dynamic subtest: pipe-A-HDMI-A-1
[467.053916] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.042s)
[467.064295] Starting dynamic subtest: pipe-B-HDMI-A-1
[467.065218] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[467.074273] Starting dynamic subtest: pipe-C-HDMI-A-1
[467.075468] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[467.083396] Starting dynamic subtest: pipe-D-HDMI-A-1
[467.084705] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[467.086123] Subtest bad-vsync-start: SUCCESS (0.055s)
[467.205498] [104/132] (560s left) kms_atomic_interruptible (legacy-dpms)
[467.295841] Starting subtest: legacy-dpms
[467.296566] Starting dynamic subtest: pipe-A-HDMI-A-1
[473.504759] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.207s)
[473.505455] Subtest legacy-dpms: SUCCESS (6.209s)
[473.663097] [105/132] (553s left) gem_spin_batch (resubmit)
[473.710483] Starting subtest: resubmit
[473.711242] Starting dynamic subtest: rcs0
[473.717167] Dynamic subtest rcs0: SUCCESS (0.006s)
[473.727569] Starting dynamic subtest: bcs0
[473.728306] Dynamic subtest bcs0: SUCCESS (0.002s)
[473.736633] Starting dynamic subtest: vcs0
[473.737324] Dynamic subtest vcs0: SUCCESS (0.002s)
[473.744721] Starting dynamic subtest: vcs1
[473.745391] Dynamic subtest vcs1: SUCCESS (0.002s)
[473.752412] Starting dynamic subtest: vecs0
[473.753102] Dynamic subtest vecs0: SUCCESS (0.002s)
[473.753780] Subtest resubmit: SUCCESS (0.021s)
[473.948251] [106/132] (553s left) gem_mmap_offset (blt-coherency)
[473.983010] Starting subtest: blt-coherency
[473.989626] Subtest blt-coherency: SUCCESS (0.007s)
[474.137921] [107/132] (553s left) gem_exec_whisper (basic-contexts)
[474.181174] Starting subtest: basic-contexts
[476.600296] Subtest basic-contexts: SUCCESS (2.418s)
[476.817686] [108/132] (550s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[476.851913] Starting subtest: cpuset-medium-copy-odd
[483.998343] Subtest cpuset-medium-copy-odd: SUCCESS (7.146s)
[484.098714] [109/132] (543s left) gem_exec_balancer (busy)
[484.188264] Starting subtest: busy
[484.890310] Subtest busy: SUCCESS (0.702s)
[485.120939] [110/132] (542s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[485.223441] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[485.276421] [111/132] (542s left) gen7_exec_parse (basic-rejected)
[485.315227] Subtest basic-rejected: SKIP (0.000s)
[485.377410] [112/132] (542s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[485.466226] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[485.466933] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.473709] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[485.482180] Starting dynamic subtest: pipe-B-HDMI-A-1
[485.488899] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[485.497227] Starting dynamic subtest: pipe-C-HDMI-A-1
[485.503907] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[485.512053] Starting dynamic subtest: pipe-D-HDMI-A-1
[485.518786] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[485.520105] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.007s)
[485.702094] [113/132] (542s left) i915_module_load (resize-bar)
[485.735813] Starting subtest: resize-bar
[485.748071] Subtest resize-bar: SKIP (0.013s)
[485.806213] [114/132] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[485.899740] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[485.901217] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[486.022246] [115/132] (541s left) gem_partial_pwrite_pread (write-display)
[486.060490] Starting subtest: write-display
[496.587171] Subtest write-display: SUCCESS (10.526s)
[496.729880] [116/132] (531s left) gem_flink_basic (bad-flink)
[496.766746] Starting subtest: bad-flink
[496.767506] Subtest bad-flink: SUCCESS (0.000s)
[496.861958] [117/132] (531s left) api_intel_allocator (alloc-simple)
[496.895914] Starting subtest: alloc-simple
[496.897839] Subtest alloc-simple: SUCCESS (0.001s)
[497.029213] [118/132] (531s left) perf_pmu (semaphore-busy)
[497.066367] Starting subtest: semaphore-busy
[497.067142] Starting dynamic subtest: rcs0
[498.634694] Dynamic subtest rcs0: SUCCESS (1.558s)
[498.645556] Starting dynamic subtest: bcs0
[500.185812] Dynamic subtest bcs0: SUCCESS (1.549s)
[500.202663] Starting dynamic subtest: vcs0
[501.740124] Dynamic subtest vcs0: SUCCESS (1.552s)
[501.751332] Starting dynamic subtest: vcs1
[503.288703] Dynamic subtest vcs1: SUCCESS (1.546s)
[503.300179] Starting dynamic subtest: vecs0
[504.835829] Dynamic subtest vecs0: SUCCESS (1.545s)
[504.836748] Subtest semaphore-busy: SUCCESS (7.761s)
[504.941618] [119/132] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[505.033477] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[505.034908] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[505.155440] [120/132] (523s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[505.243418] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[505.287824] [121/132] (522s left) i915_query (query-topology-kernel-writes)
[505.321141] Starting subtest: query-topology-kernel-writes
[505.321913] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[505.420221] [122/132] (522s left) kms_feature_discovery (display)
[505.508361] Starting subtest: display
[505.509115] Subtest display: SUCCESS (0.000s)
[505.609214] [123/132] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[505.698994] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[505.700455] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[505.799254] [124/132] (522s left) gem_userptr_blits (probe)
[505.876865] Starting subtest: probe
[505.986635] Subtest probe: SUCCESS (0.109s)
[506.124245] [125/132] (522s left) kms_addfb_basic (addfb25-modifier-no-flag)
[506.213368] Starting subtest: addfb25-modifier-no-flag
[506.214116] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[506.331788] [126/132] (522s left) kms_big_fb (linear-8bpp-rotate-180)
[506.430115] Starting subtest: linear-8bpp-rotate-180
[508.255379] Subtest linear-8bpp-rotate-180: SUCCESS (1.825s)
[508.418756] [127/132] (520s left) kms_pipe_crc_basic (suspend-read-crc)
[508.510627] Starting subtest: suspend-read-crc
[508.512881] Starting dynamic subtest: pipe-A-HDMI-A-1
[525.956330] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.398s)
[525.966678] Starting dynamic subtest: pipe-B-HDMI-A-1
[542.909300] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.071s)
[542.919748] Starting dynamic subtest: pipe-C-HDMI-A-1
[559.906037] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.057s)
[559.917141] Starting dynamic subtest: pipe-D-HDMI-A-1
[576.904769] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.046s)
[576.905549] Subtest suspend-read-crc: SUCCESS (8.580s)
[585.108459] [128/132] (451s left) perf (i915-ref-count)
[585.206682] Starting subtest: i915-ref-count
[585.228017] Subtest i915-ref-count: SUCCESS (0.021s)
[585.283036] [129/132] (451s left) kms_flip (flip-vs-blocking-wf-vblank)
[585.370704] Starting subtest: flip-vs-blocking-wf-vblank
[585.372875] Starting dynamic subtest: A-HDMI-A1
[585.895506] Dynamic subtest A-HDMI-A1: FAIL (0.492s)
[585.904961] Starting dynamic subtest: B-HDMI-A1
[605.042615] Dynamic subtest B-HDMI-A1: SUCCESS (18.896s)
[605.053080] Starting dynamic subtest: C-HDMI-A1
[613.148700] Dynamic subtest C-HDMI-A1: SUCCESS (8.086s)
[613.158438] Starting dynamic subtest: D-HDMI-A1
[621.244058] Dynamic subtest D-HDMI-A1: SUCCESS (8.085s)
[621.244983] Subtest flip-vs-blocking-wf-vblank: FAIL (35.572s)
[621.416962] [130/132] (415s left) gem_exec_fence (basic-busy)
[621.580745] Starting subtest: basic-busy
[621.581785] Starting dynamic subtest: rcs0
[621.612098] Dynamic subtest rcs0: SUCCESS (0.030s)
[621.631799] Starting dynamic subtest: bcs0
[621.641999] Dynamic subtest bcs0: SUCCESS (0.028s)
[621.656171] Starting dynamic subtest: vcs0
[621.679473] Dynamic subtest vcs0: SUCCESS (0.035s)
[621.695889] Starting dynamic subtest: vcs1
[621.710135] Dynamic subtest vcs1: SUCCESS (0.028s)
[621.730123] Starting dynamic subtest: vecs0
[621.737929] Dynamic subtest vecs0: SUCCESS (0.026s)
[621.739132] Subtest basic-busy: SUCCESS (0.158s)
[622.231783] [131/132] (414s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[622.333736] Starting subtest: verify-pxp-execution-after-suspend-resume
[638.904114] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (16.562s)
[647.076118] [132/132] (397s left) kms_chamelium_frames (hdmi-crc-single)
[647.242689] Subtest hdmi-crc-single: SKIP (0.000s)
[647.332677] Closing watchdogs
results: parsing output: 0/ for test: gem_madvise
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_exec_nop
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_lmem_swapping
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: syncobj_basic
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: dumb_buffer
results: parsing output: 38/ for test: kms_cdclk
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_tiled_swapping
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_unref_active_buffers
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_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_render_copy_redux
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_vblank
results: parsing output: 61/ for test: prime_mmap
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_setmode
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: gem_set_tiling_vs_blt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_atomic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: sysfs_heartbeat_interval
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: drm_read
results: parsing output: 96/ for test: kms_plane_multiple
results: parsing output: 97/ for test: i915_selftest
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_invalid_mode
results: parsing output: 103/ for test: kms_atomic_interruptible
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gen7_exec_parse
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_module_load
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_partial_pwrite_pread
results: parsing output: 115/ for test: gem_flink_basic
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: i915_query
results: parsing output: 121/ for test: kms_feature_discovery
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_pipe_crc_basic
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: kms_chamelium_frames
Done.