[57.209572] Initializing watchdogs
[57.209675]   /dev/watchdog0
[57.224635] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.229273] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.231692] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.235282] [001/133] (960s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[57.364006] Starting subtest: x-tiled-16bpp-rotate-0
[58.799557] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.400s)
[58.919255] [002/133] (958s left) kms_frontbuffer_tracking (fbc-suspend)
[59.025255] Starting subtest: fbc-suspend
[97.544540] Subtest fbc-suspend: SUCCESS (8.281s)
[98.771988] [003/133] (919s left) syncobj_wait (single-wait-all-signaled)
[98.846741] Starting subtest: single-wait-all-signaled
[98.849332] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[98.939994] [004/133] (918s left) kms_pwrite_crc
[100.509348] [005/133] (917s left) kms_big_fb (linear-64bpp-rotate-90)
[100.611983] Starting subtest: linear-64bpp-rotate-90
[100.630952] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[100.755946] [006/133] (917s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[100.879144] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[118.413348] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.412s)
[119.241975] [007/133] (898s left) i915_pm_rc6_residency (rc6-accuracy)
[119.298143] Starting subtest: rc6-accuracy
[119.300082] Starting dynamic subtest: gt0
[122.471300] Dynamic subtest gt0: SUCCESS (3.165s)
[122.482129] Starting dynamic subtest: gt1
[125.642708] Dynamic subtest gt1: SUCCESS (3.166s)
[125.645167] Subtest rc6-accuracy: SUCCESS (6.334s)
[125.733445] [008/133] (892s left) kms_cursor_crc (cursor-offscreen-256x85)
[125.999836] Starting subtest: cursor-offscreen-256x85
[126.051263] Subtest cursor-offscreen-256x85: SKIP (0.046s)
[126.219666] [009/133] (891s left) gem_exec_balancer (full-pulse)
[126.300330] Starting subtest: full-pulse
[131.165512] Subtest full-pulse: SUCCESS (4.868s)
[131.495941] [010/133] (886s left) gem_ringfill (legacy-basic)
[137.318735] Starting subtest: legacy-basic
[137.321354] Starting dynamic subtest: default
[137.380313] Dynamic subtest default: SUCCESS (0.062s)
[137.392239] Starting dynamic subtest: render
[137.422083] Dynamic subtest render: SUCCESS (0.041s)
[137.432107] Starting dynamic subtest: bsd
[137.466297] Dynamic subtest bsd: SUCCESS (0.042s)
[137.478252] Starting dynamic subtest: bsd1
[137.508223] Dynamic subtest bsd1: SUCCESS (0.040s)
[137.523055] Starting dynamic subtest: bsd2
[137.548162] Dynamic subtest bsd2: SUCCESS (0.038s)
[137.557713] Starting dynamic subtest: blt
[137.593334] Dynamic subtest blt: SUCCESS (0.043s)
[137.603696] Starting dynamic subtest: vebox
[137.635328] Dynamic subtest vebox: SUCCESS (0.041s)
[137.637561] Subtest legacy-basic: SUCCESS (0.319s)
[137.710053] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[137.713352] [011/133] (880s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[137.811081] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[137.813471] Starting dynamic subtest: pipe-A-eDP-1
[137.837125] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[137.846341] Starting dynamic subtest: pipe-B-eDP-1
[137.868300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[137.878516] Starting dynamic subtest: pipe-C-eDP-1
[137.899375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[137.908020] Starting dynamic subtest: pipe-D-eDP-1
[137.929890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[137.933938] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[140.062234] [012/133] (878s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[140.162491] Starting subtest: flip-primary-invalidate-overlay
[151.782897] Subtest flip-primary-invalidate-overlay: SUCCESS (11.623s)
[151.933171] [013/133] (866s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[152.029531] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[152.033063] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[152.120835] [014/133] (866s left) prime_mmap (test_correct_cpu_write)
[152.165319] Starting subtest: test_correct_cpu_write
[152.167129] Starting dynamic subtest: test_correct_cpu_write-smem
[152.168963] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[152.170771] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[152.251957] [015/133] (866s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[152.342055] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[159.306156] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.963s)
[159.434093] [016/133] (858s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[159.554415] Starting subtest: basic-busy-flip-before-cursor-varying-size
[159.559041] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[159.697654] [017/133] (858s left) gen9_exec_parse (unaligned-access)
[159.756108] Subtest unaligned-access: SKIP (0.000s)
[159.826861] [018/133] (858s left) gem_huc_copy (huc-copy)
[159.880312] Starting subtest: huc-copy
[159.884973] Subtest huc-copy: SUCCESS (0.004s)
[159.993494] [019/133] (858s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[160.087671] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[160.733868] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[160.897410] [020/133] (857s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[160.995802] Starting subtest: pr-overlay-plane-move-continuous-sf
[161.000239] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[161.072010] [021/133] (857s left) gem_ctx_persistence (engines-queued)
[161.134330] Starting subtest: engines-queued
[161.136615] Starting dynamic subtest: rcs0
[161.221029] Dynamic subtest rcs0: SUCCESS (0.086s)
[161.233832] Starting dynamic subtest: bcs0
[161.249844] Dynamic subtest bcs0: SUCCESS (0.028s)
[161.258588] Starting dynamic subtest: vcs0
[163.330669] Dynamic subtest vcs0: SUCCESS (2.078s)
[163.343982] Starting dynamic subtest: vcs1
[165.311856] Dynamic subtest vcs1: SUCCESS (1.979s)
[165.325584] Starting dynamic subtest: vecs0
[167.295701] Dynamic subtest vecs0: SUCCESS (1.981s)
[167.308303] Starting dynamic subtest: ccs0
[167.478367] Dynamic subtest ccs0: SUCCESS (0.183s)
[167.480839] Subtest engines-queued: SUCCESS (6.344s)
[167.600550] [022/133] (850s left) syncobj_wait (invalid-wait-bad-flags)
[167.673486] Starting subtest: invalid-wait-bad-flags
[167.675811] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[167.778105] [023/133] (850s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[167.874923] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[167.877234] Starting dynamic subtest: pipe-A-eDP-1
[167.886327] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.897228] Starting dynamic subtest: pipe-B-eDP-1
[167.906159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.915323] Starting dynamic subtest: pipe-C-eDP-1
[167.924241] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.933083] Starting dynamic subtest: pipe-D-eDP-1
[167.941693] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.946012] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[170.052404] [024/133] (848s left) gem_exec_fence (submit3)
[170.233786] Starting subtest: submit3
[170.238395] Subtest submit3: SKIP (0.000s)
[172.421894] [025/133] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[172.522835] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[172.527355] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[172.620927] [026/133] (846s left) kms_cdclk (mode-transition-all-outputs)
[172.726247] Starting subtest: mode-transition-all-outputs
[173.013810] Subtest mode-transition-all-outputs: SKIP (0.285s)
[173.886789] [027/133] (844s left) kms_plane (plane-panning-bottom-right-suspend)
[173.975716] Starting subtest: plane-panning-bottom-right-suspend
[173.978148] Starting dynamic subtest: pipe-A
[191.397457] Dynamic subtest pipe-A: SUCCESS (2.850s)
[191.407207] Starting dynamic subtest: pipe-B
[209.430004] Dynamic subtest pipe-B: SUCCESS (3.477s)
[209.432429] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.330s)
[210.338532] [028/133] (808s left) kms_psr (fbc-psr-primary-mmap-gtt)
[210.438673] Starting subtest: fbc-psr-primary-mmap-gtt
[210.440584] Starting dynamic subtest: eDP-1
[210.444564] Dynamic subtest eDP-1: SKIP (0.000s)
[210.448619] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[210.510465] [029/133] (808s left) kms_atomic (atomic-invalid-params)
[210.604747] Starting subtest: atomic-invalid-params
[210.607132] Starting dynamic subtest: pipe-A-eDP-1
[211.027035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[211.029015] Subtest atomic-invalid-params: SUCCESS (0.411s)
[211.919781] [030/133] (807s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[211.991457] Starting subtest: multi-wait-all-for-submit-submitted
[212.097143] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[212.186970] [031/133] (806s left) kms_psr (pr-dpms)
[212.273248] Starting subtest: pr-dpms
[212.277536] Subtest pr-dpms: SKIP (0.000s)
[212.350481] [032/133] (806s left) kms_vblank (invalid)
[212.432808] Starting subtest: invalid
[212.434747] Starting dynamic subtest: pipe-A-eDP-1
[212.842687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[212.845235] Subtest invalid: SUCCESS (0.403s)
[213.698951] [033/133] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[213.804519] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[221.103707] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.209s)
[221.243967] [034/133] (797s left) perf_pmu (interrupts)
[221.293300] Starting subtest: interrupts
[222.360659] Subtest interrupts: SUCCESS (1.059s)
[222.470023] [035/133] (796s left) perf_pmu (semaphore-wait)
[222.511011] Starting subtest: semaphore-wait
[222.513300] Starting dynamic subtest: rcs0
[223.027157] Dynamic subtest rcs0: SUCCESS (0.512s)
[223.039616] Starting dynamic subtest: bcs0
[223.543637] Dynamic subtest bcs0: SUCCESS (0.511s)
[223.554039] Starting dynamic subtest: vcs0
[224.061275] Dynamic subtest vcs0: SUCCESS (0.512s)
[224.075621] Starting dynamic subtest: vcs1
[224.579085] Dynamic subtest vcs1: SUCCESS (0.512s)
[224.593010] Starting dynamic subtest: vecs0
[225.095415] Dynamic subtest vecs0: SUCCESS (0.511s)
[225.113065] Starting dynamic subtest: ccs0
[225.613909] Dynamic subtest ccs0: SUCCESS (0.513s)
[225.616622] Subtest semaphore-wait: SUCCESS (3.085s)
[225.733487] [036/133] (793s left) gem_eio (in-flight-immediate)
[225.953159] Starting subtest: in-flight-immediate
[233.762821] Subtest in-flight-immediate: SUCCESS (7.786s)
[233.879602] [037/133] (785s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[233.968440] Starting subtest: psr-rgb565-draw-mmap-gtt
[233.971917] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[234.072131] [038/133] (785s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[234.136613] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[234.138680] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[234.258358] [039/133] (785s left) gem_exec_parallel (fds)
[234.316190] Starting subtest: fds
[234.318074] Starting dynamic subtest: rcs0
[237.799955] Dynamic subtest rcs0: SUCCESS (3.476s)
[237.812376] Starting dynamic subtest: bcs0
[241.827798] Dynamic subtest bcs0: SUCCESS (4.023s)
[241.838231] Starting dynamic subtest: vcs0
[245.698830] Dynamic subtest vcs0: SUCCESS (3.871s)
[245.710786] Starting dynamic subtest: vcs1
[249.648006] Dynamic subtest vcs1: SUCCESS (3.953s)
[249.658396] Starting dynamic subtest: vecs0
[253.695808] Dynamic subtest vecs0: SUCCESS (4.048s)
[253.707341] Starting dynamic subtest: ccs0
[258.139749] Dynamic subtest ccs0: SUCCESS (4.443s)
[258.142823] Subtest fds: SUCCESS (23.824s)
[258.328597] [040/133] (761s left) syncobj_wait (invalid-wait-illegal-handle)
[258.383952] Starting subtest: invalid-wait-illegal-handle
[258.386362] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[258.485179] [041/133] (760s left) gem_exec_schedule (u-semaphore-user)
[258.568213] Starting subtest: u-semaphore-user
[258.622687] Subtest u-semaphore-user: SUCCESS (0.062s)
[260.390749] [042/133] (759s left) fbdev (read)
[260.440959] Starting subtest: read
[260.970607] Subtest read: SUCCESS (0.527s)
[261.034541] [043/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[261.134385] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[265.576895] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.446s)
[266.714386] [044/133] (752s left) kms_flip (wf_vblank-ts-check)
[266.804755] Starting subtest: wf_vblank-ts-check
[266.806960] Starting dynamic subtest: A-eDP1
[275.725827] Dynamic subtest A-eDP1: SUCCESS (8.922s)
[275.738183] Starting dynamic subtest: B-eDP1
[284.659507] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[284.669497] Starting dynamic subtest: C-eDP1
[293.578360] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[293.590240] Starting dynamic subtest: D-eDP1
[302.508501] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[302.513234] Subtest wf_vblank-ts-check: SUCCESS (35.707s)
[303.741435] [045/133] (715s left) kms_async_flips (async-flip-dpms)
[303.831605] Starting subtest: async-flip-dpms
[304.202160] Starting dynamic subtest: pipe-A-eDP-1
[308.062596] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.859s)
[308.445091] Starting dynamic subtest: pipe-B-eDP-1
[311.234580] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.798s)
[311.609158] Starting dynamic subtest: pipe-C-eDP-1
[314.399768] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.797s)
[314.777333] Starting dynamic subtest: pipe-D-eDP-1
[317.571678] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[317.573993] Subtest async-flip-dpms: SUCCESS (13.742s)
[318.756818] [046/133] (700s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[318.816389] Starting subtest: single-wait-all-for-submit-unsubmitted
[318.920404] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[318.997484] [047/133] (700s left) gem_linear_blits (normal)
[319.706473] Starting subtest: normal
[323.597690] Subtest normal: SUCCESS (3.890s)
[323.973599] [048/133] (695s left) gem_exec_store (cachelines)
[324.084471] Starting subtest: cachelines
[324.086817] Starting dynamic subtest: rcs0
[324.181235] Dynamic subtest rcs0: SUCCESS (0.098s)
[324.194422] Starting dynamic subtest: bcs0
[324.244568] Dynamic subtest bcs0: SUCCESS (0.061s)
[324.257089] Starting dynamic subtest: vcs0
[324.306634] Dynamic subtest vcs0: SUCCESS (0.060s)
[324.319896] Starting dynamic subtest: vcs1
[324.361031] Dynamic subtest vcs1: SUCCESS (0.052s)
[324.372996] Starting dynamic subtest: vecs0
[324.416034] Dynamic subtest vecs0: SUCCESS (0.053s)
[324.427201] Starting dynamic subtest: ccs0
[324.471416] Dynamic subtest ccs0: SUCCESS (0.054s)
[324.473774] Subtest cachelines: SUCCESS (0.389s)
[324.653335] [049/133] (695s left) kms_psr (fbc-pr-sprite-blt)
[324.767144] Starting subtest: fbc-pr-sprite-blt
[324.771457] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[324.840284] [050/133] (694s left) kms_pm_lpsp (screens-disabled)
[325.931502] Starting subtest: screens-disabled
[325.935912] Subtest screens-disabled: SKIP (0.000s)
[326.017464] [051/133] (693s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[326.118833] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[326.798405] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[326.970255] [052/133] (692s left) syncobj_basic (bad-flags-fd-to-handle)
[327.028650] Starting subtest: bad-flags-fd-to-handle
[327.030841] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[327.138292] [053/133] (692s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[327.262788] Starting subtest: cursorB-vs-flipB-toggle
[327.267384] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[327.411246] [054/133] (692s left) gem_userptr_blits (relocations)
[327.484021] Starting subtest: relocations
[327.488398] Subtest relocations: SKIP (0.000s)
[327.626544] [055/133] (692s left) syncobj_wait (invalid-reset-bad-pad)
[327.687954] Starting subtest: invalid-reset-bad-pad
[327.690374] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[327.795648] [056/133] (692s left) gem_eio (kms)
[328.084544] Starting subtest: kms
[347.818905] Subtest kms: SUCCESS (19.729s)
[349.010215] [057/133] (671s left) i915_suspend (basic-s2idle-without-i915)
[349.049931] Starting subtest: basic-s2idle-without-i915
[369.495848] Subtest basic-s2idle-without-i915: SUCCESS (5.634s)
[369.621825] [058/133] (650s left) kms_prop_blob (invalid-set-prop-any)
[369.699324] Starting subtest: invalid-set-prop-any
[369.701611] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[369.818817] [059/133] (650s left) prime_vgem (basic-read)
[369.899769] Starting subtest: basic-read
[369.907899] Subtest basic-read: SKIP (0.006s)
[370.006068] [060/133] (650s left) kms_vblank (wait-idle)
[370.111977] Starting subtest: wait-idle
[370.113918] Starting dynamic subtest: pipe-A-eDP-1
[371.938722] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.779s)
[371.953821] Starting dynamic subtest: pipe-D-eDP-1
[374.444673] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.454s)
[374.447238] Subtest wait-idle: SUCCESS (4.237s)
[375.286660] [061/133] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[375.387843] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[375.392055] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[375.488920] [062/133] (644s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[375.592251] Starting subtest: fbcpsr-rgb565-draw-pwrite
[382.704646] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.048s)
[382.832943] [063/133] (637s left) kms_pipe_crc_basic (nonblocking-crc)
[382.922164] Starting subtest: nonblocking-crc
[382.924443] Starting dynamic subtest: pipe-A-eDP-1
[383.701420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s)
[383.710596] Starting dynamic subtest: pipe-B-eDP-1
[385.093155] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[385.103103] Starting dynamic subtest: pipe-C-eDP-1
[386.507376] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.407s)
[386.518259] Starting dynamic subtest: pipe-D-eDP-1
[387.833068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[387.835495] Subtest nonblocking-crc: SUCCESS (4.892s)
[388.639351] [064/133] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[388.741822] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[393.158547] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.410s)
[394.348705] [065/133] (626s left) kms_flip (basic-plain-flip)
[394.456544] Starting subtest: basic-plain-flip
[394.459155] Starting dynamic subtest: A-eDP1
[396.142419] Dynamic subtest A-eDP1: SUCCESS (1.685s)
[396.154084] Starting dynamic subtest: B-eDP1
[397.779291] Dynamic subtest B-eDP1: SUCCESS (1.634s)
[397.791034] Starting dynamic subtest: C-eDP1
[399.402101] Dynamic subtest C-eDP1: SUCCESS (1.619s)
[399.413166] Starting dynamic subtest: D-eDP1
[401.040828] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[401.043227] Subtest basic-plain-flip: SUCCESS (6.582s)
[402.210839] [066/133] (618s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[402.323544] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[402.325780] Starting dynamic subtest: pipe-A-eDP-1
[402.379724] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[402.390415] Starting dynamic subtest: pipe-B-eDP-1
[402.444177] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[402.455307] Starting dynamic subtest: pipe-C-eDP-1
[402.511075] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[402.520790] Starting dynamic subtest: pipe-D-eDP-1
[402.577362] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[402.581310] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[404.489167] [067/133] (616s left) gem_wait (wait)
[404.547270] Starting subtest: wait
[404.549539] Starting dynamic subtest: all-engines
[406.128603] Dynamic subtest all-engines: SUCCESS (1.578s)
[406.140447] Starting dynamic subtest: rcs0
[407.176055] Dynamic subtest rcs0: SUCCESS (1.045s)
[407.190728] Starting dynamic subtest: bcs0
[408.225809] Dynamic subtest bcs0: SUCCESS (1.046s)
[408.237471] Starting dynamic subtest: vcs0
[409.272621] Dynamic subtest vcs0: SUCCESS (1.044s)
[409.284298] Starting dynamic subtest: vcs1
[410.317912] Dynamic subtest vcs1: SUCCESS (1.042s)
[410.332264] Starting dynamic subtest: vecs0
[411.364920] Dynamic subtest vecs0: SUCCESS (1.044s)
[411.376804] Starting dynamic subtest: ccs0
[412.412887] Dynamic subtest ccs0: SUCCESS (1.045s)
[412.415314] Subtest wait: SUCCESS (7.861s)
[412.631307] [068/133] (607s left) kms_getfb (getfb2-handle-protection)
[412.729571] Starting subtest: getfb2-handle-protection
[412.743761] Subtest getfb2-handle-protection: SUCCESS (0.015s)
[412.865041] [069/133] (607s left) gem_pxp (fail-invalid-protected-context)
[412.985924] Starting subtest: fail-invalid-protected-context
[412.988246] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[413.097478] [070/133] (607s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[413.200090] Starting subtest: y-tiled-64bpp-rotate-270
[413.204347] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[413.294693] [071/133] (607s left) gem_media_vme
[413.431544] [072/133] (607s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[413.519347] Starting subtest: primary-y-tiled-reflect-x-90
[413.523676] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[413.589691] [073/133] (607s left) perf_pmu (multi-client)
[413.628499] Starting subtest: multi-client
[413.630292] Starting dynamic subtest: rcs0
[414.679067] Dynamic subtest rcs0: SUCCESS (1.047s)
[414.691562] Starting dynamic subtest: bcs0
[415.731281] Dynamic subtest bcs0: SUCCESS (1.048s)
[415.743770] Starting dynamic subtest: vcs0
[416.783411] Dynamic subtest vcs0: SUCCESS (1.048s)
[416.796003] Starting dynamic subtest: vcs1
[418.166443] Dynamic subtest vcs1: SUCCESS (1.365s)
[418.179952] Starting dynamic subtest: vecs0
[420.137075] Dynamic subtest vecs0: SUCCESS (1.981s)
[420.147230] Starting dynamic subtest: ccs0
[422.184055] Dynamic subtest ccs0: SUCCESS (2.043s)
[422.186709] Subtest multi-client: SUCCESS (8.550s)
[422.300211] [074/133] (598s left) kms_display_modes (extended-mode-basic)
[422.397339] Starting subtest: extended-mode-basic
[422.401231] Subtest extended-mode-basic: SKIP (0.000s)
[422.443022] [075/133] (598s left) kms_cursor_crc (cursor-random-32x32)
[422.590023] Starting subtest: cursor-random-32x32
[422.634793] Subtest cursor-random-32x32: SKIP (0.041s)
[422.902746] [076/133] (597s left) kms_prime (basic-crc-hybrid)
[422.980649] Subtest basic-crc-hybrid: SKIP (0.000s)
[423.081491] [077/133] (597s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[423.173735] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[423.175960] Starting dynamic subtest: pipe-A-default-mode
[424.385796] Dynamic subtest pipe-A-default-mode: SKIP (1.208s)
[424.390578] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.210s)
[424.525521] [078/133] (596s left) kms_lease (lease-uevent)
[424.632679] Starting subtest: lease-uevent
[425.649534] Subtest lease-uevent: SUCCESS (1.017s)
[425.769484] [079/133] (595s left) syncobj_timeline (wait-all-delayed-signal)
[425.837061] Starting subtest: wait-all-delayed-signal
[425.940147] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[426.019248] [080/133] (595s left) kms_chamelium_frames (hdmi-crc-fast)
[426.404316] Subtest hdmi-crc-fast: SKIP (0.000s)
[427.254612] [081/133] (593s left) kms_flip (2x-flip-vs-expired-vblank)
[427.350007] Starting subtest: 2x-flip-vs-expired-vblank
[427.361614] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[427.457155] [082/133] (593s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[427.555678] Starting subtest: psr-1p-primscrn-cur-indfb-move
[434.941700] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.384s)
[435.090407] [083/133] (586s left) i915_hangman (engine-engine-hang)
[435.152910] Starting subtest: engine-engine-hang
[435.154725] Starting dynamic subtest: rcs0
[437.138286] Dynamic subtest rcs0: SUCCESS (1.983s)
[437.149774] Starting dynamic subtest: bcs0
[439.058455] Dynamic subtest bcs0: SUCCESS (1.916s)
[439.074758] Starting dynamic subtest: vcs0
[441.103486] Dynamic subtest vcs0: SUCCESS (2.041s)
[441.120357] Starting dynamic subtest: vcs1
[443.024120] Dynamic subtest vcs1: SUCCESS (1.916s)
[443.036983] Starting dynamic subtest: vecs0
[444.111657] Dynamic subtest vecs0: SUCCESS (1.084s)
[444.125400] Starting dynamic subtest: ccs0
[446.096834] Dynamic subtest ccs0: SUCCESS (1.981s)
[446.099706] Subtest engine-engine-hang: SUCCESS (10.939s)
[446.180294] [084/133] (575s left) gem_ctx_persistence (legacy-engines-cleanup)
[446.242944] Starting subtest: legacy-engines-cleanup
[446.245358] Starting dynamic subtest: render
[446.334534] Dynamic subtest render: SUCCESS (0.091s)
[446.349686] Starting dynamic subtest: bsd1
[446.379193] Dynamic subtest bsd1: SUCCESS (0.042s)
[446.392507] Starting dynamic subtest: bsd2
[446.405929] Dynamic subtest bsd2: SUCCESS (0.024s)
[446.414865] Starting dynamic subtest: blt
[446.484079] Dynamic subtest blt: SUCCESS (0.077s)
[446.497782] Starting dynamic subtest: vebox
[446.538315] Dynamic subtest vebox: SUCCESS (0.051s)
[446.540937] Subtest legacy-engines-cleanup: SUCCESS (0.296s)
[446.635366] [085/133] (574s left) kms_rotation_crc (cursor-rotation-180)
[446.736556] Starting subtest: cursor-rotation-180
[448.287229] Subtest cursor-rotation-180: SUCCESS (1.551s)
[449.482226] [086/133] (571s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[449.549572] Starting subtest: yf-tiled-ccs-to-x-tiled
[449.554207] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[449.735874] [087/133] (571s left) gem_pread (uncached)
[449.800108] Subtest uncached: SKIP (0.000s)
[449.860121] [088/133] (571s left) kms_flip (busy-flip)
[449.959499] Starting subtest: busy-flip
[449.961818] Starting dynamic subtest: A-eDP1
[451.701962] Dynamic subtest A-eDP1: SUCCESS (1.744s)
[451.712578] Starting dynamic subtest: B-eDP1
[453.334485] Dynamic subtest B-eDP1: SUCCESS (1.629s)
[453.349068] Starting dynamic subtest: C-eDP1
[455.059048] Dynamic subtest C-eDP1: SUCCESS (1.721s)
[455.071054] Starting dynamic subtest: D-eDP1
[456.693514] Dynamic subtest D-eDP1: SUCCESS (1.633s)
[456.698416] Subtest busy-flip: SUCCESS (6.739s)
[457.870029] [089/133] (563s left) gem_create (create-ext-placement-each)
[458.048653] Starting subtest: create-ext-placement-each
[458.051473] Subtest create-ext-placement-each: SUCCESS (0.000s)
[458.159295] [090/133] (563s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[458.246593] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[458.248902] Starting dynamic subtest: pipe-A-eDP-1
[458.270672] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[458.282683] Starting dynamic subtest: pipe-B-eDP-1
[458.303806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[458.312708] Starting dynamic subtest: pipe-C-eDP-1
[458.333579] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[458.342137] Starting dynamic subtest: pipe-D-eDP-1
[458.363754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[458.367964] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[460.515614] [091/133] (560s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[460.613211] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[460.617338] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[460.740049] [092/133] (560s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[460.833253] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[460.837272] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[460.929013] [093/133] (560s left) kms_color (ctm-0-50)
[461.026924] Starting subtest: ctm-0-50
[461.029054] Starting dynamic subtest: pipe-A-eDP-1
[464.518557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[464.528294] Starting dynamic subtest: pipe-B-eDP-1
[468.623641] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.105s)
[468.633687] Starting dynamic subtest: pipe-C-eDP-1
[472.581976] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.960s)
[472.593006] Starting dynamic subtest: pipe-D-eDP-1
[476.602697] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.022s)
[476.605116] Subtest ctm-0-50: SUCCESS (15.582s)
[477.437899] [094/133] (544s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[477.531676] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[477.534030] Starting dynamic subtest: pipe-A
[477.594499] Dynamic subtest pipe-A: SUCCESS (0.065s)
[477.609717] Starting dynamic subtest: pipe-B
[478.751542] Dynamic subtest pipe-B: SUCCESS (1.156s)
[478.763405] Starting dynamic subtest: pipe-C
[479.859550] Dynamic subtest pipe-C: SUCCESS (1.106s)
[479.870685] Starting dynamic subtest: pipe-D
[480.980288] Dynamic subtest pipe-D: SUCCESS (1.120s)
[480.982585] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.452s)
[482.135739] [095/133] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[482.238181] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[488.809518] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.575s)
[488.922765] [096/133] (532s left) sw_sync (timeline_closed)
[488.961278] Starting subtest: timeline_closed
[488.963440] Subtest timeline_closed: SUCCESS (0.000s)
[489.020451] [097/133] (532s left) kms_chamelium_hpd (vga-hpd-fast)
[489.411761] Subtest vga-hpd-fast: SKIP (0.000s)
[490.191713] [098/133] (531s left) gem_mmap_offset (close-race)
[490.246247] Starting subtest: close-race
[510.353671] Subtest close-race: SUCCESS (20.105s)
[510.505515] [099/133] (511s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[510.610100] Starting subtest: fbc-1p-pri-indfb-multidraw
[523.503066] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.894s)
[524.840761] [100/133] (497s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[524.930469] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[524.934962] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[525.027301] [101/133] (496s left) gem_exec_flush (basic-wb-rw-default)
[525.086282] Starting subtest: basic-wb-rw-default
[530.541331] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[530.727693] [102/133] (491s left) kms_vrr (lobf)
[530.836427] Starting subtest: lobf
[530.840350] Subtest lobf: SKIP (0.000s)
[530.908981] [103/133] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[531.006320] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[531.010469] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[531.118310] [104/133] (490s left) api_intel_bb (simple-bb)
[531.170220] Starting subtest: simple-bb
[531.172867] Subtest simple-bb: SUCCESS (0.006s)
[531.287353] [105/133] (490s left) kms_feature_discovery (display-3x)
[531.380879] Starting subtest: display-3x
[531.384826] Subtest display-3x: SKIP (0.000s)
[531.464063] [106/133] (490s left) kms_plane_multiple (tiling-4)
[531.562872] Starting subtest: tiling-4
[531.565031] Starting dynamic subtest: pipe-A-eDP-1
[535.377990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.813s)
[535.391903] Starting dynamic subtest: pipe-B-eDP-1
[539.944127] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.564s)
[539.954877] Starting dynamic subtest: pipe-C-eDP-1
[544.341041] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.395s)
[544.350981] Starting dynamic subtest: pipe-D-eDP-1
[548.669571] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.327s)
[548.672008] Subtest tiling-4: SUCCESS (17.104s)
[549.482765] [107/133] (472s left) kms_content_protection (atomic-dpms-hdcp14)
[549.621256] Starting subtest: atomic-dpms-hdcp14
[549.625664] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[549.739121] [108/133] (472s left) api_intel_allocator (reserve-simple)
[549.797154] Starting subtest: reserve-simple
[549.799395] Subtest reserve-simple: SUCCESS (0.003s)
[549.912837] [109/133] (472s left) vgem_basic (dmabuf-export)
[549.951752] Starting subtest: dmabuf-export
[549.996141] Subtest dmabuf-export: SUCCESS (0.047s)
[550.115333] [110/133] (472s left) gen9_exec_parse (bb-start-param)
[550.178913] Subtest bb-start-param: SKIP (0.000s)
[550.239833] [111/133] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[550.344887] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[550.349133] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[550.449154] [112/133] (471s left) kms_joiner (invalid-modeset-force-big-joiner)
[550.540791] Starting subtest: invalid-modeset-force-big-joiner
[550.544120] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[550.608589] [113/133] (471s left) gem_spin_batch (resubmit-new)
[550.671368] Starting subtest: resubmit-new
[550.673262] Starting dynamic subtest: rcs0
[550.680196] Dynamic subtest rcs0: SUCCESS (0.011s)
[550.689568] Starting dynamic subtest: bcs0
[550.691483] Dynamic subtest bcs0: SUCCESS (0.004s)
[550.700554] Starting dynamic subtest: vcs0
[550.702544] Dynamic subtest vcs0: SUCCESS (0.004s)
[550.711555] Starting dynamic subtest: vcs1
[550.713387] Dynamic subtest vcs1: SUCCESS (0.005s)
[550.721896] Starting dynamic subtest: vecs0
[550.723658] Dynamic subtest vecs0: SUCCESS (0.006s)
[550.732333] Starting dynamic subtest: ccs0
[550.734133] Dynamic subtest ccs0: SUCCESS (0.005s)
[550.735908] Subtest resubmit-new: SUCCESS (0.039s)
[552.156882] [114/133] (470s left) dmabuf_sync_file (export-before-signal)
[552.206669] Starting subtest: export-before-signal
[552.208850] Subtest export-before-signal: SUCCESS (0.001s)
[552.269575] [115/133] (470s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[552.327692] Starting subtest: multi-wait-all-available-submitted-signaled
[552.329945] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[552.421957] [116/133] (470s left) syncobj_wait (invalid-signal-zero-handles)
[552.478100] Starting subtest: invalid-signal-zero-handles
[552.480073] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[552.575204] [117/133] (470s left) kms_psr (fbc-pr-cursor-plane-move)
[552.669434] Starting subtest: fbc-pr-cursor-plane-move
[552.673728] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[552.740598] [118/133] (469s left) gem_exec_gttfill (multigpu-basic)
[552.909612] Starting subtest: multigpu-basic
[566.241862] Subtest multigpu-basic: SUCCESS (13.328s)
[566.327197] [119/133] (456s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[566.471432] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[566.475786] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[566.542387] [120/133] (456s left) kms_psr (psr2-sprite-blt)
[566.637546] Starting subtest: psr2-sprite-blt
[566.639757] Starting dynamic subtest: eDP-1
[568.386407] Dynamic subtest eDP-1: SUCCESS (1.748s)
[568.388615] Subtest psr2-sprite-blt: SUCCESS (1.749s)
[569.254477] [121/133] (453s left) gem_exec_balancer (parallel-keep-submit-fence)
[569.516232] Starting subtest: parallel-keep-submit-fence
[570.670453] Subtest parallel-keep-submit-fence: SUCCESS (1.154s)
[570.770420] [122/133] (452s left) gem_exec_parallel (basic)
[570.827698] Starting subtest: basic
[570.829936] Starting dynamic subtest: rcs0
[572.331047] Dynamic subtest rcs0: SUCCESS (1.502s)
[572.343789] Starting dynamic subtest: bcs0
[573.805279] Dynamic subtest bcs0: SUCCESS (1.471s)
[573.815743] Starting dynamic subtest: vcs0
[575.198659] Dynamic subtest vcs0: SUCCESS (1.391s)
[575.211384] Starting dynamic subtest: vcs1
[577.073772] Dynamic subtest vcs1: SUCCESS (1.872s)
[577.086169] Starting dynamic subtest: vecs0
[579.121089] Dynamic subtest vecs0: SUCCESS (2.044s)
[579.132396] Starting dynamic subtest: ccs0
[580.614335] Dynamic subtest ccs0: SUCCESS (1.492s)
[580.616868] Subtest basic: SUCCESS (9.785s)
[580.802502] [123/133] (442s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[580.862232] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[580.965665] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[581.045553] [124/133] (441s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[581.143906] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[581.147898] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[581.266483] [125/133] (441s left) gem_exec_schedule (implicit-write-read)
[581.334999] Starting subtest: implicit-write-read
[581.337159] Starting dynamic subtest: rcs0
[581.445462] Dynamic subtest rcs0: SUCCESS (0.116s)
[581.458183] Starting dynamic subtest: vcs0
[581.522293] Dynamic subtest vcs0: SUCCESS (0.077s)
[581.534987] Starting dynamic subtest: vcs1
[581.612092] Dynamic subtest vcs1: SUCCESS (0.089s)
[581.624633] Starting dynamic subtest: vecs0
[581.691386] Dynamic subtest vecs0: SUCCESS (0.078s)
[581.703569] Starting dynamic subtest: ccs0
[581.775501] Dynamic subtest ccs0: SUCCESS (0.083s)
[581.778423] Subtest implicit-write-read: SUCCESS (0.447s)
[583.237788] [126/133] (439s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[583.336438] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[583.340709] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[583.444288] [127/133] (439s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[583.509585] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[583.614287] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[583.705923] [128/133] (439s left) kms_cursor_crc (cursor-size-change)
[583.797037] Starting subtest: cursor-size-change
[583.799242] Starting dynamic subtest: pipe-A-eDP-1
[584.626773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[584.638703] Starting dynamic subtest: pipe-D-eDP-1
[586.126280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[586.128121] Subtest cursor-size-change: SUCCESS (2.328s)
[587.014692] [129/133] (436s left) sysfs_heartbeat_interval (nopreempt)
[587.073775] Starting subtest: nopreempt
[587.076110] Starting dynamic subtest: vecs0
[597.103210] Dynamic subtest vecs0: SUCCESS (10.027s)
[597.117174] Starting dynamic subtest: ccs0
[601.105351] Dynamic subtest ccs0: SUCCESS (3.999s)
[601.119264] Starting dynamic subtest: vcs0
[611.112774] Dynamic subtest vcs0: SUCCESS (10.008s)
[611.126188] Starting dynamic subtest: bcs0
[615.075931] Dynamic subtest bcs0: SUCCESS (3.959s)
[615.089124] Starting dynamic subtest: rcs0
[619.024451] Dynamic subtest rcs0: SUCCESS (3.948s)
[619.036448] Starting dynamic subtest: vcs1
[628.151059] Dynamic subtest vcs1: SUCCESS (9.121s)
[628.155794] Subtest nopreempt: SUCCESS (41.074s)
[628.228745] [130/133] (394s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[628.335476] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[628.339797] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[628.406106] [131/133] (394s left) gem_exec_reloc (basic-cpu-wc)
[628.461867] Subtest basic-cpu-wc: SKIP (0.000s)
[628.530062] [132/133] (394s left) gem_render_tiled_blits (basic)
[628.593138] Subtest basic: SKIP (0.000s)
[628.662688] [133/133] (394s left) gem_madvise (dontneed-after-mmap)
[628.696080] Starting subtest: dontneed-after-mmap
[628.712213] Subtest dontneed-after-mmap: SUCCESS (0.018s)
[628.834184] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_pwrite_crc
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: i915_pm_rc6_residency
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: gem_ringfill
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_psr_stress_test
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_mmap
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: gem_huc_copy
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_cdclk
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_atomic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_exec_parallel
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: fbdev
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: gem_linear_blits
results: parsing output: 47/ for test: gem_exec_store
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_pm_lpsp
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: syncobj_basic
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: i915_suspend
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_wait
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_media_vme
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_display_modes
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_prime
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_chamelium_frames
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_hangman
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_pread
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_create
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: kms_vrr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_feature_discovery
results: parsing output: 105/ for test: kms_plane_multiple
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_joiner
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_gttfill
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: gem_exec_parallel
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: sysfs_heartbeat_interval
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: gem_render_tiled_blits
results: parsing output: 132/ for test: gem_madvise
Done.