[59.244537] Initializing watchdogs
[59.244585]   /dev/watchdog0
[59.259188] [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]
[59.263686] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.265911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.269195] [001/133] (960s left) perf (gen12-oa-tlb-invalidate)
[59.429681] Starting subtest: gen12-oa-tlb-invalidate
[59.431844] Starting dynamic subtest: 0-rcs0
[69.478637] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[69.486426] Starting dynamic subtest: 1-vcs1
[79.537927] Dynamic subtest 1-vcs1: SUCCESS (10.049s)
[79.540608] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.062s)
[79.581721] [002/133] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[79.677684] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[79.682136] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[79.762035] [003/133] (940s left) kms_vblank (ts-continuation-dpms-rpm)
[79.848483] Starting subtest: ts-continuation-dpms-rpm
[79.850584] Starting dynamic subtest: pipe-A-eDP-1
[82.396227] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.546s)
[82.410433] Starting dynamic subtest: pipe-D-eDP-1
[84.644756] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s)
[84.646960] Subtest ts-continuation-dpms-rpm: SUCCESS (4.795s)
[85.526704] [004/133] (934s left) kms_cursor_legacy (forked-move)
[85.664887] Starting subtest: forked-move
[85.667083] Starting dynamic subtest: pipe-A
[91.130911] Dynamic subtest pipe-A: SUCCESS (5.461s)
[91.146378] Starting dynamic subtest: pipe-B
[96.604755] Dynamic subtest pipe-B: SUCCESS (5.470s)
[96.621394] Starting dynamic subtest: pipe-C
[102.078097] Dynamic subtest pipe-C: SUCCESS (5.472s)
[102.089520] Starting dynamic subtest: pipe-D
[107.559822] Dynamic subtest pipe-D: SUCCESS (5.479s)
[107.569528] Starting dynamic subtest: all-pipes
[113.069704] Dynamic subtest all-pipes: SUCCESS (5.507s)
[113.072212] Subtest forked-move: SUCCESS (27.394s)
[113.212124] [005/133] (906s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[113.292952] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[113.376528] [006/133] (906s left) gem_mmap_gtt (big-copy-xy)
[113.446829] Subtest big-copy-XY: SKIP (0.000s)
[113.505756] [007/133] (906s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[113.607264] Starting subtest: y-tiled-32bpp-rotate-180
[113.611263] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[113.700081] [008/133] (906s left) sw_sync (sync_merge_same)
[113.743047] Starting subtest: sync_merge_same
[113.745344] Subtest sync_merge_same: SUCCESS (0.000s)
[113.796809] [009/133] (906s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[114.195249] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[115.031625] [010/133] (905s left) kms_sequence (queue-busy)
[115.137076] Starting subtest: queue-busy
[115.139619] Starting dynamic subtest: pipe-A-eDP-1
[117.078183] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[117.086794] Starting dynamic subtest: pipe-B-eDP-1
[119.663529] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.582s)
[119.672261] Starting dynamic subtest: pipe-C-eDP-1
[122.268912] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.605s)
[122.277407] Starting dynamic subtest: pipe-D-eDP-1
[124.821068] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[124.822948] Subtest queue-busy: SUCCESS (9.684s)
[125.633049] [011/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[125.725534] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[125.729739] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[125.817695] [012/133] (894s left) kms_cursor_crc (cursor-sliding-64x21)
[126.019278] Starting subtest: cursor-sliding-64x21
[126.073810] Subtest cursor-sliding-64x21: SKIP (0.050s)
[126.308651] [013/133] (893s left) i915_hangman (detector)
[126.402100] Starting subtest: detector
[126.404233] Starting dynamic subtest: rcs0
[137.844570] Dynamic subtest rcs0: SUCCESS (11.441s)
[137.855020] Starting dynamic subtest: bcs0
[149.876640] Dynamic subtest bcs0: SUCCESS (12.029s)
[149.887071] Starting dynamic subtest: vcs0
[160.819208] Dynamic subtest vcs0: SUCCESS (10.940s)
[160.830243] Starting dynamic subtest: vcs1
[172.852607] Dynamic subtest vcs1: SUCCESS (12.031s)
[172.862675] Starting dynamic subtest: vecs0
[184.819073] Dynamic subtest vecs0: SUCCESS (11.964s)
[184.830348] Starting dynamic subtest: ccs0
[195.890812] Dynamic subtest ccs0: SUCCESS (11.069s)
[195.894062] Subtest detector: SUCCESS (69.481s)
[195.971249] [014/133] (824s left) kms_prop_blob (basic)
[196.038816] Starting subtest: basic
[196.041151] Subtest basic: SUCCESS (0.000s)
[196.143845] [015/133] (824s left) gem_userptr_blits (dmabuf-sync)
[196.210890] Starting subtest: dmabuf-sync
[196.215193] Subtest dmabuf-sync: SKIP (0.002s)
[196.352593] [016/133] (823s left) perf (polling)
[196.442480] Starting subtest: polling
[196.444882] Starting dynamic subtest: 0-rcs0
[206.451418] Dynamic subtest 0-rcs0: SUCCESS (10.006s)
[206.459997] Starting dynamic subtest: 1-vcs1
[216.474545] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[216.476835] Subtest polling: SUCCESS (20.029s)
[216.520895] [017/133] (803s left) prime_vgem (wait)
[216.623962] Starting subtest: wait
[216.626294] Starting dynamic subtest: rcs0
[216.676824] Dynamic subtest rcs0: SUCCESS (0.053s)
[216.686761] Starting dynamic subtest: bcs0
[216.742478] Dynamic subtest bcs0: SUCCESS (0.065s)
[216.749984] Starting dynamic subtest: vcs0
[216.789532] Dynamic subtest vcs0: SUCCESS (0.047s)
[216.797131] Starting dynamic subtest: vcs1
[216.835311] Dynamic subtest vcs1: SUCCESS (0.045s)
[216.842792] Starting dynamic subtest: vecs0
[216.884373] Dynamic subtest vecs0: SUCCESS (0.049s)
[216.891913] Starting dynamic subtest: ccs0
[216.933098] Dynamic subtest ccs0: SUCCESS (0.048s)
[216.935412] Subtest wait: SUCCESS (0.310s)
[217.056670] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[217.059300] [018/133] (803s left) gem_exec_params (no-bsd)
[217.120702] Starting subtest: no-bsd
[217.123080] Subtest no-bsd: SUCCESS (0.003s)
[218.970803] [019/133] (801s left) kms_color (ctm-0-25)
[219.068764] Starting subtest: ctm-0-25
[219.071058] Starting dynamic subtest: pipe-A-eDP-1
[222.539018] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[222.551260] Starting dynamic subtest: pipe-B-eDP-1
[226.742180] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.202s)
[226.751095] Starting dynamic subtest: pipe-C-eDP-1
[230.787832] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.045s)
[230.795990] Starting dynamic subtest: pipe-D-eDP-1
[234.762134] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.973s)
[234.764340] Subtest ctm-0-25: SUCCESS (15.692s)
[235.577893] [020/133] (784s left) kms_cursor_crc (cursor-offscreen-512x170)
[235.885574] Starting subtest: cursor-offscreen-512x170
[235.890062] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[236.025745] [021/133] (784s left) kms_flip (dpms-off-confusion-interruptible)
[236.114060] Starting subtest: dpms-off-confusion-interruptible
[236.116353] Starting dynamic subtest: A-eDP1
[244.784741] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[244.793784] Starting dynamic subtest: B-eDP1
[253.423794] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[253.434500] Starting dynamic subtest: C-eDP1
[262.038432] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[262.046693] Starting dynamic subtest: D-eDP1
[270.667046] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[270.671929] Subtest dpms-off-confusion-interruptible: SUCCESS (34.555s)
[271.845878] [022/133] (748s left) gem_ctx_shared (exec-single-timeline)
[271.915280] Starting subtest: exec-single-timeline
[271.917658] Starting dynamic subtest: rcs0
[272.945063] Dynamic subtest rcs0: SUCCESS (1.028s)
[272.955368] Starting dynamic subtest: bcs0
[274.033398] Dynamic subtest bcs0: SUCCESS (1.086s)
[274.044759] Starting dynamic subtest: vcs0
[275.124065] Dynamic subtest vcs0: SUCCESS (1.089s)
[275.135713] Starting dynamic subtest: vcs1
[276.210503] Dynamic subtest vcs1: SUCCESS (1.084s)
[276.221872] Starting dynamic subtest: vecs0
[277.297208] Dynamic subtest vecs0: SUCCESS (1.086s)
[277.305163] Starting dynamic subtest: ccs0
[278.386101] Dynamic subtest ccs0: SUCCESS (1.086s)
[278.389332] Subtest exec-single-timeline: SUCCESS (6.470s)
[278.575492] [023/133] (742s left) kms_getfb (getfb-reject-nv12)
[278.666999] Starting subtest: getfb-reject-nv12
[278.669313] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[278.770127] [024/133] (741s left) gem_watchdog (default-physical)
[278.843989] Starting subtest: default-physical
[280.603549] Subtest default-physical: SUCCESS (1.769s)
[280.694853] [025/133] (740s left) kms_chamelium_frames (hdmi-crc-multiple)
[281.080024] Subtest hdmi-crc-multiple: SKIP (0.000s)
[281.857423] [026/133] (738s left) syncobj_timeline (multi-wait-signaled)
[281.905872] Starting subtest: multi-wait-signaled
[281.908237] Subtest multi-wait-signaled: SUCCESS (0.001s)
[282.004880] [027/133] (738s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[282.068759] Starting subtest: multi-wait-all-for-submit-available-submitted
[282.071034] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[282.176999] [028/133] (738s left) api_intel_bb (intel-bb-blit-x)
[282.232835] Starting subtest: intel-bb-blit-x
[286.075713] Subtest intel-bb-blit-x: SUCCESS (3.842s)
[286.184383] [029/133] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[286.288381] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[286.292773] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[286.391640] [030/133] (734s left) i915_drm_fdinfo (most-busy-idle-check-all)
[286.429387] Starting subtest: most-busy-idle-check-all
[286.431681] Starting dynamic subtest: rcs0
[286.436233] Dynamic subtest rcs0: SKIP (0.003s)
[286.447913] Starting dynamic subtest: bcs0
[286.452333] Dynamic subtest bcs0: SKIP (0.000s)
[286.464116] Starting dynamic subtest: vcs0
[286.468174] Dynamic subtest vcs0: SKIP (0.000s)
[286.475126] Starting dynamic subtest: vcs1
[286.479153] Dynamic subtest vcs1: SKIP (0.000s)
[286.486026] Starting dynamic subtest: vecs0
[286.490097] Dynamic subtest vecs0: SKIP (0.000s)
[286.497259] Starting dynamic subtest: ccs0
[286.501292] Dynamic subtest ccs0: SKIP (0.000s)
[286.505279] Subtest most-busy-idle-check-all: SKIP (0.007s)
[286.540222] [031/133] (734s left) kms_pm_backlight (fade-with-dpms)
[286.671913] Starting subtest: fade-with-dpms
[288.775077] Starting dynamic subtest: eDP-1
[291.268088] Dynamic subtest eDP-1: SUCCESS (2.492s)
[291.270379] Subtest fade-with-dpms: SUCCESS (4.596s)
[292.071694] [032/133] (728s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[292.171841] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[292.176251] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[292.265923] [033/133] (728s left) syncobj_wait (single-wait-all-for-submit-signaled)
[292.323579] Starting subtest: single-wait-all-for-submit-signaled
[292.325912] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[292.425031] [034/133] (728s left) kms_addfb_basic (basic-y-tiled-legacy)
[292.481347] Starting subtest: basic-y-tiled-legacy
[292.485678] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[292.618688] [035/133] (728s left) kms_psr (fbc-pr-dpms)
[292.713333] Starting subtest: fbc-pr-dpms
[292.717771] Subtest fbc-pr-dpms: SKIP (0.000s)
[292.785525] [036/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[292.884940] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[292.889339] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[292.988304] [037/133] (728s left) kms_dsc (dsc-with-output-formats-with-bpc)
[293.082726] Starting subtest: dsc-with-output-formats-with-bpc
[293.130910] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[293.165432] [038/133] (728s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[293.260066] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[293.263867] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[293.332965] [039/133] (727s left) gem_exec_schedule (submit-early-slice)
[293.400698] Starting subtest: submit-early-slice
[293.402869] Starting dynamic subtest: rcs0
[293.439498] Dynamic subtest rcs0: SUCCESS (0.043s)
[293.450980] Starting dynamic subtest: bcs0
[293.483277] Dynamic subtest bcs0: SUCCESS (0.043s)
[293.492201] Starting dynamic subtest: vcs0
[293.527801] Dynamic subtest vcs0: SUCCESS (0.044s)
[293.537187] Starting dynamic subtest: vcs1
[293.571418] Dynamic subtest vcs1: SUCCESS (0.043s)
[293.580695] Starting dynamic subtest: vecs0
[293.614017] Dynamic subtest vecs0: SUCCESS (0.042s)
[293.621729] Starting dynamic subtest: ccs0
[293.658084] Dynamic subtest ccs0: SUCCESS (0.043s)
[293.660340] Subtest submit-early-slice: SUCCESS (0.262s)
[295.022506] [040/133] (726s left) perf_pmu (busy-hang)
[295.067532] Starting subtest: busy-hang
[295.069431] Starting dynamic subtest: rcs0
[296.342108] Dynamic subtest rcs0: SUCCESS (1.275s)
[296.352748] Starting dynamic subtest: bcs0
[297.579422] Dynamic subtest bcs0: SUCCESS (1.234s)
[297.589473] Starting dynamic subtest: vcs0
[299.414281] Dynamic subtest vcs0: SUCCESS (1.835s)
[299.425065] Starting dynamic subtest: vcs1
[301.396434] Dynamic subtest vcs1: SUCCESS (1.980s)
[301.407937] Starting dynamic subtest: vecs0
[303.445867] Dynamic subtest vecs0: SUCCESS (2.048s)
[303.456846] Starting dynamic subtest: ccs0
[304.676801] Dynamic subtest ccs0: SUCCESS (1.229s)
[304.679605] Subtest busy-hang: SUCCESS (9.610s)
[304.775609] [041/133] (716s left) gem_exec_whisper (basic-fds)
[304.836850] Starting subtest: basic-fds
[314.870377] Subtest basic-fds: SUCCESS (10.030s)
[315.067135] [042/133] (706s left) kms_setmode (invalid-clone-single-crtc)
[315.138942] Starting subtest: invalid-clone-single-crtc
[315.145705] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[315.237808] [043/133] (706s left) kms_lease (lease-invalid-crtc)
[315.346662] Starting subtest: lease-invalid-crtc
[315.348898] Starting dynamic subtest: pipe-A-eDP-1
[315.351229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[315.359463] Starting dynamic subtest: pipe-B-eDP-1
[315.361620] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[315.369993] Starting dynamic subtest: pipe-C-eDP-1
[315.371826] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[315.379843] Starting dynamic subtest: pipe-D-eDP-1
[315.382568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[315.384766] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[315.421087] [044/133] (706s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[315.545211] Starting subtest: cursorB-vs-flipB-atomic
[315.549627] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[315.706065] [045/133] (705s left) gem_render_copy (linear)
[315.773357] Starting subtest: linear
[315.775725] Starting dynamic subtest: smem
[315.815496] Dynamic subtest smem: SUCCESS (0.041s)
[315.818450] Subtest linear: SUCCESS (0.042s)
[316.040841] [046/133] (705s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[316.127318] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[316.129591] Starting dynamic subtest: pipe-A-eDP-1
[316.152686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.162474] Starting dynamic subtest: pipe-B-eDP-1
[316.183638] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.192290] Starting dynamic subtest: pipe-C-eDP-1
[316.213312] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.221966] Starting dynamic subtest: pipe-D-eDP-1
[316.243903] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.247976] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[318.429227] [047/133] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[318.544839] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[319.567502] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.023s)
[319.680463] [048/133] (701s left) fbdev (eof)
[319.717823] Starting subtest: eof
[319.719979] Subtest eof: SUCCESS (0.000s)
[319.796547] [049/133] (701s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[319.856214] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[319.859740] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[320.042779] [050/133] (701s left) kms_cursor_crc (cursor-sliding-128x128)
[320.260941] Starting subtest: cursor-sliding-128x128
[320.263331] Starting dynamic subtest: pipe-A-eDP-1
[323.487846] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.224s)
[323.516567] Starting dynamic subtest: pipe-D-eDP-1
[327.404661] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.893s)
[327.406622] Subtest cursor-sliding-128x128: SUCCESS (7.143s)
[328.196802] [051/133] (693s left) gem_exec_fence (long-history)
[328.634889] Starting subtest: long-history
[335.607923] Subtest long-history: SUCCESS (6.973s)
[336.063113] [052/133] (685s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[336.157090] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[336.161283] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[336.251984] [053/133] (685s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[336.349464] Starting subtest: fbc-shrfb-scaledprimary
[339.287919] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.942s)
[340.422453] [054/133] (681s left) gem_exec_params (dr1-dirt)
[340.480868] Starting subtest: DR1-dirt
[340.483318] Subtest DR1-dirt: SUCCESS (0.000s)
[340.581426] [055/133] (681s left) gem_exec_balancer (sequential)
[340.651734] Starting subtest: sequential
[343.738810] Subtest sequential: SUCCESS (3.087s)
[344.076331] [056/133] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[344.176930] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[351.325637] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (7.152s)
[351.454479] [057/133] (670s left) gem_exec_create (madvise)
[351.521320] Starting subtest: madvise
[351.523553] Starting dynamic subtest: smem
[372.946265] Dynamic subtest smem: SUCCESS (21.421s)
[372.948368] Subtest madvise: SUCCESS (21.422s)
[373.780246] [058/133] (648s left) device_reset (unbind-reset-rebind)
[373.825084] Starting subtest: unbind-reset-rebind
[378.463096] Subtest unbind-reset-rebind: SUCCESS (4.632s)
[378.504943] [059/133] (643s left) i915_query (query-topology-matches-eu-total)
[378.562520] Starting subtest: query-topology-matches-eu-total
[378.564868] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[378.651184] [060/133] (643s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[378.733903] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[378.736214] Starting dynamic subtest: pipe-A-eDP-1
[378.756506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[378.765690] Starting dynamic subtest: pipe-B-eDP-1
[378.784830] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[378.795507] Starting dynamic subtest: pipe-C-eDP-1
[378.814765] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[378.823184] Starting dynamic subtest: pipe-D-eDP-1
[378.842256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[378.844400] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[380.979979] [061/133] (641s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[381.078325] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[381.082455] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[381.147633] [062/133] (641s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[381.233180] Starting subtest: primary-y-tiled-reflect-x-180
[381.293694] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[381.397372] [063/133] (640s left) kms_flip (2x-flip-vs-suspend)
[381.489610] Starting subtest: 2x-flip-vs-suspend
[381.499024] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[381.575489] [064/133] (640s left) kms_prop_blob (blob-prop-core)
[381.630666] Starting subtest: blob-prop-core
[381.632976] Subtest blob-prop-core: SUCCESS (0.000s)
[381.727303] [065/133] (640s left) gem_lmem_swapping (massive)
[381.765897] Subtest massive: SKIP (0.000s)
[381.815239] [066/133] (640s left) gem_ctx_param (invalid-size-set)
[381.867336] Starting subtest: invalid-size-set
[381.869663] Subtest invalid-size-set: SUCCESS (0.001s)
[381.969222] [067/133] (640s left) gem_mmap_offset (mmap-boundaries)
[382.018090] Starting subtest: mmap-boundaries
[382.019954] Starting dynamic subtest: smem0
[382.324659] Dynamic subtest smem0: SUCCESS (0.307s)
[382.327054] Subtest mmap-boundaries: SUCCESS (0.307s)
[382.452737] [068/133] (640s left) gem_pipe_control_store_loop (reused-buffer)
[382.510156] Starting subtest: reused-buffer
[384.664622] Subtest reused-buffer: SUCCESS (2.153s)
[384.786383] [069/133] (637s left) syncobj_basic (bad-flags-handle-to-fd)
[384.845191] Starting subtest: bad-flags-handle-to-fd
[384.847368] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[384.964322] [070/133] (637s left) kms_busy (extended-modeset-hang-newfb)
[385.075823] Starting subtest: extended-modeset-hang-newfb
[385.078141] Starting dynamic subtest: pipe-A
[419.798414] Dynamic subtest pipe-A: SUCCESS (34.718s)
[419.807463] Starting dynamic subtest: pipe-D
[442.841237] Dynamic subtest pipe-D: SUCCESS (23.037s)
[442.843502] Subtest extended-modeset-hang-newfb: SUCCESS (57.762s)
[443.629218] [071/133] (578s left) gem_exec_balancer (bonded-chain)
[443.690501] Starting subtest: bonded-chain
[450.697484] Subtest bonded-chain: SUCCESS (7.005s)
[451.013378] [072/133] (571s left) gem_spin_batch (resubmit-new)
[451.070566] Starting subtest: resubmit-new
[451.072902] Starting dynamic subtest: rcs0
[451.085854] Dynamic subtest rcs0: SUCCESS (0.014s)
[451.095152] Starting dynamic subtest: bcs0
[451.097384] Dynamic subtest bcs0: SUCCESS (0.007s)
[451.106324] Starting dynamic subtest: vcs0
[451.109420] Dynamic subtest vcs0: SUCCESS (0.005s)
[451.118326] Starting dynamic subtest: vcs1
[451.120192] Dynamic subtest vcs1: SUCCESS (0.005s)
[451.129383] Starting dynamic subtest: vecs0
[451.131508] Dynamic subtest vecs0: SUCCESS (0.006s)
[451.141052] Starting dynamic subtest: ccs0
[451.143205] Dynamic subtest ccs0: SUCCESS (0.008s)
[451.145355] Subtest resubmit-new: SUCCESS (0.050s)
[452.923463] [073/133] (569s left) gem_ctx_param (invalid-get-no-zeromap)
[452.964857] Starting subtest: invalid-get-no-zeromap
[452.967105] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[453.085588] [074/133] (569s left) gem_exec_reloc (basic-cpu-read-noreloc)
[453.141604] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[453.222067] [075/133] (569s left) kms_flip (flip-vs-rmfb-interruptible)
[453.321060] Starting subtest: flip-vs-rmfb-interruptible
[453.323271] Starting dynamic subtest: A-eDP1
[462.020475] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[462.034703] Starting dynamic subtest: B-eDP1
[470.649136] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[470.659084] Starting dynamic subtest: C-eDP1
[479.266977] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[479.278778] Starting dynamic subtest: D-eDP1
[487.888364] Dynamic subtest D-eDP1: SUCCESS (8.618s)
[487.893650] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.570s)
[489.101100] [076/133] (533s left) gen7_exec_parse (chained-batch)
[489.163824] Subtest chained-batch: SKIP (0.000s)
[489.232554] [077/133] (533s left) kms_rotation_crc (sprite-rotation-180)
[489.330346] Starting subtest: sprite-rotation-180
[496.141344] Subtest sprite-rotation-180: SUCCESS (6.813s)
[497.357886] [078/133] (525s left) gem_exec_flush (basic-uc-set-default)
[497.423698] Starting subtest: basic-uc-set-default
[502.877436] Subtest basic-uc-set-default: SUCCESS (5.454s)
[503.067025] [079/133] (519s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[503.175451] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[503.179833] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[503.257833] [080/133] (519s left) gem_lmem_swapping (smem-oom)
[503.294839] Subtest smem-oom: SKIP (0.000s)
[503.336535] [081/133] (519s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[503.429320] Starting subtest: fbc-rgb565-draw-render
[507.616832] Subtest fbc-rgb565-draw-render: SUCCESS (4.190s)
[508.742353] [082/133] (514s left) perf (rc6-disable)
[508.879738] Starting subtest: rc6-disable
[509.056219] Subtest rc6-disable: SUCCESS (0.178s)
[509.113377] [083/133] (513s left) syncobj_timeline (host-signal-points)
[509.172018] Starting subtest: host-signal-points
[509.176857] Subtest host-signal-points: SUCCESS (0.004s)
[509.269092] [084/133] (513s left) gem_exec_schedule (implicit-read-write)
[509.334274] Starting subtest: implicit-read-write
[509.336562] Starting dynamic subtest: rcs0
[509.430208] Dynamic subtest rcs0: SUCCESS (0.105s)
[509.442943] Starting dynamic subtest: vcs0
[509.507689] Dynamic subtest vcs0: SUCCESS (0.078s)
[509.519420] Starting dynamic subtest: vcs1
[509.587347] Dynamic subtest vcs1: SUCCESS (0.079s)
[509.599347] Starting dynamic subtest: vecs0
[509.659570] Dynamic subtest vecs0: SUCCESS (0.071s)
[509.670829] Starting dynamic subtest: ccs0
[509.748455] Dynamic subtest ccs0: SUCCESS (0.088s)
[509.750688] Subtest implicit-read-write: SUCCESS (0.426s)
[511.033828] [085/133] (512s left) kms_joiner (invalid-modeset-force-big-joiner)
[511.125534] Starting subtest: invalid-modeset-force-big-joiner
[511.129984] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[511.205056] [086/133] (512s left) api_intel_bb (add-remove-objects)
[511.260840] Starting subtest: add-remove-objects
[511.266529] Subtest add-remove-objects: SUCCESS (0.006s)
[511.388982] [087/133] (511s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[511.516161] Starting subtest: flip-vs-cursor-atomic-transitions
[519.132860] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.613s)
[519.957994] [088/133] (503s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[520.050901] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[527.381120] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.333s)
[527.518591] [089/133] (495s left) kms_psr (psr2-cursor-mmap-gtt)
[527.619143] Starting subtest: psr2-cursor-mmap-gtt
[527.621404] Starting dynamic subtest: eDP-1
[529.317511] Dynamic subtest eDP-1: SUCCESS (1.700s)
[529.319910] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.701s)
[530.109884] [090/133] (493s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[530.197361] Starting subtest: crc-primary-suspend-y-tiled-ccs
[530.199685] Starting dynamic subtest: pipe-A-eDP-1
[530.208752] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.219834] Starting dynamic subtest: pipe-B-eDP-1
[530.229074] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.238240] Starting dynamic subtest: pipe-C-eDP-1
[530.247064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.256294] Starting dynamic subtest: pipe-D-eDP-1
[530.265704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.270149] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[532.475286] [091/133] (490s left) kms_atomic_transition (modeset-transition)
[532.566049] Starting subtest: modeset-transition
[532.568534] Starting dynamic subtest: 1x-outputs
[543.425235] Dynamic subtest 1x-outputs: SUCCESS (10.860s)
[543.427866] Subtest modeset-transition: SUCCESS (10.861s)
[544.296514] [092/133] (479s left) sysfs_timeslice_duration (invalid)
[544.360422] Starting subtest: invalid
[544.362763] Starting dynamic subtest: vecs0
[544.365191] Dynamic subtest vecs0: SUCCESS (0.000s)
[544.378228] Starting dynamic subtest: ccs0
[544.380517] Dynamic subtest ccs0: SUCCESS (0.000s)
[544.389317] Starting dynamic subtest: vcs0
[544.391607] Dynamic subtest vcs0: SUCCESS (0.000s)
[544.400645] Starting dynamic subtest: bcs0
[544.402869] Dynamic subtest bcs0: SUCCESS (0.000s)
[544.411367] Starting dynamic subtest: rcs0
[544.413615] Dynamic subtest rcs0: SUCCESS (0.000s)
[544.423069] Starting dynamic subtest: vcs1
[544.425233] Dynamic subtest vcs1: SUCCESS (0.000s)
[544.427511] Subtest invalid: SUCCESS (0.006s)
[544.487173] [093/133] (479s left) kms_psr (fbc-psr-cursor-render)
[544.579059] Starting subtest: fbc-psr-cursor-render
[544.581319] Starting dynamic subtest: eDP-1
[544.585724] Dynamic subtest eDP-1: SKIP (0.000s)
[544.590121] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[544.653072] [094/133] (478s left) syncobj_wait (reset-during-wait-for-submit)
[544.713741] Starting subtest: reset-during-wait-for-submit
[544.818437] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[544.910349] [095/133] (478s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[544.967675] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[544.970027] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[545.076312] [096/133] (478s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[545.219580] Starting subtest: dp-mst-type-0-suspend-resume
[545.224183] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[545.339487] [097/133] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[545.437302] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[545.441154] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[545.529252] [098/133] (478s left) prime_mmap_kms (buffer-sharing)
[545.620058] Starting subtest: buffer-sharing
[546.067365] Subtest buffer-sharing: SUCCESS (0.445s)
[546.911219] [099/133] (476s left) syncobj_timeline (single-wait-available-signaled)
[546.978417] Starting subtest: single-wait-available-signaled
[546.980740] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[547.074858] [100/133] (476s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[547.163061] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[547.165264] Starting dynamic subtest: pipe-A-default-mode
[549.953758] Dynamic subtest pipe-A-default-mode: SUCCESS (2.790s)
[549.956450] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.792s)
[550.801765] [101/133] (473s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[550.895963] Starting subtest: fbc-tiling-linear
[554.657381] Subtest fbc-tiling-linear: SUCCESS (3.766s)
[555.802883] [102/133] (468s left) syncobj_wait (single-wait-all-submitted)
[555.850017] Starting subtest: single-wait-all-submitted
[555.953053] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[556.029388] [103/133] (467s left) kms_setmode (basic-clone-single-crtc)
[556.078370] Starting subtest: basic-clone-single-crtc
[556.084635] Subtest basic-clone-single-crtc: SKIP (0.000s)
[556.169744] [104/133] (467s left) syncobj_eventfd (timeline-wait-before-signal)
[556.236218] Starting subtest: timeline-wait-before-signal
[556.265154] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[556.342818] [105/133] (467s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[556.427251] Starting subtest: psr-rgb101010-draw-mmap-wc
[563.477978] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.054s)
[563.591459] [106/133] (460s left) kms_chamelium_color (ctm-negative)
[563.682083] Subtest ctm-negative: SKIP (0.000s)
[563.730801] [107/133] (460s left) syncobj_wait (multi-wait-all-signaled)
[563.793666] Starting subtest: multi-wait-all-signaled
[563.795556] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[563.902455] [108/133] (460s left) kms_psr (psr-primary-mmap-gtt)
[563.991622] Starting subtest: psr-primary-mmap-gtt
[563.993820] Starting dynamic subtest: eDP-1
[565.397456] Dynamic subtest eDP-1: SKIP (1.403s)
[565.402207] Subtest psr-primary-mmap-gtt: SKIP (1.405s)
[565.579290] [109/133] (458s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[565.675292] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[565.677519] Starting dynamic subtest: pipe-A-eDP-1
[565.699684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.712035] Starting dynamic subtest: pipe-B-eDP-1
[565.732602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.741514] Starting dynamic subtest: pipe-C-eDP-1
[565.762112] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.770709] Starting dynamic subtest: pipe-D-eDP-1
[565.791569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.795474] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[567.986834] [110/133] (456s left) gem_ctx_persistence (heartbeat-stop)
[568.047351] Starting subtest: heartbeat-stop
[568.052057] Subtest heartbeat-stop: SKIP (0.000s)
[568.152975] [111/133] (456s left) kms_psr (pr-sprite-render)
[568.258335] Starting subtest: pr-sprite-render
[568.262720] Subtest pr-sprite-render: SKIP (0.000s)
[568.341416] [112/133] (455s left) gem_ppgtt (shrink-vs-evict-pinned)
[568.392402] Starting subtest: shrink-vs-evict-pinned
[573.865602] Subtest shrink-vs-evict-pinned: SUCCESS (5.472s)
[573.947265] [113/133] (450s left) gem_exec_reloc (basic-write-gtt)
[574.008354] Subtest basic-write-gtt: SKIP (0.000s)
[574.086497] [114/133] (450s left) i915_pm_rps (thresholds-idle)
[574.159600] Starting subtest: thresholds-idle
[574.164229] Subtest thresholds-idle: SKIP (0.001s)
[574.235886] [115/133] (450s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[574.333766] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[574.935749] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[575.112536] [116/133] (449s left) kms_plane (plane-position-covered)
[575.211185] Starting subtest: plane-position-covered
[575.747852] Starting dynamic subtest: pipe-A-plane-1
[577.073155] Dynamic subtest pipe-A-plane-1: SUCCESS (1.324s)
[577.083100] Starting dynamic subtest: pipe-A-plane-2
[578.385044] Dynamic subtest pipe-A-plane-2: SUCCESS (1.311s)
[578.395126] Starting dynamic subtest: pipe-A-plane-3
[579.724504] Dynamic subtest pipe-A-plane-3: SUCCESS (1.341s)
[579.735420] Starting dynamic subtest: pipe-A-plane-4
[581.070253] Dynamic subtest pipe-A-plane-4: SUCCESS (1.344s)
[581.080291] Starting dynamic subtest: pipe-A-plane-5
[581.096422] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[582.304326] Starting dynamic subtest: pipe-B-plane-1
[583.620539] Dynamic subtest pipe-B-plane-1: SUCCESS (1.324s)
[583.630484] Starting dynamic subtest: pipe-B-plane-2
[584.954946] Dynamic subtest pipe-B-plane-2: SUCCESS (1.332s)
[584.965123] Starting dynamic subtest: pipe-B-plane-3
[586.279702] Dynamic subtest pipe-B-plane-3: SUCCESS (1.325s)
[586.290509] Starting dynamic subtest: pipe-B-plane-4
[587.642883] Dynamic subtest pipe-B-plane-4: SUCCESS (1.361s)
[587.653071] Starting dynamic subtest: pipe-B-plane-5
[587.671855] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s)
[587.674224] Subtest plane-position-covered: SUCCESS (12.461s)
[588.463158] [117/133] (436s left) gem_workarounds (suspend-resume-fd)
[588.536324] Starting subtest: suspend-resume-fd
[604.495664] Subtest suspend-resume-fd: SUCCESS (1.310s)
[604.626542] [118/133] (419s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[604.740782] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[604.744852] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[604.834137] [119/133] (419s left) i915_pm_rpm (debugfs-read)
[606.688248] Starting subtest: debugfs-read
[607.855750] Subtest debugfs-read: SUCCESS (1.135s)
[608.242685] [120/133] (416s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[608.336422] Starting subtest: compare-crc-sanitycheck-nv12
[608.338835] Starting dynamic subtest: pipe-A-eDP-1
[609.058897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[609.069736] Starting dynamic subtest: pipe-B-eDP-1
[610.353308] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[610.364819] Starting dynamic subtest: pipe-C-eDP-1
[611.650957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.274s)
[611.661119] Starting dynamic subtest: pipe-D-eDP-1
[612.893564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[612.895846] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.471s)
[613.754142] [121/133] (410s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[613.843013] Starting subtest: pixel-format-linear-modifier-source-clamping
[613.869149] Starting dynamic subtest: pipe-A-plane-0
[617.360821] Dynamic subtest pipe-A-plane-0: SUCCESS (3.456s)
[617.373190] Starting dynamic subtest: pipe-A-plane-3
[619.037371] Dynamic subtest pipe-A-plane-3: SUCCESS (1.664s)
[620.185082] Starting dynamic subtest: pipe-B-plane-0
[623.859171] Dynamic subtest pipe-B-plane-0: SUCCESS (3.666s)
[623.868886] Starting dynamic subtest: pipe-B-plane-3
[625.620871] Dynamic subtest pipe-B-plane-3: SUCCESS (1.755s)
[625.946270] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.027s)
[626.780610] [122/133] (397s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[626.890723] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[626.894864] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[626.991785] [123/133] (397s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[627.085761] Starting subtest: fbc-pr-sprite-mmap-gtt
[627.090189] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[627.165919] [124/133] (397s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[627.265570] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[627.269843] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[627.366440] [125/133] (397s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[627.459059] Starting subtest: plane-upscale-factor-0-25-with-rotation
[627.461323] Starting dynamic subtest: pipe-A
[627.684836] Dynamic subtest pipe-A: SUCCESS (0.227s)
[627.699624] Starting dynamic subtest: pipe-B
[628.977455] Dynamic subtest pipe-B: SUCCESS (1.287s)
[628.987616] Starting dynamic subtest: pipe-C
[630.307634] Dynamic subtest pipe-C: SUCCESS (1.326s)
[630.318853] Starting dynamic subtest: pipe-D
[631.639632] Dynamic subtest pipe-D: SUCCESS (1.329s)
[631.641990] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.175s)
[632.814427] [126/133] (392s left) gem_exec_gttfill (engines)
[632.869084] Starting subtest: engines
[632.871810] Starting dynamic subtest: rcs0
[655.841376] Dynamic subtest rcs0: SUCCESS (22.958s)
[655.852721] Starting dynamic subtest: bcs0
[679.141131] Dynamic subtest bcs0: SUCCESS (23.287s)
[679.157505] Starting dynamic subtest: vcs0
[702.436902] Dynamic subtest vcs0: SUCCESS (23.283s)
[702.450314] Starting dynamic subtest: vcs1
[725.710323] Dynamic subtest vcs1: SUCCESS (23.275s)
[725.723499] Starting dynamic subtest: vecs0
[749.053948] Dynamic subtest vecs0: SUCCESS (23.338s)
[749.067216] Starting dynamic subtest: ccs0
[772.383065] Dynamic subtest ccs0: SUCCESS (23.323s)
[772.386028] Subtest engines: SUCCESS (139.479s)
[772.573808] [127/133] (252s left) gem_create (create-ext-placement-each)
[772.789708] Starting subtest: create-ext-placement-each
[772.791963] Subtest create-ext-placement-each: SUCCESS (0.000s)
[772.886268] [128/133] (252s left) gem_render_copy (yf-tiled)
[772.946161] Starting subtest: yf-tiled
[772.950904] Subtest yf-tiled: SKIP (0.000s)
[773.149428] [129/133] (251s left) kms_rotation_crc (cursor-rotation-180)
[773.267311] Starting subtest: cursor-rotation-180
[774.804967] Subtest cursor-rotation-180: SUCCESS (1.538s)
[775.991745] [130/133] (249s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[776.091070] Starting subtest: yf-tiled-64bpp-rotate-0
[776.095475] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[776.191122] [131/133] (248s left) kms_big_fb (linear-32bpp-rotate-270)
[776.285764] Starting subtest: linear-32bpp-rotate-270
[776.305214] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[776.431405] [132/133] (248s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[776.524521] Starting subtest: fbc-rgb101010-draw-blt
[781.137172] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.614s)
[782.311835] [133/133] (242s left) syncobj_wait (reset-unsignaled)
[782.373101] Starting subtest: reset-unsignaled
[782.375601] Subtest reset-unsignaled: SUCCESS (0.000s)
[782.488817] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: kms_sequence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: i915_hangman
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_ctx_shared
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: gem_watchdog
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_pm_backlight
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_dsc
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: kms_lease
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_create
results: parsing output: 57/ for test: device_reset
results: parsing output: 58/ for test: i915_query
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: gem_mmap_offset
results: parsing output: 67/ for test: gem_pipe_control_store_loop
results: parsing output: 68/ for test: syncobj_basic
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_joiner
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: sysfs_timeslice_duration
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_mmap_kms
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_setmode
results: parsing output: 103/ for test: syncobj_eventfd
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_chamelium_color
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ppgtt
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: gem_workarounds
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: i915_pm_rpm
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_exec_gttfill
results: parsing output: 126/ for test: gem_create
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.