[57.902060] Initializing watchdogs
[57.902107]   /dev/watchdog0
[57.915760] [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.920331] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.922879] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.926406] [001/133] (960s left) kms_psr (psr2-primary-mmap-gtt)
[58.043820] Starting subtest: psr2-primary-mmap-gtt
[58.046176] Starting dynamic subtest: eDP-1
[59.440976] Dynamic subtest eDP-1: SKIP (1.394s)
[59.446082] Subtest psr2-primary-mmap-gtt: SKIP (1.395s)
[59.577674] [002/133] (958s left) i915_drm_fdinfo (most-busy-idle-check-all)
[59.616412] Starting subtest: most-busy-idle-check-all
[59.619186] Starting dynamic subtest: rcs0
[59.623818] Dynamic subtest rcs0: SKIP (0.004s)
[59.631453] Starting dynamic subtest: bcs0
[59.635682] Dynamic subtest bcs0: SKIP (0.000s)
[59.642155] Starting dynamic subtest: vcs0
[59.646483] Dynamic subtest vcs0: SKIP (0.000s)
[59.653754] Starting dynamic subtest: vcs1
[59.658166] Dynamic subtest vcs1: SKIP (0.000s)
[59.664864] Starting dynamic subtest: vecs0
[59.669189] Dynamic subtest vecs0: SKIP (0.000s)
[59.675570] Starting dynamic subtest: ccs0
[59.679974] Dynamic subtest ccs0: SKIP (0.000s)
[59.684325] Subtest most-busy-idle-check-all: SKIP (0.007s)
[59.716926] [003/133] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[59.853928] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[64.080224] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.230s)
[65.277023] [004/133] (953s left) gem_exec_schedule (pi-shared-iova)
[65.457957] Starting subtest: pi-shared-iova
[65.460162] Starting dynamic subtest: rcs0
[65.529207] Dynamic subtest rcs0: SUCCESS (0.074s)
[65.536461] Starting dynamic subtest: vcs0
[65.595201] Dynamic subtest vcs0: SUCCESS (0.065s)
[65.606132] Starting dynamic subtest: vcs1
[65.655832] Dynamic subtest vcs1: SUCCESS (0.060s)
[65.666094] Starting dynamic subtest: vecs0
[65.712680] Dynamic subtest vecs0: SUCCESS (0.057s)
[65.721881] Starting dynamic subtest: ccs0
[65.772363] Dynamic subtest ccs0: SUCCESS (0.059s)
[65.774739] Subtest pi-shared-iova: SUCCESS (0.318s)
[67.281691] [005/133] (951s left) syncobj_timeline (multi-wait-all-available-signaled)
[67.525899] Starting subtest: multi-wait-all-available-signaled
[67.528335] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[67.653163] [006/133] (950s left) gem_exec_balancer (parallel)
[67.986047] Starting subtest: parallel
[68.955398] Subtest parallel: SUCCESS (0.970s)
[69.959363] [007/133] (948s left) kms_lease (master-vs-lease)
[70.059818] Starting subtest: master-vs-lease
[70.062383] Subtest master-vs-lease: SUCCESS (0.001s)
[70.155758] [008/133] (948s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[70.434492] Starting subtest: cursor-rapid-movement-max-size
[70.441068] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[70.554621] [009/133] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[70.648445] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[70.652929] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[70.736319] [010/133] (948s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[70.832579] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[70.834943] Starting dynamic subtest: pipe-A-eDP-1
[70.916325] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[70.925095] Starting dynamic subtest: pipe-B-eDP-1
[72.050744] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[72.055631] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.222s)
[73.230502] [011/133] (945s left) device_reset (unbind-cold-reset-rebind)
[73.282955] Starting subtest: unbind-cold-reset-rebind
[73.287634] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[73.349900] [012/133] (945s left) kms_content_protection (suspend-resume)
[73.493847] Starting subtest: suspend-resume
[73.498291] Subtest suspend-resume: SKIP (0.000s)
[73.614603] [013/133] (945s left) kms_dp_link_training (uhbr-mst)
[73.702917] Starting subtest: uhbr-mst
[73.711670] Subtest uhbr-mst: SKIP (0.000s)
[73.786110] [014/133] (945s left) api_intel_bb (intel-bb-blit-y)
[73.835813] Starting subtest: intel-bb-blit-y
[77.561496] Subtest intel-bb-blit-y: SUCCESS (3.725s)
[77.663754] [015/133] (941s left) i915_drm_fdinfo (virtual-idle)
[77.703464] Starting subtest: virtual-idle
[80.762828] Subtest virtual-idle: SUCCESS (3.057s)
[80.839488] [016/133] (938s left) i915_pm_sseu (full-enable)
[80.895063] Subtest full-enable: SKIP (0.000s)
[81.005407] [017/133] (938s left) api_intel_allocator (gem-pool)
[81.057738] Starting subtest: gem-pool
[81.071396] Subtest gem-pool: SUCCESS (0.015s)
[81.200595] [018/133] (937s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[81.305567] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[81.307771] Starting dynamic subtest: pipe-A
[81.328869] Dynamic subtest pipe-A: SKIP (0.019s)
[81.337666] Starting dynamic subtest: pipe-B
[81.362331] Dynamic subtest pipe-B: SKIP (0.036s)
[81.371581] Starting dynamic subtest: pipe-C
[81.403434] Dynamic subtest pipe-C: SKIP (0.039s)
[81.411545] Starting dynamic subtest: pipe-D
[81.437521] Dynamic subtest pipe-D: SKIP (0.037s)
[81.441283] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.132s)
[81.539177] [019/133] (937s left) gem_exec_balancer (persistence)
[81.812777] Starting subtest: persistence
[82.728858] Subtest persistence: SUCCESS (0.916s)
[82.859863] [020/133] (936s left) gem_exec_schedule (u-submit-early-slice)
[82.943042] Starting subtest: u-submit-early-slice
[82.945143] Starting dynamic subtest: rcs0
[82.981712] Dynamic subtest rcs0: SUCCESS (0.046s)
[82.992064] Starting dynamic subtest: bcs0
[83.018515] Dynamic subtest bcs0: SUCCESS (0.037s)
[83.026490] Starting dynamic subtest: vcs0
[83.058091] Dynamic subtest vcs0: SUCCESS (0.039s)
[83.067605] Starting dynamic subtest: vcs1
[83.099349] Dynamic subtest vcs1: SUCCESS (0.041s)
[83.108750] Starting dynamic subtest: vecs0
[83.140697] Dynamic subtest vecs0: SUCCESS (0.041s)
[83.154399] Starting dynamic subtest: ccs0
[83.180913] Dynamic subtest ccs0: SUCCESS (0.040s)
[83.183244] Subtest u-submit-early-slice: SUCCESS (0.247s)
[84.977319] [021/133] (934s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[85.045072] Starting subtest: single-wait-all-for-submit-unsubmitted
[85.153053] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[85.229984] [022/133] (934s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[85.337250] Starting subtest: yf-tiled-32bpp-rotate-270
[85.341570] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[85.427543] [023/133] (933s left) kms_psr (fbc-psr2-cursor-render)
[85.516195] Starting subtest: fbc-psr2-cursor-render
[85.518429] Starting dynamic subtest: eDP-1
[85.522446] Dynamic subtest eDP-1: SKIP (0.000s)
[85.526510] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[85.585527] [024/133] (933s left) perf (whitelisted-registers-userspace-config)
[85.700852] Starting subtest: whitelisted-registers-userspace-config
[85.703113] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[85.742388] [025/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[85.834381] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[85.838539] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[85.946159] [026/133] (933s left) fbdev (eof)
[85.991992] Starting subtest: eof
[85.994380] Subtest eof: SUCCESS (0.000s)
[86.057366] [027/133] (933s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[86.145823] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[86.148211] Starting dynamic subtest: pipe-A
[87.362102] Dynamic subtest pipe-A: SUCCESS (1.218s)
[87.369384] Starting dynamic subtest: pipe-B
[89.538300] Dynamic subtest pipe-B: SUCCESS (2.176s)
[89.547766] Starting dynamic subtest: pipe-C
[90.751074] Dynamic subtest pipe-C: SUCCESS (1.212s)
[90.762454] Starting dynamic subtest: pipe-D
[91.984623] Dynamic subtest pipe-D: SUCCESS (1.233s)
[91.987063] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.841s)
[93.186908] [028/133] (926s left) syncobj_basic (bad-create-flags)
[93.247968] Starting subtest: bad-create-flags
[93.249970] Subtest bad-create-flags: SUCCESS (0.000s)
[93.353226] [029/133] (926s left) sw_sync (sync_busy)
[93.386020] Starting subtest: sync_busy
[93.388315] Subtest sync_busy: SUCCESS (0.002s)
[93.440102] [030/133] (926s left) gem_wait (busy)
[93.502275] Starting subtest: busy
[93.504283] Starting dynamic subtest: all-engines
[94.932413] Dynamic subtest all-engines: SUCCESS (1.431s)
[94.943139] Starting dynamic subtest: rcs0
[95.472064] Dynamic subtest rcs0: SUCCESS (0.540s)
[95.482068] Starting dynamic subtest: bcs0
[96.011545] Dynamic subtest bcs0: SUCCESS (0.539s)
[96.021787] Starting dynamic subtest: vcs0
[97.939709] Dynamic subtest vcs0: SUCCESS (1.927s)
[97.950445] Starting dynamic subtest: vcs1
[99.924380] Dynamic subtest vcs1: SUCCESS (1.983s)
[99.934944] Starting dynamic subtest: vecs0
[101.908309] Dynamic subtest vecs0: SUCCESS (1.983s)
[101.918905] Starting dynamic subtest: ccs0
[102.450577] Dynamic subtest ccs0: SUCCESS (0.543s)
[102.452984] Subtest busy: SUCCESS (8.950s)
[102.648614] [031/133] (916s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[102.758861] Starting subtest: pipe-fbc-rte
[102.766041] Starting dynamic subtest: pipe-B-eDP-1
[108.256047] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.501s)
[108.263955] Subtest pipe-fbc-rte: SUCCESS (5.503s)
[110.527698] [032/133] (909s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[110.625283] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[110.629168] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[110.716222] [033/133] (908s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[110.846316] Starting subtest: short-flip-after-cursor-atomic-transitions
[111.851608] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.005s)
[112.664127] [034/133] (907s left) kms_psr (pr-cursor-blt)
[112.756162] Starting subtest: pr-cursor-blt
[112.760641] Subtest pr-cursor-blt: SKIP (0.000s)
[112.838819] [035/133] (906s left) kms_color (ctm-red-to-blue)
[112.926058] Starting subtest: ctm-red-to-blue
[112.928072] Starting dynamic subtest: pipe-A-eDP-1
[113.635915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[113.647191] Starting dynamic subtest: pipe-B-eDP-1
[115.086375] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.449s)
[115.094693] Starting dynamic subtest: pipe-C-eDP-1
[116.487973] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[116.503376] Starting dynamic subtest: pipe-D-eDP-1
[117.816205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[117.818407] Subtest ctm-red-to-blue: SUCCESS (4.890s)
[118.617947] [036/133] (901s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[118.678223] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[118.785448] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[118.875456] [037/133] (901s left) gem_exec_reloc (basic-wc-gtt-active)
[118.936873] Subtest basic-wc-gtt-active: SKIP (0.000s)
[119.011071] [038/133] (900s left) gem_ctx_exec (basic-norecovery)
[119.062169] Starting subtest: basic-norecovery
[119.356065] Subtest basic-norecovery: SUCCESS (0.293s)
[119.470402] [039/133] (900s left) gem_userptr_blits (process-exit)
[119.552286] Starting subtest: process-exit
[119.557447] Subtest process-exit: SUCCESS (0.009s)
[119.667659] [040/133] (900s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[120.228112] Starting subtest: syncobj-backward-timeline-chain-engines
[120.355335] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.130s)
[122.050249] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[122.053192] [041/133] (897s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[122.158568] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[122.162781] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[122.240329] [042/133] (897s left) kms_joiner (basic-max-non-joiner)
[122.340645] Starting subtest: basic-max-non-joiner
[122.345264] Subtest basic-max-non-joiner: SKIP (0.000s)
[122.407796] [043/133] (897s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[122.458761] Starting subtest: wait-all-for-submit-delayed-submit
[122.562726] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[122.667747] [044/133] (897s left) gem_mmap_gtt (hang-user)
[122.736589] Subtest hang-user: SKIP (0.000s)
[122.803875] [045/133] (897s left) sw_sync (alloc_timeline)
[122.839625] Starting subtest: alloc_timeline
[122.841455] Subtest alloc_timeline: SUCCESS (0.000s)
[122.895910] [046/133] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[122.991045] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[127.516732] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.529s)
[128.733283] [047/133] (891s left) kms_pm_dc (dc3co-vpb-simulation)
[129.847123] Starting subtest: dc3co-vpb-simulation
[138.626834] Subtest dc3co-vpb-simulation: SKIP (8.776s)
[138.781525] [048/133] (881s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[138.842250] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[138.846745] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[139.024081] [049/133] (881s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[139.112062] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[139.114300] Starting dynamic subtest: pipe-A-eDP-1
[139.136653] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[139.148314] Starting dynamic subtest: pipe-B-eDP-1
[139.169134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[139.176630] Starting dynamic subtest: pipe-C-eDP-1
[139.197169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[139.204455] Starting dynamic subtest: pipe-D-eDP-1
[139.224760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[139.228845] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[141.379023] [050/133] (879s left) gem_exec_flush (basic-uc-pro-default)
[141.450400] Starting subtest: basic-uc-pro-default
[146.909073] Subtest basic-uc-pro-default: SUCCESS (5.460s)
[147.118385] [051/133] (873s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[147.163888] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[147.221222] [052/133] (873s left) kms_addfb_basic (bad-pitch-1024)
[147.275582] Starting subtest: bad-pitch-1024
[147.277639] Subtest bad-pitch-1024: SUCCESS (0.000s)
[147.419754] [053/133] (873s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[147.513174] Starting subtest: primary-yf-tiled-reflect-x-90
[147.517461] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[147.586293] [054/133] (873s left) kms_universal_plane (universal-plane-sanity)
[147.680196] Starting subtest: universal-plane-sanity
[147.682594] Starting dynamic subtest: pipe-A-eDP-1
[148.281789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[148.291097] Starting dynamic subtest: pipe-B-eDP-1
[149.507220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[149.516264] Starting dynamic subtest: pipe-C-eDP-1
[150.725269] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[150.734381] Starting dynamic subtest: pipe-D-eDP-1
[151.964724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[151.966595] Subtest universal-plane-sanity: SUCCESS (4.285s)
[152.812209] [055/133] (867s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[152.925736] Starting subtest: cursor-vs-flip-toggle
[183.958994] Subtest cursor-vs-flip-toggle: SUCCESS (31.031s)
[184.847784] [056/133] (835s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[185.226330] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[186.052640] [057/133] (834s left) gem_exec_async (forked-writes)
[186.109656] Starting subtest: forked-writes
[186.111903] Starting dynamic subtest: rcs0
[186.136464] Dynamic subtest rcs0: SUCCESS (0.027s)
[186.144685] Starting dynamic subtest: bcs0
[186.159085] Dynamic subtest bcs0: SUCCESS (0.022s)
[186.168124] Starting dynamic subtest: vcs0
[186.181343] Dynamic subtest vcs0: SUCCESS (0.021s)
[186.190981] Starting dynamic subtest: vcs1
[186.205919] Dynamic subtest vcs1: SUCCESS (0.024s)
[186.214519] Starting dynamic subtest: vecs0
[186.228505] Dynamic subtest vecs0: SUCCESS (0.022s)
[186.238080] Starting dynamic subtest: ccs0
[186.266280] Dynamic subtest ccs0: SUCCESS (0.037s)
[186.268598] Subtest forked-writes: SUCCESS (0.157s)
[186.497139] [058/133] (834s left) kms_chamelium_audio (hdmi-audio)
[186.871873] Subtest hdmi-audio: SKIP (0.000s)
[187.680511] [059/133] (833s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[187.781336] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[187.785607] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[187.877491] [060/133] (833s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[187.965812] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[187.968054] Starting dynamic subtest: pipe-A-eDP-1
[187.988598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[188.000676] Starting dynamic subtest: pipe-B-eDP-1
[188.018875] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[188.026646] Starting dynamic subtest: pipe-C-eDP-1
[188.045169] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[188.054728] Starting dynamic subtest: pipe-D-eDP-1
[188.073407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[188.075260] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[190.276771] [061/133] (830s left) vgem_basic (create)
[190.327980] Starting subtest: create
[190.330310] Subtest create: SUCCESS (0.000s)
[190.396954] [062/133] (830s left) gem_create (create-valid-nonaligned)
[190.449985] Starting subtest: create-valid-nonaligned
[190.452234] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[190.631981] [063/133] (830s left) kms_cursor_edge_walk (128x128-right-edge)
[190.720103] Starting subtest: 128x128-right-edge
[190.722434] Starting dynamic subtest: pipe-A-eDP-1
[194.133586] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[194.142691] Starting dynamic subtest: pipe-D-eDP-1
[197.263717] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[197.265996] Subtest 128x128-right-edge: SUCCESS (6.545s)
[198.059579] [064/133] (822s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[198.133278] Starting subtest: etime-single-wait-for-submit-unsubmitted
[198.241085] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[198.316450] [065/133] (822s left) kms_vrr (max-min)
[198.419310] Starting subtest: max-min
[198.425755] Subtest max-min: SKIP (0.000s)
[198.510179] [066/133] (822s left) gem_exec_params (no-blt)
[198.583378] Starting subtest: no-blt
[198.585717] Subtest no-blt: SUCCESS (0.002s)
[198.709580] [067/133] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[198.809472] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[198.813679] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[198.907181] [068/133] (822s left) kms_prime (basic-crc-vgem)
[198.996514] Starting subtest: basic-crc-vgem
[198.998852] Starting dynamic subtest: second-to-first
[199.985041] Dynamic subtest second-to-first: SUCCESS (0.993s)
[199.987479] Subtest basic-crc-vgem: SUCCESS (0.993s)
[200.091237] [069/133] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[200.219594] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[200.223141] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[200.316115] [070/133] (820s left) perf_pmu (busy-no-semaphores)
[200.363984] Starting subtest: busy-no-semaphores
[200.365953] Starting dynamic subtest: rcs0
[200.916861] Dynamic subtest rcs0: SUCCESS (0.551s)
[200.926907] Starting dynamic subtest: bcs0
[201.465459] Dynamic subtest bcs0: SUCCESS (0.546s)
[201.477089] Starting dynamic subtest: vcs0
[202.017855] Dynamic subtest vcs0: SUCCESS (0.550s)
[202.032253] Starting dynamic subtest: vcs1
[203.417220] Dynamic subtest vcs1: SUCCESS (1.397s)
[203.428502] Starting dynamic subtest: vecs0
[205.400298] Dynamic subtest vecs0: SUCCESS (1.980s)
[205.412417] Starting dynamic subtest: ccs0
[207.388900] Dynamic subtest ccs0: SUCCESS (1.986s)
[207.391545] Subtest busy-no-semaphores: SUCCESS (7.024s)
[207.504740] [071/133] (813s left) gem_partial_pwrite_pread (reads-snoop)
[207.559888] Subtest reads-snoop: SKIP (0.000s)
[207.637804] [072/133] (813s left) gem_flink_basic (basic)
[207.709278] Starting subtest: basic
[207.711607] Subtest basic: SUCCESS (0.000s)
[207.805064] [073/133] (813s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[207.899233] Starting subtest: fbc-rgb101010-draw-mmap-wc
[212.438404] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.541s)
[213.567973] [074/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[213.661758] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[221.024398] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.365s)
[221.147426] [075/133] (800s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[221.248081] Starting subtest: x-tiled-8bpp-rotate-270
[221.268712] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[221.383277] [076/133] (800s left) syncobj_timeline (multi-wait-signaled)
[221.449709] Starting subtest: multi-wait-signaled
[221.452122] Subtest multi-wait-signaled: SUCCESS (0.001s)
[221.583994] [077/133] (800s left) syncobj_timeline (wait-for-submit-snapshot)
[221.640268] Starting subtest: wait-for-submit-snapshot
[221.720386] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[221.798114] [078/133] (799s left) kms_chamelium_frames (hdmi-crc-fast)
[222.186985] Subtest hdmi-crc-fast: SKIP (0.000s)
[222.984347] [079/133] (798s left) gem_eio (in-flight-immediate)
[223.199039] Starting subtest: in-flight-immediate
[231.560489] Subtest in-flight-immediate: SUCCESS (8.360s)
[231.678950] [080/133] (790s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[231.766247] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[231.768534] Starting dynamic subtest: A-eDP1
[235.345377] Dynamic subtest A-eDP1: SUCCESS (3.574s)
[235.355561] Starting dynamic subtest: B-eDP1
[238.531298] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[238.540367] Starting dynamic subtest: C-eDP1
[241.660622] Dynamic subtest C-eDP1: SUCCESS (3.127s)
[241.670509] Starting dynamic subtest: D-eDP1
[244.761620] Dynamic subtest D-eDP1: SUCCESS (3.099s)
[244.763789] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.996s)
[245.561307] [081/133] (776s left) kms_addfb_basic (basic-y-tiled-legacy)
[245.624699] Starting subtest: basic-y-tiled-legacy
[245.629058] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[245.759176] [082/133] (776s left) i915_query (query-topology-known-pci-ids)
[245.812590] Starting subtest: query-topology-known-pci-ids
[245.817042] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[245.906779] [083/133] (775s left) gem_partial_pwrite_pread (write)
[245.967992] Subtest write: SKIP (0.000s)
[246.037834] [084/133] (775s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[246.140783] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[252.893103] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.756s)
[253.021226] [085/133] (768s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[253.120078] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[253.124094] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[253.194864] [086/133] (768s left) gem_exec_suspend (basic-s4-devices)
[253.267570] Starting subtest: basic-S4-devices
[253.269820] Starting dynamic subtest: smem
[264.918040] Dynamic subtest smem: SUCCESS (11.650s)
[264.921053] Subtest basic-S4-devices: SUCCESS (11.653s)
[270.146979] [087/133] (756s left) kms_cursor_crc (cursor-offscreen-256x256)
[270.428733] Starting subtest: cursor-offscreen-256x256
[270.433719] Starting dynamic subtest: pipe-A-eDP-1
[272.390538] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[272.429950] Starting dynamic subtest: pipe-D-eDP-1
[275.039818] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[275.042183] Subtest cursor-offscreen-256x256: SUCCESS (4.610s)
[275.882506] [088/133] (751s left) syncobj_basic (bad-destroy-pad)
[275.941055] Starting subtest: bad-destroy-pad
[275.943385] Subtest bad-destroy-pad: SUCCESS (0.000s)
[276.051258] [089/133] (751s left) syncobj_timeline (single-wait-available-submitted)
[276.106961] Starting subtest: single-wait-available-submitted
[276.109258] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[276.223403] [090/133] (750s left) kms_pipe_crc_basic (suspend-read-crc)
[276.314972] Starting subtest: suspend-read-crc
[276.317110] Starting dynamic subtest: pipe-A-eDP-1
[293.854898] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.582s)
[293.867717] Starting dynamic subtest: pipe-B-eDP-1
[311.894274] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.184s)
[311.905099] Starting dynamic subtest: pipe-C-eDP-1
[329.787222] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.053s)
[329.800999] Starting dynamic subtest: pipe-D-eDP-1
[347.810105] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[347.812410] Subtest suspend-read-crc: SUCCESS (11.940s)
[348.630124] [091/133] (678s left) kms_feature_discovery (psr1)
[348.727219] Starting subtest: psr1
[348.730126] Subtest psr1: SUCCESS (0.000s)
[348.805915] [092/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[348.919294] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[348.924251] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[349.011791] [093/133] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[349.116197] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[349.121173] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[349.236337] [094/133] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[349.337678] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[356.718988] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.384s)
[356.839814] [095/133] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[356.942415] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[356.946600] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[357.044150] [096/133] (670s left) gem_ctx_persistence (legacy-engines-queued)
[357.108245] Starting subtest: legacy-engines-queued
[357.110716] Starting dynamic subtest: render
[357.150248] Dynamic subtest render: SUCCESS (0.044s)
[357.161086] Starting dynamic subtest: bsd1
[358.417835] Dynamic subtest bsd1: SUCCESS (1.265s)
[358.431797] Starting dynamic subtest: bsd2
[360.401019] Dynamic subtest bsd2: SUCCESS (1.979s)
[360.414354] Starting dynamic subtest: blt
[360.461728] Dynamic subtest blt: SUCCESS (0.058s)
[360.473470] Starting dynamic subtest: vebox
[362.447755] Dynamic subtest vebox: SUCCESS (1.983s)
[362.450768] Subtest legacy-engines-queued: SUCCESS (5.342s)
[362.534823] [097/133] (664s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[362.636104] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[362.638541] Starting dynamic subtest: pipe-A-eDP-1
[362.665425] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[362.677643] Starting dynamic subtest: pipe-B-eDP-1
[362.707257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[362.717409] Starting dynamic subtest: pipe-C-eDP-1
[362.743333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[362.756999] Starting dynamic subtest: pipe-D-eDP-1
[362.783473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[362.788514] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[364.910152] [098/133] (662s left) gen9_exec_parse (batch-zero-length)
[364.973119] Subtest batch-zero-length: SKIP (0.000s)
[365.048946] [099/133] (662s left) kms_atomic_transition (plane-all-transition-fencing)
[365.150099] Starting subtest: plane-all-transition-fencing
[365.152373] Starting dynamic subtest: pipe-A-eDP-1
[367.644093] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[367.963095] Starting dynamic subtest: pipe-B-eDP-1
[371.174128] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.221s)
[371.470216] Subtest plane-all-transition-fencing: SUCCESS (6.321s)
[372.290586] [100/133] (655s left) kms_plane (pixel-format-yf-tiled-modifier)
[372.399342] Starting subtest: pixel-format-yf-tiled-modifier
[372.405279] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[372.505950] [101/133] (655s left) gem_mmap_gtt (basic-read)
[372.570454] Subtest basic-read: SKIP (0.000s)
[372.639978] [102/133] (655s left) kms_psr2_su (page_flip-nv12)
[372.697267] Subtest page_flip-NV12: SKIP (0.000s)
[372.760936] [103/133] (655s left) gem_spin_batch (spin-all)
[372.833355] Starting subtest: spin-all
[372.850713] Subtest spin-all: SUCCESS (0.017s)
[374.494763] [104/133] (653s left) gem_create (hog-create)
[374.559667] Starting subtest: hog-create
[374.562539] Starting dynamic subtest: smem0
[408.435430] Dynamic subtest smem0: SUCCESS (33.870s)
[408.438823] Subtest hog-create: SUCCESS (33.873s)
[408.628840] [105/133] (619s left) sriov_basic (enable-vfs-bind-unbind-each)
[408.698182] Starting subtest: enable-vfs-bind-unbind-each
[408.700960] Starting dynamic subtest: numvfs-1
[408.789356] Dynamic subtest numvfs-1: FAIL (0.014s)
[408.805554] Starting dynamic subtest: numvfs-2
[408.893152] Dynamic subtest numvfs-2: FAIL (0.004s)
[408.905234] Starting dynamic subtest: numvfs-3
[408.993858] Dynamic subtest numvfs-3: FAIL (0.007s)
[409.004049] Starting dynamic subtest: numvfs-4
[409.088388] Dynamic subtest numvfs-4: FAIL (0.003s)
[409.099431] Starting dynamic subtest: numvfs-5
[409.186922] Dynamic subtest numvfs-5: FAIL (0.004s)
[409.197655] Starting dynamic subtest: numvfs-6
[409.283358] Dynamic subtest numvfs-6: FAIL (0.004s)
[409.295315] Starting dynamic subtest: numvfs-7
[409.380784] Dynamic subtest numvfs-7: FAIL (0.003s)
[409.390653] Starting dynamic subtest: numvfs-random
[409.475422] Dynamic subtest numvfs-random: FAIL (0.004s)
[409.477852] Subtest enable-vfs-bind-unbind-each: FAIL (0.049s)
[409.519734] [106/133] (618s left) i915_pm_rps (fence-order)
[409.585938] Starting subtest: fence-order
[412.595173] Subtest fence-order: SUCCESS (3.006s)
[412.724296] [107/133] (615s left) kms_psr (psr-no-drrs)
[412.825322] Starting subtest: psr-no-drrs
[412.828182] Starting dynamic subtest: eDP-1
[414.477326] Dynamic subtest eDP-1: SUCCESS (1.649s)
[414.479894] Subtest psr-no-drrs: SUCCESS (1.650s)
[415.362074] [108/133] (612s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[415.494636] Starting subtest: cursorA-vs-flipA-atomic-transitions
[426.666462] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.171s)
[427.480353] [109/133] (600s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[427.597195] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[428.376937] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[428.553551] [110/133] (599s left) kms_flip (2x-plain-flip)
[428.644357] Starting subtest: 2x-plain-flip
[428.656306] Subtest 2x-plain-flip: SKIP (0.012s)
[428.737934] [111/133] (599s left) gem_mmap_gtt (medium-copy-xy)
[428.793033] Subtest medium-copy-XY: SKIP (0.000s)
[428.865112] [112/133] (599s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[428.961405] Starting subtest: y-tiled-64bpp-rotate-0
[428.966850] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[429.062586] [113/133] (599s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[429.161706] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[435.823983] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.664s)
[435.941005] [114/133] (592s left) gem_exec_schedule (wide)
[436.123190] Starting subtest: wide
[436.126006] Starting dynamic subtest: rcs0
[447.161690] Dynamic subtest rcs0: SUCCESS (11.040s)
[447.175016] Starting dynamic subtest: vcs0
[458.398672] Dynamic subtest vcs0: SUCCESS (11.236s)
[458.409681] Starting dynamic subtest: vcs1
[470.654118] Dynamic subtest vcs1: SUCCESS (12.254s)
[470.666217] Starting dynamic subtest: vecs0
[482.027791] Dynamic subtest vecs0: SUCCESS (11.372s)
[482.039259] Starting dynamic subtest: ccs0
[495.990680] Dynamic subtest ccs0: SUCCESS (13.961s)
[495.993788] Subtest wide: SUCCESS (59.869s)
[497.602061] [115/133] (530s left) kms_vblank (ts-continuation-modeset)
[497.731441] Starting subtest: ts-continuation-modeset
[497.733874] Starting dynamic subtest: pipe-A-eDP-1
[499.273043] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.542s)
[499.291610] Starting dynamic subtest: pipe-D-eDP-1
[501.439422] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s)
[501.442050] Subtest ts-continuation-modeset: SUCCESS (3.707s)
[502.249071] [116/133] (526s left) kms_flip_event_leak (basic)
[502.339610] Starting subtest: basic
[502.342207] Starting dynamic subtest: pipe-A-eDP-1
[502.765387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[502.776134] Starting dynamic subtest: pipe-B-eDP-1
[503.878009] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[503.888289] Starting dynamic subtest: pipe-C-eDP-1
[504.993962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[505.004992] Starting dynamic subtest: pipe-D-eDP-1
[506.138107] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[506.140677] Subtest basic: SUCCESS (3.800s)
[506.988489] [117/133] (521s left) kms_plane_lowres (tiling-y)
[507.088531] Starting subtest: tiling-y
[507.093919] Subtest tiling-y: SKIP (0.000s)
[507.177517] [118/133] (521s left) gem_exec_whisper (basic-sync)
[507.249208] Starting subtest: basic-sync
[514.564443] Subtest basic-sync: SUCCESS (7.312s)
[514.751859] [119/133] (513s left) gem_exec_parallel (engines)
[514.828708] Starting subtest: engines
[514.831057] Starting dynamic subtest: basic
[518.450754] Dynamic subtest basic: SUCCESS (3.622s)
[518.464642] Starting dynamic subtest: contexts
[522.887785] Dynamic subtest contexts: SUCCESS (4.434s)
[522.900685] Starting dynamic subtest: fds
[526.744739] Dynamic subtest fds: SUCCESS (3.854s)
[526.757714] Starting dynamic subtest: userptr
[530.419224] Dynamic subtest userptr: SUCCESS (3.671s)
[530.422479] Subtest engines: SUCCESS (15.593s)
[530.617458] [120/133] (497s left) gem_userptr_blits (create-destroy-sync)
[530.682687] Starting subtest: create-destroy-sync
[535.696149] Subtest create-destroy-sync: SUCCESS (5.013s)
[535.813355] [121/133] (492s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[535.908280] Starting subtest: psr-rgb565-draw-mmap-cpu
[542.691198] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.786s)
[542.796014] [122/133] (485s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[542.921664] Starting subtest: 2x-cursor-vs-flip-atomic
[542.926828] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[543.080349] [123/133] (485s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[543.189840] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[543.194344] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[544.342176] [124/133] (484s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[544.435271] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[544.441068] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[544.528443] [125/133] (484s left) gem_mmap_offset (ptrace)
[544.578391] Starting subtest: ptrace
[544.581187] Starting dynamic subtest: smem0-wb
[544.599173] Dynamic subtest smem0-wb: SUCCESS (0.019s)
[544.609678] Starting dynamic subtest: smem0-wc
[544.615399] Dynamic subtest smem0-wc: SUCCESS (0.016s)
[544.625242] Starting dynamic subtest: smem0-uc
[544.637963] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[544.640231] Subtest ptrace: SUCCESS (0.063s)
[544.746715] [126/133] (484s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[544.849083] Starting subtest: 4-tiled-8bpp-rotate-90
[544.875198] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.024s)
[544.981962] [127/133] (483s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[545.046267] Starting subtest: yf-tiled-ccs-to-yf-tiled
[545.051661] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[545.247528] [128/133] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[545.339303] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[545.344700] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[545.435939] [129/133] (483s left) kms_psr (fbc-psr2-sprite-render)
[545.533107] Starting subtest: fbc-psr2-sprite-render
[545.535674] Starting dynamic subtest: eDP-1
[545.540441] Dynamic subtest eDP-1: SKIP (0.000s)
[545.545283] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[545.606393] [130/133] (483s left) kms_async_flips (crc-atomic)
[545.699244] Starting subtest: crc-atomic
[546.071145] Starting dynamic subtest: pipe-A-eDP-1
[548.960560] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.890s)
[549.353268] Starting dynamic subtest: pipe-B-eDP-1
[552.293329] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.949s)
[552.670117] Starting dynamic subtest: pipe-C-eDP-1
[555.591209] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.932s)
[555.958071] Starting dynamic subtest: pipe-D-eDP-1
[558.925996] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.976s)
[558.928731] Subtest crc-atomic: SUCCESS (13.228s)
[560.145456] [131/133] (468s left) kms_addfb_basic (unused-pitches)
[560.215213] Starting subtest: unused-pitches
[560.218248] Subtest unused-pitches: SUCCESS (0.000s)
[560.344481] [132/133] (468s left) kms_flip (plain-flip-fb-recreate)
[560.432125] Starting subtest: plain-flip-fb-recreate
[560.434905] Starting dynamic subtest: A-eDP1
[569.283787] Dynamic subtest A-eDP1: SUCCESS (8.854s)
[569.295004] Starting dynamic subtest: B-eDP1
[578.116065] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[578.126422] Starting dynamic subtest: C-eDP1
[586.933895] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[586.947109] Starting dynamic subtest: D-eDP1
[595.760892] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[595.762978] Subtest plain-flip-fb-recreate: SUCCESS (35.334s)
[596.949950] [133/133] (432s left) gem_reg_read (timestamp-moving)
[597.009226] Starting subtest: timestamp-moving
[598.010358] Subtest timestamp-moving: SUCCESS (1.001s)
[598.086523] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: device_reset
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: kms_dp_link_training
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: i915_pm_sseu
results: parsing output: 16/ for test: api_intel_allocator
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: fbdev
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: syncobj_basic
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: gem_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_ctx_exec
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_joiner
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pm_dc
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_flush
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: kms_universal_plane
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: gem_exec_async
results: parsing output: 57/ for test: kms_chamelium_audio
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: gem_create
results: parsing output: 62/ for test: kms_cursor_edge_walk
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_vrr
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_prime
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: gem_partial_pwrite_pread
results: parsing output: 71/ for test: gem_flink_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: gem_eio
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: i915_query
results: parsing output: 82/ for test: gem_partial_pwrite_pread
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: gem_exec_suspend
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_pipe_crc_basic
results: parsing output: 90/ for test: kms_feature_discovery
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_psr2_su
results: parsing output: 102/ for test: gem_spin_batch
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: sriov_basic
results: parsing output: 105/ for test: i915_pm_rps
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_flip_event_leak
results: parsing output: 116/ for test: kms_plane_lowres
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: gem_exec_parallel
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: gem_reg_read
Done.