[56.484355] Initializing watchdogs
[56.484402]   /dev/watchdog0
[56.499692] [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]
[56.504347] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.506885] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.510821] [001/133] (960s left) gem_busy (extended)
[56.723528] Starting subtest: extended
[56.726350] Starting dynamic subtest: rcs0
[56.816044] Dynamic subtest rcs0: SUCCESS (0.093s)
[56.826665] Starting dynamic subtest: bcs0
[56.860089] Dynamic subtest bcs0: SUCCESS (0.044s)
[56.869295] Starting dynamic subtest: vcs0
[58.313299] Dynamic subtest vcs0: SUCCESS (1.451s)
[58.322102] Starting dynamic subtest: vcs1
[60.298759] Dynamic subtest vcs1: SUCCESS (1.984s)
[60.308382] Starting dynamic subtest: vecs0
[62.281628] Dynamic subtest vecs0: SUCCESS (1.981s)
[62.290080] Starting dynamic subtest: ccs0
[62.328773] Dynamic subtest ccs0: SUCCESS (0.047s)
[62.331432] Subtest extended: SUCCESS (5.606s)
[62.567615] [002/133] (954s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[62.668702] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[62.671089] Starting dynamic subtest: pipe-A-eDP-1
[62.694642] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.703941] Starting dynamic subtest: pipe-B-eDP-1
[62.725903] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.734896] Starting dynamic subtest: pipe-C-eDP-1
[62.755409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.762981] Starting dynamic subtest: pipe-D-eDP-1
[62.784991] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.789089] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[65.183884] [003/133] (951s left) kms_frontbuffer_tracking (psr-2p-rte)
[65.291633] Starting subtest: psr-2p-rte
[65.295853] Subtest psr-2p-rte: SKIP (0.000s)
[65.390094] [004/133] (951s left) syncobj_wait (reset-during-wait-for-submit)
[65.447364] Starting subtest: reset-during-wait-for-submit
[65.551777] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[65.628051] [005/133] (951s left) gem_fenced_exec_thrash (too-many-fences)
[65.686775] Subtest too-many-fences: SKIP (0.000s)
[65.756587] [006/133] (951s left) gem_tiled_fence_blits (basic)
[65.811724] Subtest basic: SKIP (0.000s)
[65.875976] [007/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[65.966248] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[73.691695] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.728s)
[73.813659] [008/133] (943s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[73.907981] Starting subtest: psr-rgb101010-draw-render
[81.260791] Subtest psr-rgb101010-draw-render: SUCCESS (7.356s)
[81.393963] [009/133] (935s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[81.502770] Starting subtest: x-tiled-64bpp-rotate-90
[81.523489] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[81.623635] [010/133] (935s left) gem_eio (wait-1us)
[81.789014] Starting subtest: wait-1us
[82.012416] Subtest wait-1us: SUCCESS (0.223s)
[82.124674] [011/133] (935s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[82.217205] Starting subtest: fbc-psr-sprite-mmap-cpu
[82.219146] Starting dynamic subtest: eDP-1
[82.222651] Dynamic subtest eDP-1: SKIP (0.000s)
[82.226307] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[82.287649] [012/133] (935s left) gem_exec_schedule (manyslice)
[82.355469] Starting subtest: manyslice
[82.357636] Starting dynamic subtest: rcs0
[87.494410] Dynamic subtest rcs0: SUCCESS (5.143s)
[87.507640] Starting dynamic subtest: bcs0
[94.631112] Dynamic subtest bcs0: SUCCESS (7.135s)
[94.640945] Starting dynamic subtest: vcs0
[100.711822] Dynamic subtest vcs0: SUCCESS (6.080s)
[100.724750] Starting dynamic subtest: vcs1
[106.791614] Dynamic subtest vcs1: SUCCESS (6.079s)
[106.804190] Starting dynamic subtest: vecs0
[112.878458] Dynamic subtest vecs0: SUCCESS (6.086s)
[112.887907] Starting dynamic subtest: ccs0
[119.072771] Dynamic subtest ccs0: SUCCESS (6.194s)
[119.075347] Subtest manyslice: SUCCESS (36.721s)
[119.388962] [013/133] (898s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[119.450076] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[119.452295] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[119.544630] [014/133] (897s left) gem_exec_schedule (wide)
[119.727277] Starting subtest: wide
[119.730525] Starting dynamic subtest: rcs0
[130.877286] Dynamic subtest rcs0: SUCCESS (11.148s)
[130.889680] Starting dynamic subtest: vcs0
[142.932393] Dynamic subtest vcs0: SUCCESS (12.055s)
[142.943886] Starting dynamic subtest: vcs1
[155.811981] Dynamic subtest vcs1: SUCCESS (12.879s)
[155.820883] Starting dynamic subtest: vecs0
[167.804062] Dynamic subtest vecs0: SUCCESS (11.990s)
[167.815353] Starting dynamic subtest: ccs0
[181.456788] Dynamic subtest ccs0: SUCCESS (13.653s)
[181.459100] Subtest wide: SUCCESS (61.726s)
[182.584939] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[182.587894] [015/133] (834s left) kms_addfb_basic (small-bo)
[182.677269] Starting subtest: small-bo
[182.679674] Subtest small-bo: SUCCESS (0.000s)
[182.772455] [016/133] (834s left) gem_exec_balancer (full-late)
[182.832045] Starting subtest: full-late
[187.186642] Subtest full-late: SUCCESS (4.354s)
[187.519659] [017/133] (830s left) kms_pm_backlight (brightness-with-dpms)
[187.619090] Starting subtest: brightness-with-dpms
[187.701886] Starting dynamic subtest: eDP-1
[190.147823] Dynamic subtest eDP-1: SUCCESS (2.444s)
[190.150241] Subtest brightness-with-dpms: SUCCESS (2.529s)
[191.027121] [018/133] (826s left) api_intel_allocator (fork-simple-once)
[191.089913] Starting subtest: fork-simple-once
[191.105425] Subtest fork-simple-once: SUCCESS (0.016s)
[191.242941] [019/133] (826s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[191.336076] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[191.340377] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[191.418860] [020/133] (826s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[191.517823] Starting subtest: psr2-plane-move-sf-dmg-area
[191.520098] Starting dynamic subtest: pipe-A-eDP-1
[196.097609] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.581s)
[196.107604] Starting dynamic subtest: pipe-B-eDP-1
[201.416381] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.317s)
[201.418933] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.901s)
[202.307501] [021/133] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[202.422797] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[205.967936] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.550s)
[207.112428] [022/133] (810s left) kms_frontbuffer_tracking (fbc-2p-rte)
[207.218855] Starting subtest: fbc-2p-rte
[207.223442] Subtest fbc-2p-rte: SKIP (0.000s)
[207.320325] [023/133] (810s left) gem_exec_reloc (basic-cpu-wc)
[207.369780] Subtest basic-cpu-wc: SKIP (0.000s)
[207.451145] [024/133] (810s left) gem_tiled_blits (normal)
[207.514194] Subtest normal: SKIP (0.000s)
[207.586492] [025/133] (810s left) syncobj_timeline (wait-all-for-submit-complex)
[207.644831] Starting subtest: wait-all-for-submit-complex
[207.858625] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[207.931710] [026/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[208.020629] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[208.024855] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[208.124848] [027/133] (809s left) kms_dsc (dsc-with-output-formats-with-bpc)
[208.227716] Starting subtest: dsc-with-output-formats-with-bpc
[208.285091] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[208.327243] [028/133] (809s left) gem_exec_flush (basic-wb-rw-default)
[208.389945] Starting subtest: basic-wb-rw-default
[213.843791] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[214.045039] [029/133] (804s left) kms_joiner (basic-big-joiner)
[214.159273] Starting subtest: basic-big-joiner
[214.163904] Subtest basic-big-joiner: SKIP (0.000s)
[214.240177] [030/133] (803s left) perf_pmu (render-node-busy-idle)
[214.316755] Starting subtest: render-node-busy-idle
[214.319751] Starting dynamic subtest: rcs0
[215.009714] Dynamic subtest rcs0: SUCCESS (0.692s)
[215.021998] Starting dynamic subtest: bcs0
[215.672793] Dynamic subtest bcs0: SUCCESS (0.661s)
[215.683084] Starting dynamic subtest: vcs0
[217.289719] Dynamic subtest vcs0: SUCCESS (1.614s)
[217.302247] Starting dynamic subtest: vcs1
[219.272513] Dynamic subtest vcs1: SUCCESS (1.982s)
[219.284834] Starting dynamic subtest: vecs0
[221.321473] Dynamic subtest vecs0: SUCCESS (2.047s)
[221.333981] Starting dynamic subtest: ccs0
[221.993475] Dynamic subtest ccs0: SUCCESS (0.672s)
[221.996039] Subtest render-node-busy-idle: SUCCESS (7.677s)
[222.083513] [031/133] (796s left) kms_addfb_basic (invalid-get-prop)
[222.139221] Starting subtest: invalid-get-prop
[222.141514] Subtest invalid-get-prop: SUCCESS (0.000s)
[222.286543] [032/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[222.388538] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[222.392698] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[222.500052] [033/133] (795s left) i915_pm_rps (thresholds)
[222.555932] Starting subtest: thresholds
[222.560438] Subtest thresholds: SKIP (0.001s)
[222.662626] [034/133] (795s left) gem_mmap_wc (bad-offset)
[222.709155] Subtest bad-offset: SKIP (0.000s)
[222.808695] [035/133] (795s left) kms_rotation_crc (multiplane-rotation)
[222.895272] Starting subtest: multiplane-rotation
[240.353123] Subtest multiplane-rotation: SUCCESS (17.460s)
[240.458110] [036/133] (778s left) gem_softpin (evict-prime-sanity-check)
[240.512680] Starting subtest: evict-prime-sanity-check
[240.514703] Starting dynamic subtest: rcs0
[241.657722] Dynamic subtest rcs0: SUCCESS (1.144s)
[241.669469] Starting dynamic subtest: bcs0
[242.763658] Dynamic subtest bcs0: SUCCESS (1.105s)
[242.774260] Starting dynamic subtest: vcs0
[244.272062] Dynamic subtest vcs0: SUCCESS (1.506s)
[244.282934] Starting dynamic subtest: vcs1
[246.273782] Dynamic subtest vcs1: SUCCESS (2.000s)
[246.288572] Starting dynamic subtest: vecs0
[248.262485] Dynamic subtest vecs0: SUCCESS (1.986s)
[248.272664] Starting dynamic subtest: ccs0
[249.381236] Dynamic subtest ccs0: SUCCESS (1.118s)
[249.390763] Starting dynamic subtest: all
[250.511543] Dynamic subtest all: SUCCESS (1.129s)
[250.514431] Subtest evict-prime-sanity-check: SUCCESS (9.999s)
[250.597058] [037/133] (767s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[250.690851] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[250.695212] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[250.764856] [038/133] (767s left) kms_flip (flip-vs-expired-vblank-interruptible)
[250.870465] Starting subtest: flip-vs-expired-vblank-interruptible
[250.872767] Starting dynamic subtest: A-eDP1
[259.502347] Dynamic subtest A-eDP1: SUCCESS (8.631s)
[259.513087] Starting dynamic subtest: B-eDP1
[268.123813] Dynamic subtest B-eDP1: SUCCESS (8.619s)
[268.135922] Starting dynamic subtest: C-eDP1
[276.745809] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[276.758092] Starting dynamic subtest: D-eDP1
[285.376774] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[285.379540] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.508s)
[286.563081] [039/133] (732s left) gem_ctx_shared (disjoint-timelines)
[286.624088] Starting subtest: disjoint-timelines
[286.656327] Subtest disjoint-timelines: SUCCESS (0.032s)
[286.908490] [040/133] (731s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[287.006837] Starting subtest: fbcpsr-rgb101010-draw-render
[293.808575] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.805s)
[293.921247] [041/133] (724s left) gem_exec_parallel (fds)
[293.989214] Starting subtest: fds
[293.991462] Starting dynamic subtest: rcs0
[297.452042] Dynamic subtest rcs0: SUCCESS (3.463s)
[297.464755] Starting dynamic subtest: bcs0
[301.455796] Dynamic subtest bcs0: SUCCESS (4.003s)
[301.466857] Starting dynamic subtest: vcs0
[305.573533] Dynamic subtest vcs0: SUCCESS (4.114s)
[305.584810] Starting dynamic subtest: vcs1
[311.352287] Dynamic subtest vcs1: SUCCESS (5.777s)
[311.362113] Starting dynamic subtest: vecs0
[315.549777] Dynamic subtest vecs0: SUCCESS (4.195s)
[315.567598] Starting dynamic subtest: ccs0
[319.528841] Dynamic subtest ccs0: SUCCESS (3.977s)
[319.531573] Subtest fds: SUCCESS (25.539s)
[319.720249] [042/133] (699s left) gem_readwrite (new-obj)
[319.777514] Subtest new-obj: SKIP (0.000s)
[319.853752] [043/133] (698s left) gem_mmap_wc (fault-concurrent)
[319.907401] Subtest fault-concurrent: SKIP (0.000s)
[319.972576] [044/133] (698s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[320.077362] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[321.134257] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.056s)
[321.266938] [045/133] (697s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[321.324407] Starting subtest: multi-wait-for-submit-available-signaled
[321.326312] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[321.414046] [046/133] (697s left) gem_exec_fence (basic-busy-all)
[321.470549] Starting subtest: basic-busy-all
[321.565717] Subtest basic-busy-all: SUCCESS (0.096s)
[323.361244] [047/133] (695s left) gem_lmem_swapping (parallel-random-verify-ccs)
[323.403211] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[323.452636] [048/133] (695s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[323.537108] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[323.539420] Starting dynamic subtest: pipe-A-eDP-1
[323.562736] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[323.575206] Starting dynamic subtest: pipe-B-eDP-1
[323.596732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[323.606936] Starting dynamic subtest: pipe-C-eDP-1
[323.628523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[323.639901] Starting dynamic subtest: pipe-D-eDP-1
[323.662095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[323.666408] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[325.833726] [049/133] (693s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[325.938049] Starting subtest: pr-plane-move-sf-dmg-area
[325.942250] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[326.007678] [050/133] (693s left) kms_psr (fbc-psr2-sprite-blt)
[326.099907] Starting subtest: fbc-psr2-sprite-blt
[326.102879] Starting dynamic subtest: eDP-1
[326.107121] Dynamic subtest eDP-1: SKIP (0.000s)
[326.111303] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[326.176123] [051/133] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[326.275789] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[332.975359] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.703s)
[333.129203] [052/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[333.235162] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[333.239668] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[333.337740] [053/133] (685s left) gem_eio (wait-10ms)
[333.561904] Starting subtest: wait-10ms
[333.908984] Subtest wait-10ms: SUCCESS (0.346s)
[334.037770] [054/133] (685s left) kms_prime (basic-crc-vgem)
[334.117343] Starting subtest: basic-crc-vgem
[334.118951] Starting dynamic subtest: second-to-first
[335.118527] Dynamic subtest second-to-first: SUCCESS (1.004s)
[335.120526] Subtest basic-crc-vgem: SUCCESS (1.005s)
[335.244135] [055/133] (684s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[335.382266] Starting subtest: extended-modeset-hang-newfb-with-reset
[335.384245] Starting dynamic subtest: pipe-A
[349.214203] Dynamic subtest pipe-A: SUCCESS (13.830s)
[349.225806] Starting dynamic subtest: pipe-D
[365.094154] Dynamic subtest pipe-D: SUCCESS (15.876s)
[365.096485] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.710s)
[365.893733] [056/133] (653s left) kms_hdr (static-swap)
[365.992246] Starting subtest: static-swap
[365.998687] Subtest static-swap: SKIP (0.000s)
[366.077629] [057/133] (653s left) kms_content_protection (type1)
[366.206379] Starting subtest: type1
[366.210804] Subtest type1: SKIP (0.000s)
[366.341845] [058/133] (653s left) gem_flink_basic (double-flink)
[366.406620] Starting subtest: double-flink
[366.408627] Subtest double-flink: SUCCESS (0.000s)
[366.525347] [059/133] (652s left) gem_tiled_swapping (non-threaded)
[366.589985] Subtest non-threaded: SKIP (0.000s)
[366.648122] [060/133] (652s left) gem_render_copy (yf-tiled)
[366.715209] Starting subtest: yf-tiled
[366.719628] Subtest yf-tiled: SKIP (0.000s)
[366.926794] [061/133] (652s left) gem_exec_balancer (semaphore)
[366.991245] Starting subtest: semaphore
[368.326583] Subtest semaphore: SUCCESS (1.333s)
[368.656520] [062/133] (650s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[368.718984] Starting subtest: y-tiled-to-vebox-x-tiled
[368.723637] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[368.908678] [063/133] (650s left) gem_exec_fence (syncobj-timeline-wait)
[369.470227] Starting subtest: syncobj-timeline-wait
[371.298082] Subtest syncobj-timeline-wait: SUCCESS (1.828s)
[371.535509] [064/133] (648s left) kms_flip (dpms-vs-vblank-race)
[371.630306] Starting subtest: dpms-vs-vblank-race
[371.632571] Starting dynamic subtest: A-eDP1
[375.528459] Dynamic subtest A-eDP1: SUCCESS (3.896s)
[375.538612] Starting dynamic subtest: B-eDP1
[379.056362] Dynamic subtest B-eDP1: SUCCESS (3.526s)
[379.066244] Starting dynamic subtest: C-eDP1
[383.694250] Dynamic subtest C-eDP1: SUCCESS (4.638s)
[383.704898] Starting dynamic subtest: D-eDP1
[388.332608] Dynamic subtest D-eDP1: SUCCESS (4.633s)
[388.334991] Subtest dpms-vs-vblank-race: SUCCESS (16.704s)
[389.198524] [065/133] (630s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[389.251404] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[389.357547] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[389.434680] [066/133] (630s left) syncobj_timeline (invalid-transfer-bad-pad)
[389.483785] Starting subtest: invalid-transfer-bad-pad
[389.486262] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[389.588142] [067/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[389.694269] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[396.317572] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.626s)
[396.464964] [068/133] (623s left) kms_color (ctm-max)
[396.557972] Starting subtest: ctm-max
[396.559983] Starting dynamic subtest: pipe-A-eDP-1
[397.270706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[397.280443] Starting dynamic subtest: pipe-B-eDP-1
[398.666800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[398.676616] Starting dynamic subtest: pipe-C-eDP-1
[400.007501] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.336s)
[400.018208] Starting dynamic subtest: pipe-D-eDP-1
[401.330487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[401.332657] Subtest ctm-max: SUCCESS (4.773s)
[402.131495] [069/133] (617s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[402.237400] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[402.241729] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[402.310616] [070/133] (617s left) gem_eio (hibernate)
[402.525980] Starting subtest: hibernate
[417.449444] Subtest hibernate: SUCCESS (14.921s)
[425.614234] [071/133] (602s left) gem_wait (write-wait)
[425.683811] Starting subtest: write-wait
[425.686290] Starting dynamic subtest: all-engines
[426.765347] Dynamic subtest all-engines: SUCCESS (1.081s)
[426.785584] Starting dynamic subtest: rcs0
[427.825836] Dynamic subtest rcs0: SUCCESS (1.058s)
[427.845417] Starting dynamic subtest: bcs0
[428.882630] Dynamic subtest bcs0: SUCCESS (1.055s)
[428.902083] Starting dynamic subtest: vcs0
[429.938096] Dynamic subtest vcs0: SUCCESS (1.052s)
[429.957045] Starting dynamic subtest: vcs1
[430.993721] Dynamic subtest vcs1: SUCCESS (1.054s)
[431.011922] Starting dynamic subtest: vecs0
[432.049227] Dynamic subtest vecs0: SUCCESS (1.053s)
[432.067835] Starting dynamic subtest: ccs0
[433.106756] Dynamic subtest ccs0: SUCCESS (1.055s)
[433.109949] Subtest write-wait: SUCCESS (7.424s)
[433.321698] [072/133] (594s left) kms_async_flips (async-flip-dpms)
[433.417607] Starting subtest: async-flip-dpms
[433.793069] Starting dynamic subtest: pipe-A-eDP-1
[437.643904] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.850s)
[438.023723] Starting dynamic subtest: pipe-B-eDP-1
[440.818322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.802s)
[441.214834] Starting dynamic subtest: pipe-C-eDP-1
[443.981694] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[444.361354] Starting dynamic subtest: pipe-D-eDP-1
[447.156080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.804s)
[447.158533] Subtest async-flip-dpms: SUCCESS (13.739s)
[448.331468] [073/133] (579s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[448.428041] Starting subtest: primary-yf-tiled-reflect-x-270
[448.432272] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[448.501405] [074/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[448.594722] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[448.599143] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[448.692690] [075/133] (579s left) gem_exec_fence (syncobj-invalid-flags)
[449.104120] Starting subtest: syncobj-invalid-flags
[449.106602] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[450.402239] [076/133] (577s left) perf (non-zero-reason)
[450.534168] Starting subtest: non-zero-reason
[450.536411] Starting dynamic subtest: 0-rcs0
[455.999436] Dynamic subtest 0-rcs0: SUCCESS (5.464s)
[456.016076] Starting dynamic subtest: 1-vecs0
[459.944695] Dynamic subtest 1-vecs0: SUCCESS (3.944s)
[459.947296] Subtest non-zero-reason: SUCCESS (9.410s)
[459.999078] [077/133] (568s left) i915_pm_freq_api (freq-basic-api)
[460.075493] Starting subtest: freq-basic-api
[460.077876] Starting dynamic subtest: gt0
[460.080394] Dynamic subtest gt0: SUCCESS (0.003s)
[460.091234] Starting dynamic subtest: gt1
[460.093487] Dynamic subtest gt1: SUCCESS (0.003s)
[460.095402] Subtest freq-basic-api: SUCCESS (0.008s)
[460.152435] [078/133] (568s left) gem_mmap_gtt (ptrace)
[460.220921] Subtest ptrace: SKIP (0.000s)
[460.282461] [079/133] (568s left) kms_pipe_crc_basic (suspend-read-crc)
[460.392869] Starting subtest: suspend-read-crc
[460.395178] Starting dynamic subtest: pipe-A-eDP-1
[477.780481] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.574s)
[477.796104] Starting dynamic subtest: pipe-B-eDP-1
[495.777078] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.114s)
[495.788004] Starting dynamic subtest: pipe-C-eDP-1
[513.781040] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.173s)
[513.794934] Starting dynamic subtest: pipe-D-eDP-1
[531.729997] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.021s)
[531.732387] Subtest suspend-read-crc: SUCCESS (11.891s)
[532.560845] [080/133] (495s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[532.676120] Starting subtest: 4-tiled-64bpp-rotate-90
[532.696463] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[532.819726] [081/133] (495s left) gem_partial_pwrite_pread (reads-uncached)
[532.881869] Subtest reads-uncached: SKIP (0.000s)
[532.951658] [082/133] (495s left) sysfs_heartbeat_interval (precise)
[533.004872] Starting subtest: precise
[533.007062] Starting dynamic subtest: vecs0
[540.715346] Dynamic subtest vecs0: SUCCESS (7.697s)
[540.729031] Starting dynamic subtest: ccs0
[541.822743] Dynamic subtest ccs0: SUCCESS (1.106s)
[541.834841] Starting dynamic subtest: vcs0
[549.734643] Dynamic subtest vcs0: SUCCESS (7.903s)
[549.746691] Starting dynamic subtest: bcs0
[550.860421] Dynamic subtest bcs0: SUCCESS (1.124s)
[550.873376] Starting dynamic subtest: rcs0
[551.953958] Dynamic subtest rcs0: SUCCESS (1.092s)
[551.967201] Starting dynamic subtest: vcs1
[558.695237] Dynamic subtest vcs1: SUCCESS (6.738s)
[558.697771] Subtest precise: SUCCESS (25.672s)
[558.790078] [083/133] (469s left) gem_ctx_exec (basic-close-race)
[558.860946] Starting subtest: basic-close-race
[564.590629] Subtest basic-close-race: SUCCESS (5.730s)
[564.740093] [084/133] (463s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[565.059654] Starting subtest: cursor-rapid-movement-max-size
[565.066150] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[565.186129] [085/133] (463s left) kms_psr (pr-no-drrs)
[565.273151] Starting subtest: pr-no-drrs
[565.277272] Subtest pr-no-drrs: SKIP (0.000s)
[565.361072] [086/133] (463s left) gem_userptr_blits (process-exit-busy)
[565.428602] Starting subtest: process-exit-busy
[565.440037] Subtest process-exit-busy: SUCCESS (0.012s)
[565.584722] [087/133] (463s left) gem_ctx_persistence (engines-mixed-process)
[565.642643] Starting subtest: engines-mixed-process
[565.644637] Starting dynamic subtest: rcs0
[567.709403] Dynamic subtest rcs0: SUCCESS (2.061s)
[567.722380] Starting dynamic subtest: bcs0
[569.710615] Dynamic subtest bcs0: SUCCESS (2.003s)
[569.722452] Starting dynamic subtest: vcs0
[571.772870] Dynamic subtest vcs0: SUCCESS (2.059s)
[571.789336] Starting dynamic subtest: vcs1
[573.756541] Dynamic subtest vcs1: SUCCESS (1.981s)
[573.770508] Starting dynamic subtest: vecs0
[575.709878] Dynamic subtest vecs0: SUCCESS (1.952s)
[575.723267] Starting dynamic subtest: ccs0
[577.709696] Dynamic subtest ccs0: SUCCESS (2.000s)
[577.712218] Subtest engines-mixed-process: SUCCESS (12.065s)
[577.793014] [088/133] (450s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[577.885505] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[577.889943] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[577.997720] [089/133] (450s left) kms_psr (psr-cursor-mmap-cpu)
[578.090791] Starting subtest: psr-cursor-mmap-cpu
[578.093077] Starting dynamic subtest: eDP-1
[579.769936] Dynamic subtest eDP-1: SUCCESS (1.679s)
[579.772304] Subtest psr-cursor-mmap-cpu: SUCCESS (1.680s)
[580.635244] [090/133] (448s left) gem_exec_schedule (preempt-self)
[580.713486] Starting subtest: preempt-self
[580.715555] Starting dynamic subtest: rcs0
[580.729316] Dynamic subtest rcs0: SUCCESS (0.023s)
[580.745282] Starting dynamic subtest: bcs0
[580.751581] Dynamic subtest bcs0: SUCCESS (0.020s)
[580.763446] Starting dynamic subtest: vcs0
[580.774881] Dynamic subtest vcs0: SUCCESS (0.022s)
[580.789608] Starting dynamic subtest: vcs1
[580.794427] Dynamic subtest vcs1: SUCCESS (0.019s)
[580.807667] Starting dynamic subtest: vecs0
[580.816130] Dynamic subtest vecs0: SUCCESS (0.021s)
[580.827830] Starting dynamic subtest: ccs0
[580.841182] Dynamic subtest ccs0: SUCCESS (0.024s)
[580.843441] Subtest preempt-self: SUCCESS (0.135s)
[582.789218] [091/133] (446s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[582.842917] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[582.953200] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[583.033352] [092/133] (445s left) kms_flip (flip-vs-absolute-wf_vblank)
[583.136182] Starting subtest: flip-vs-absolute-wf_vblank
[583.138589] Starting dynamic subtest: A-eDP1
[592.075528] Dynamic subtest A-eDP1: SUCCESS (8.938s)
[592.089286] Starting dynamic subtest: B-eDP1
[601.015855] Dynamic subtest B-eDP1: SUCCESS (8.938s)
[601.027652] Starting dynamic subtest: C-eDP1
[609.943222] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[609.955849] Starting dynamic subtest: D-eDP1
[618.871239] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[618.876267] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.733s)
[620.088506] [093/133] (408s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[620.192078] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[620.194381] Starting dynamic subtest: pipe-A
[621.330074] Dynamic subtest pipe-A: SUCCESS (1.140s)
[621.340977] Starting dynamic subtest: pipe-B
[623.574006] Dynamic subtest pipe-B: SUCCESS (2.242s)
[623.586306] Starting dynamic subtest: pipe-C
[624.792699] Dynamic subtest pipe-C: SUCCESS (1.217s)
[624.804483] Starting dynamic subtest: pipe-D
[626.020531] Dynamic subtest pipe-D: SUCCESS (1.227s)
[626.022921] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.829s)
[627.230438] [094/133] (401s left) sw_sync (sync_multi_consumer_producer)
[627.272128] Starting subtest: sync_multi_consumer_producer
[627.561540] Subtest sync_multi_consumer_producer: SUCCESS (0.291s)
[627.625178] [095/133] (401s left) gem_readwrite (write-bad-handle)
[627.682429] Subtest write-bad-handle: SKIP (0.000s)
[627.744473] [096/133] (401s left) kms_chamelium_color (ctm-limited-range)
[627.839756] Subtest ctm-limited-range: SKIP (0.000s)
[627.887170] [097/133] (401s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[627.984406] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[627.988550] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[628.078769] [098/133] (401s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[628.172133] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[628.174101] Starting dynamic subtest: pipe-A-eDP-1
[628.194403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[628.207673] Starting dynamic subtest: pipe-B-eDP-1
[628.227070] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[628.239021] Starting dynamic subtest: pipe-C-eDP-1
[628.258201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[628.269560] Starting dynamic subtest: pipe-D-eDP-1
[628.290040] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[628.292232] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[630.588037] [099/133] (398s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[630.970898] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[631.810761] [100/133] (397s left) kms_sequence (get-forked)
[631.906975] Starting subtest: get-forked
[631.909202] Starting dynamic subtest: pipe-A-eDP-1
[633.802676] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.893s)
[633.814708] Starting dynamic subtest: pipe-B-eDP-1
[636.373249] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.569s)
[636.388865] Starting dynamic subtest: pipe-C-eDP-1
[638.903336] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.528s)
[638.915800] Starting dynamic subtest: pipe-D-eDP-1
[641.423492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.520s)
[641.425406] Subtest get-forked: SUCCESS (9.516s)
[642.270013] [101/133] (387s left) gem_lmem_swapping (heavy-verify-multi)
[642.315716] Subtest heavy-verify-multi: SKIP (0.000s)
[642.367871] [102/133] (386s left) api_intel_bb (intel-bb-blit-y)
[642.423446] Starting subtest: intel-bb-blit-y
[646.132323] Subtest intel-bb-blit-y: SUCCESS (3.710s)
[646.244853] [103/133] (383s left) kms_cursor_crc (cursor-tearing-position-change)
[646.357518] Starting subtest: cursor-tearing-position-change
[646.359778] Starting dynamic subtest: pipe-A-eDP-1
[646.927778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[646.941706] Starting dynamic subtest: pipe-D-eDP-1
[648.202254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[648.205048] Subtest cursor-tearing-position-change: SUCCESS (1.845s)
[649.056369] [104/133] (380s left) i915_suspend (fence-restore-untiled)
[649.110135] Starting subtest: fence-restore-untiled
[649.114596] Subtest fence-restore-untiled: SKIP (0.000s)
[649.212106] [105/133] (380s left) kms_addfb_basic (addfb25-modifier-no-flag)
[649.300785] Starting subtest: addfb25-modifier-no-flag
[649.303072] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[649.404780] [106/133] (380s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[649.498337] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[649.502432] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[649.593202] [107/133] (379s left) kms_chamelium_hpd (vga-hpd)
[649.974121] Subtest vga-hpd: SKIP (0.000s)
[650.751200] [108/133] (378s left) drm_read (short-buffer-wakeup)
[650.888750] Starting subtest: short-buffer-wakeup
[683.101120] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[683.250668] [109/133] (346s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[683.347106] Starting subtest: y-tiled-32bpp-rotate-90
[683.351052] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[683.454063] [110/133] (346s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[683.554069] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[683.558129] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[683.650861] [111/133] (346s left) i915_drm_fdinfo (most-busy-check-all)
[683.693239] Starting subtest: most-busy-check-all
[683.695623] Starting dynamic subtest: rcs0
[683.700262] Dynamic subtest rcs0: SKIP (0.004s)
[683.713124] Starting dynamic subtest: bcs0
[683.717292] Dynamic subtest bcs0: SKIP (0.000s)
[683.729010] Starting dynamic subtest: vcs0
[683.732983] Dynamic subtest vcs0: SKIP (0.000s)
[683.743792] Starting dynamic subtest: vcs1
[683.747982] Dynamic subtest vcs1: SKIP (0.000s)
[683.759113] Starting dynamic subtest: vecs0
[683.763110] Dynamic subtest vecs0: SKIP (0.000s)
[683.774030] Starting dynamic subtest: ccs0
[683.778112] Dynamic subtest ccs0: SKIP (0.000s)
[683.782144] Subtest most-busy-check-all: SKIP (0.010s)
[683.823479] [112/133] (345s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[683.945645] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[690.777071] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.834s)
[690.905434] [113/133] (338s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[691.004031] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[691.008288] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[691.093278] [114/133] (338s left) perf (polling-small-buf)
[691.182933] Starting subtest: polling-small-buf
[691.273242] Subtest polling-small-buf: SUCCESS (0.088s)
[691.324202] [115/133] (338s left) kms_plane_multiple (tiling-x)
[691.412744] Starting subtest: tiling-x
[691.415079] Starting dynamic subtest: pipe-A-eDP-1
[695.144220] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.729s)
[695.156883] Starting dynamic subtest: pipe-B-eDP-1
[699.697742] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.552s)
[699.709989] Starting dynamic subtest: pipe-C-eDP-1
[704.041720] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s)
[704.053864] Starting dynamic subtest: pipe-D-eDP-1
[708.458159] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.418s)
[708.460468] Subtest tiling-x: SUCCESS (17.044s)
[709.269112] [116/133] (320s left) gen9_exec_parse (bb-start-cmd)
[709.330640] Subtest bb-start-cmd: SKIP (0.000s)
[709.405607] [117/133] (320s left) kms_cursor_crc (cursor-offscreen-512x512)
[709.697827] Starting subtest: cursor-offscreen-512x512
[709.702406] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[709.848883] [118/133] (320s left) gem_ctx_shared (create-shared-gtt)
[709.905374] Starting subtest: create-shared-gtt
[712.060477] Subtest create-shared-gtt: SUCCESS (2.154s)
[712.414099] [119/133] (317s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[712.515429] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[712.526907] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[712.607657] [120/133] (317s left) kms_dp_linktrain_fallback (dsc-fallback)
[712.692116] Starting subtest: dsc-fallback
[712.698432] Subtest dsc-fallback: SKIP (0.000s)
[712.779337] [121/133] (317s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[712.872476] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[712.874860] Starting dynamic subtest: pipe-A-eDP-1
[712.897982] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.912408] Starting dynamic subtest: pipe-B-eDP-1
[712.934033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.945702] Starting dynamic subtest: pipe-C-eDP-1
[712.967372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.978507] Starting dynamic subtest: pipe-D-eDP-1
[713.000218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[713.004542] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[715.124387] [122/133] (315s left) syncobj_wait (single-wait-all-submitted)
[715.187330] Starting subtest: single-wait-all-submitted
[715.288651] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[715.370683] [123/133] (314s left) kms_atomic (atomic-invalid-params)
[715.466668] Starting subtest: atomic-invalid-params
[715.468958] Starting dynamic subtest: pipe-A-eDP-1
[715.858743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s)
[715.861169] Subtest atomic-invalid-params: SUCCESS (0.392s)
[716.671799] [124/133] (313s left) perf_pmu (all-busy-check-all)
[716.708740] Starting subtest: all-busy-check-all
[718.766682] Subtest all-busy-check-all: SUCCESS (2.057s)
[718.876358] [125/133] (311s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[718.975343] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[718.980054] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[719.068970] [126/133] (311s left) kms_lease (lease-invalid-connector)
[719.161075] Starting subtest: lease-invalid-connector
[719.163395] Starting dynamic subtest: pipe-A-eDP-1
[719.165676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[719.178548] Starting dynamic subtest: pipe-B-eDP-1
[719.180843] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[719.192284] Starting dynamic subtest: pipe-C-eDP-1
[719.194209] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[719.205205] Starting dynamic subtest: pipe-D-eDP-1
[719.207112] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[719.208981] Subtest lease-invalid-connector: SUCCESS (0.004s)
[719.250858] [127/133] (311s left) gem_madvise (dontneed-after-mmap)
[719.281540] Starting subtest: dontneed-after-mmap
[719.311948] Subtest dontneed-after-mmap: SUCCESS (0.031s)
[719.414095] [128/133] (311s left) kms_flip (flip-vs-suspend-interruptible)
[719.505369] Starting subtest: flip-vs-suspend-interruptible
[719.507927] Starting dynamic subtest: A-eDP1
[864.860253] Dynamic subtest A-eDP1: SUCCESS (11.171s)
[864.864755] Subtest flip-vs-suspend-interruptible: SUCCESS (11.174s)
[865.003018] [129/133] (165s left) kms_vblank (wait-forked-busy)
[865.103276] Starting subtest: wait-forked-busy
[865.105433] Starting dynamic subtest: pipe-A-eDP-1
[866.991015] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[867.008433] Starting dynamic subtest: pipe-D-eDP-1
[869.566597] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s)
[869.568801] Subtest wait-forked-busy: SUCCESS (4.470s)
[870.369399] [130/133] (160s left) kms_big_fb (linear-32bpp-rotate-180)
[870.470747] Starting subtest: linear-32bpp-rotate-180
[871.992810] Subtest linear-32bpp-rotate-180: SUCCESS (1.523s)
[872.129134] [131/133] (158s left) gen3_render_tiledx_blits
[872.254598] [132/133] (158s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[872.346930] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[879.455364] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.115s)
[879.592995] [133/133] (151s left) kms_plane_scaling (planes-scaler-unity-scaling)
[879.695589] Starting subtest: planes-scaler-unity-scaling
[879.697871] Starting dynamic subtest: pipe-A
[879.758544] Dynamic subtest pipe-A: SUCCESS (0.065s)
[879.771906] Starting dynamic subtest: pipe-B
[880.901827] Dynamic subtest pipe-B: SUCCESS (1.142s)
[880.915751] Starting dynamic subtest: pipe-C
[882.021853] Dynamic subtest pipe-C: SUCCESS (1.119s)
[882.034696] Starting dynamic subtest: pipe-D
[883.142113] Dynamic subtest pipe-D: SUCCESS (1.120s)
[883.144433] Subtest planes-scaler-unity-scaling: SUCCESS (3.450s)
[884.328317] Closing watchdogs
results: parsing output: 0/ for test: gem_busy
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_fenced_exec_thrash
results: parsing output: 5/ for test: gem_tiled_fence_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_pm_backlight
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: gem_tiled_blits
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_joiner
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_ctx_shared
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_parallel
results: parsing output: 41/ for test: gem_readwrite
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: kms_prime
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_flink_basic
results: parsing output: 58/ for test: gem_tiled_swapping
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: i915_pm_freq_api
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: gem_ctx_exec
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_readwrite
results: parsing output: 95/ for test: kms_chamelium_color
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_sequence
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: i915_suspend
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_dp_linktrain_fallback
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: gem_madvise
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gen3_render_tiledx_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.