[58.704248] Initializing watchdogs
[58.704293]   /dev/watchdog0
[58.718293] [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]
[58.722912] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.725042] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.727084] [001/130] (960s left) gem_spin_batch (resubmit-all)
[58.790166] Starting subtest: resubmit-all
[58.791175] Starting dynamic subtest: rcs0
[58.803601] Dynamic subtest rcs0: SUCCESS (0.013s)
[58.812184] Starting dynamic subtest: bcs0
[58.813078] Dynamic subtest bcs0: SUCCESS (0.003s)
[58.818714] Starting dynamic subtest: vcs0
[58.819570] Dynamic subtest vcs0: SUCCESS (0.002s)
[58.825345] Starting dynamic subtest: vcs1
[58.826228] Dynamic subtest vcs1: SUCCESS (0.004s)
[58.831477] Starting dynamic subtest: vecs0
[58.832369] Dynamic subtest vecs0: SUCCESS (0.003s)
[58.837540] Starting dynamic subtest: ccs0
[58.838419] Dynamic subtest ccs0: SUCCESS (0.002s)
[58.839292] Subtest resubmit-all: SUCCESS (0.030s)
[59.987383] [002/130] (959s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[60.391506] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[61.228178] [003/130] (958s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[61.312944] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[61.313864] Starting dynamic subtest: pipe-A-eDP-1
[61.321816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[61.329694] Starting dynamic subtest: pipe-B-eDP-1
[61.337072] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[61.342717] Starting dynamic subtest: pipe-C-eDP-1
[61.351494] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[61.357077] Starting dynamic subtest: pipe-D-eDP-1
[61.364148] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[61.364948] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[63.556241] [004/130] (955s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[63.656732] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[63.658543] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[63.791372] [005/130] (955s left) gem_exec_flush (basic-wb-ro-before-default)
[63.838370] Starting subtest: basic-wb-ro-before-default
[69.299893] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[69.499205] [006/130] (949s left) kms_psr (psr2-sprite-blt)
[69.597078] Starting subtest: psr2-sprite-blt
[69.597964] Starting dynamic subtest: eDP-1
[71.350041] Dynamic subtest eDP-1: SUCCESS (1.752s)
[71.350923] Subtest psr2-sprite-blt: SUCCESS (1.752s)
[72.232423] [007/130] (947s left) gem_exec_whisper (basic-queues-forked)
[72.298276] Starting subtest: basic-queues-forked
[96.855438] Subtest basic-queues-forked: SUCCESS (24.547s)
[97.055839] [008/130] (922s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[97.152722] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[97.154493] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[97.285246] [009/130] (922s left) kms_pm_rpm (dpms-non-lpsp)
[99.021075] Starting subtest: dpms-non-lpsp
[99.023223] Subtest dpms-non-lpsp: SKIP (0.001s)
[99.585792] [010/130] (919s left) fbdev (nullptr)
[99.631845] Starting subtest: nullptr
[99.632698] Subtest nullptr: SUCCESS (0.000s)
[99.709931] [011/130] (919s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[99.771892] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[99.874918] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[99.971347] [012/130] (919s left) gem_ctx_persistence (legacy-engines-mixed-process)
[100.028555] Starting subtest: legacy-engines-mixed-process
[100.029468] Starting dynamic subtest: render
[101.932433] Dynamic subtest render: SUCCESS (1.903s)
[101.942166] Starting dynamic subtest: bsd1
[103.916639] Dynamic subtest bsd1: SUCCESS (1.982s)
[103.926995] Starting dynamic subtest: bsd2
[105.964777] Dynamic subtest bsd2: SUCCESS (2.046s)
[105.974653] Starting dynamic subtest: blt
[107.891788] Dynamic subtest blt: SUCCESS (1.925s)
[107.901584] Starting dynamic subtest: vebox
[109.924587] Dynamic subtest vebox: SUCCESS (2.032s)
[109.925634] Subtest legacy-engines-mixed-process: SUCCESS (9.895s)
[110.022010] [013/130] (909s left) gem_partial_pwrite_pread (writes-after-reads-display)
[110.081036] Subtest writes-after-reads-display: SKIP (0.000s)
[110.129365] [014/130] (909s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[115.114229] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[115.116820] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[115.989828] [015/130] (903s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[116.049410] Starting subtest: multi-wait-all-for-submit-signaled
[116.050499] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[116.172253] [016/130] (903s left) gem_ctx_shared (disjoint-timelines)
[116.230404] Starting subtest: disjoint-timelines
[116.287331] Subtest disjoint-timelines: SUCCESS (0.057s)
[116.553174] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[116.554721] [017/130] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[116.664959] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[116.666746] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[116.793688] [018/130] (902s left) perf_pmu (idle-no-semaphores)
[116.831264] Starting subtest: idle-no-semaphores
[116.832112] Starting dynamic subtest: rcs0
[117.404449] Dynamic subtest rcs0: SUCCESS (0.570s)
[117.414342] Starting dynamic subtest: bcs0
[117.925997] Dynamic subtest bcs0: SUCCESS (0.520s)
[117.934084] Starting dynamic subtest: vcs0
[118.453631] Dynamic subtest vcs0: SUCCESS (0.527s)
[118.463531] Starting dynamic subtest: vcs1
[118.978762] Dynamic subtest vcs1: SUCCESS (0.523s)
[118.989065] Starting dynamic subtest: vecs0
[119.504735] Dynamic subtest vecs0: SUCCESS (0.525s)
[119.512921] Starting dynamic subtest: ccs0
[120.019833] Dynamic subtest ccs0: SUCCESS (0.514s)
[120.021368] Subtest idle-no-semaphores: SUCCESS (3.186s)
[120.127983] [019/130] (899s left) kms_addfb_basic (too-wide)
[120.215040] Starting subtest: too-wide
[120.215994] Subtest too-wide: SUCCESS (0.000s)
[120.348542] [020/130] (899s left) gem_wait (write-wait)
[120.413296] Starting subtest: write-wait
[120.414329] Starting dynamic subtest: all-engines
[121.535352] Dynamic subtest all-engines: SUCCESS (1.122s)
[121.549968] Starting dynamic subtest: rcs0
[122.589482] Dynamic subtest rcs0: SUCCESS (1.053s)
[122.606032] Starting dynamic subtest: bcs0
[123.645721] Dynamic subtest bcs0: SUCCESS (1.055s)
[123.660073] Starting dynamic subtest: vcs0
[124.698769] Dynamic subtest vcs0: SUCCESS (1.053s)
[124.715450] Starting dynamic subtest: vcs1
[125.749919] Dynamic subtest vcs1: SUCCESS (1.051s)
[125.766276] Starting dynamic subtest: vecs0
[126.802639] Dynamic subtest vecs0: SUCCESS (1.052s)
[126.816931] Starting dynamic subtest: ccs0
[127.858577] Dynamic subtest ccs0: SUCCESS (1.055s)
[127.859876] Subtest write-wait: SUCCESS (7.445s)
[128.077782] [021/130] (891s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[128.185987] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[128.186953] Starting dynamic subtest: pipe-A-eDP-1
[128.208838] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[128.219537] Starting dynamic subtest: pipe-B-eDP-1
[128.243706] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[128.251240] Starting dynamic subtest: pipe-C-eDP-1
[128.272229] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[128.278635] Starting dynamic subtest: pipe-D-eDP-1
[128.299832] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[128.301434] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[130.378948] [022/130] (889s left) gem_exec_schedule (pi-distinct-iova)
[130.562168] Starting subtest: pi-distinct-iova
[130.563075] Starting dynamic subtest: rcs0
[130.645416] Dynamic subtest rcs0: SUCCESS (0.084s)
[130.664646] Starting dynamic subtest: vcs0
[130.708291] Dynamic subtest vcs0: SUCCESS (0.062s)
[130.717823] Starting dynamic subtest: vcs1
[130.772482] Dynamic subtest vcs1: SUCCESS (0.064s)
[130.783329] Starting dynamic subtest: vecs0
[130.829377] Dynamic subtest vecs0: SUCCESS (0.057s)
[130.839054] Starting dynamic subtest: ccs0
[130.902121] Dynamic subtest ccs0: SUCCESS (0.072s)
[130.903536] Subtest pi-distinct-iova: SUCCESS (0.341s)
[131.992207] [023/130] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[132.087884] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[132.088720] Starting dynamic subtest: pipe-A
[132.104873] Dynamic subtest pipe-A: SKIP (0.016s)
[132.112428] Starting dynamic subtest: pipe-B
[132.136501] Dynamic subtest pipe-B: SKIP (0.030s)
[132.143669] Starting dynamic subtest: pipe-C
[132.165079] Dynamic subtest pipe-C: SKIP (0.029s)
[132.171985] Starting dynamic subtest: pipe-D
[132.194107] Dynamic subtest pipe-D: SKIP (0.028s)
[132.195835] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.105s)
[132.357880] [024/130] (887s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[132.426271] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[132.428283] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[132.624326] [025/130] (887s left) gem_exec_schedule (u-submit-early-slice)
[132.684752] Starting subtest: u-submit-early-slice
[132.685833] Starting dynamic subtest: rcs0
[132.734375] Dynamic subtest rcs0: SUCCESS (0.049s)
[132.743978] Starting dynamic subtest: bcs0
[132.778078] Dynamic subtest bcs0: SUCCESS (0.043s)
[132.786346] Starting dynamic subtest: vcs0
[132.823419] Dynamic subtest vcs0: SUCCESS (0.044s)
[132.832420] Starting dynamic subtest: vcs1
[132.861223] Dynamic subtest vcs1: SUCCESS (0.038s)
[132.869067] Starting dynamic subtest: vecs0
[132.899062] Dynamic subtest vecs0: SUCCESS (0.037s)
[132.907301] Starting dynamic subtest: ccs0
[132.937958] Dynamic subtest ccs0: SUCCESS (0.038s)
[132.938981] Subtest u-submit-early-slice: SUCCESS (0.253s)
[134.025662] [026/130] (886s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[134.145546] Starting subtest: cursorB-vs-flipA-atomic-transitions
[134.148504] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[134.308277] [027/130] (885s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[134.417867] Starting subtest: fbc-rgb565-draw-mmap-gtt
[134.419638] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[134.555083] [028/130] (885s left) kms_vblank (ts-continuation-dpms-rpm)
[134.651461] Starting subtest: ts-continuation-dpms-rpm
[134.652421] Starting dynamic subtest: pipe-A-eDP-1
[137.155956] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[137.164834] Starting dynamic subtest: pipe-D-eDP-1
[139.396444] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s)
[139.397451] Subtest ts-continuation-dpms-rpm: SUCCESS (4.745s)
[140.204470] [029/130] (879s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[140.300155] Starting subtest: fbcpsr-slowdraw
[165.399398] Subtest fbcpsr-slowdraw: SUCCESS (25.098s)
[165.563210] [030/130] (854s left) gem_create (create-ext-cpu-access-sanity-check)
[165.740520] Starting subtest: create-ext-cpu-access-sanity-check
[165.742380] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[165.826479] [031/130] (854s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[165.921647] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[165.923478] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[166.040552] [032/130] (854s left) gem_exec_fence (basic-busy-all)
[166.099191] Starting subtest: basic-busy-all
[166.211989] Subtest basic-busy-all: SUCCESS (0.112s)
[168.012651] [033/130] (852s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[168.070355] Starting subtest: map-fixed-invalidate-overlap-busy
[168.072267] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[168.214261] [034/130] (852s left) kms_psr (fbc-psr-primary-mmap-cpu)
[168.290543] Starting subtest: fbc-psr-primary-mmap-cpu
[168.291837] Starting dynamic subtest: eDP-1
[168.294305] Dynamic subtest eDP-1: SKIP (0.000s)
[168.296421] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[168.379125] [035/130] (851s left) prime_vgem (sync)
[168.437236] Starting subtest: sync
[168.438253] Starting dynamic subtest: rcs0
[168.488732] Dynamic subtest rcs0: SUCCESS (0.051s)
[168.496385] Starting dynamic subtest: bcs0
[168.556791] Dynamic subtest bcs0: SUCCESS (0.068s)
[168.564369] Starting dynamic subtest: vcs0
[168.603151] Dynamic subtest vcs0: SUCCESS (0.046s)
[168.610670] Starting dynamic subtest: vcs1
[168.649307] Dynamic subtest vcs1: SUCCESS (0.046s)
[168.656835] Starting dynamic subtest: vecs0
[168.695948] Dynamic subtest vecs0: SUCCESS (0.045s)
[168.703727] Starting dynamic subtest: ccs0
[168.740051] Dynamic subtest ccs0: SUCCESS (0.045s)
[168.741066] Subtest sync: SUCCESS (0.303s)
[168.892383] [036/130] (851s left) gem_readwrite (read-bad-handle)
[168.935038] Subtest read-bad-handle: SKIP (0.000s)
[168.986750] [037/130] (851s left) kms_plane_multiple (tiling-yf)
[169.081574] Starting subtest: tiling-yf
[169.083429] Subtest tiling-yf: SKIP (0.000s)
[169.175279] [038/130] (851s left) syncobj_timeline (single-wait-all-available-submitted)
[169.228232] Starting subtest: single-wait-all-available-submitted
[169.229277] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[169.352856] [039/130] (851s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[169.433794] Starting subtest: dsc-fractional-bpp-with-bpc
[169.445586] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[169.524749] [040/130] (850s left) vgem_basic (create)
[169.558954] Starting subtest: create
[169.559863] Subtest create: SUCCESS (0.000s)
[169.638261] [041/130] (850s left) dumb_buffer (invalid-bpp)
[169.685958] Starting subtest: invalid-bpp
[169.686866] Subtest invalid-bpp: SUCCESS (0.000s)
[169.815356] [042/130] (850s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[169.901512] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[169.903192] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.029610] [043/130] (850s left) gem_exec_schedule (semaphore-noskip)
[170.089366] Starting subtest: semaphore-noskip
[170.530315] Subtest semaphore-noskip: SUCCESS (0.440s)
[170.884371] [044/130] (849s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[170.924098] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[170.924978] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[171.048635] [045/130] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[171.135422] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[171.137250] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[171.256671] [046/130] (849s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[171.339463] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[171.340491] Starting dynamic subtest: pipe-A-eDP-1
[187.573308] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.476s)
[187.583774] Starting dynamic subtest: pipe-B-eDP-1
[205.549054] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.723s)
[205.557907] Starting dynamic subtest: pipe-C-eDP-1
[223.531119] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.690s)
[223.539564] Starting dynamic subtest: pipe-D-eDP-1
[241.513085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.718s)
[241.513897] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.611s)
[248.721379] [047/130] (778s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[248.776299] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[248.887565] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[248.982701] [048/130] (777s left) gem_flink_basic (double-flink)
[249.025286] Starting subtest: double-flink
[249.026213] Subtest double-flink: SUCCESS (0.000s)
[249.134774] [049/130] (777s left) sw_sync (sync_expired_merge)
[249.168223] Starting subtest: sync_expired_merge
[250.263666] Subtest sync_expired_merge: SUCCESS (1.075s)
[250.346814] [050/130] (776s left) syncobj_wait (multi-wait-submitted-signaled)
[250.403942] Starting subtest: multi-wait-submitted-signaled
[250.405046] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[250.544058] [051/130] (776s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[250.654599] Starting subtest: psr-rgb101010-draw-mmap-gtt
[250.656230] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[250.800751] [052/130] (776s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[250.889845] Starting subtest: fbcpsr-tiling-4
[257.985734] Subtest fbcpsr-tiling-4: SUCCESS (7.002s)
[258.163300] [053/130] (768s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[263.164914] Starting subtest: pr-overlay-plane-update-continuous-sf
[263.167745] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.003s)
[264.030259] [054/130] (762s left) i915_pm_rps (min-max-config-loaded)
[264.085563] Starting subtest: min-max-config-loaded
[264.087523] Subtest min-max-config-loaded: SKIP (0.001s)
[264.218794] [055/130] (762s left) kms_addfb_basic (bo-too-small)
[264.309083] Starting subtest: bo-too-small
[264.309954] Subtest bo-too-small: SUCCESS (0.000s)
[264.445312] [056/130] (762s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[264.567838] Starting subtest: verify-pxp-execution-after-suspend-resume
[271.679117] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.093s)
[279.870523] [057/130] (755s left) kms_cursor_crc (cursor-offscreen-256x85)
[280.122838] Starting subtest: cursor-offscreen-256x85
[280.163430] Subtest cursor-offscreen-256x85: SKIP (0.038s)
[280.379186] [058/130] (754s left) gem_eio (wait-1us)
[280.615102] Starting subtest: wait-1us
[280.974552] Subtest wait-1us: SUCCESS (0.360s)
[281.153560] [059/130] (754s left) kms_cursor_crc (cursor-random-512x512)
[281.421269] Starting subtest: cursor-random-512x512
[281.422997] Subtest cursor-random-512x512: SKIP (0.001s)
[281.610205] [060/130] (753s left) kms_color (degamma)
[281.686003] Starting subtest: degamma
[281.687085] Starting dynamic subtest: pipe-A-eDP-1
[282.423350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[282.433406] Starting dynamic subtest: pipe-B-eDP-1
[283.836403] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[283.844910] Starting dynamic subtest: pipe-C-eDP-1
[285.217501] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[285.226162] Starting dynamic subtest: pipe-D-eDP-1
[286.541988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[286.542812] Subtest degamma: SUCCESS (4.855s)
[287.371875] [061/130] (747s left) kms_getfb (getfb2-handle-closed)
[287.467219] Starting subtest: getfb2-handle-closed
[287.468099] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[287.573037] [062/130] (747s left) gem_userptr_blits (input-checking)
[287.636360] Starting subtest: input-checking
[287.637217] Subtest input-checking: SUCCESS (0.000s)
[287.800906] [063/130] (747s left) syncobj_wait (wait-all-for-submit-snapshot)
[287.867000] Starting subtest: wait-all-for-submit-snapshot
[287.948286] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[288.041226] [064/130] (747s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[288.142001] Starting subtest: extended-modeset-hang-oldfb-with-reset
[288.143216] Starting dynamic subtest: pipe-A
[299.733406] Dynamic subtest pipe-A: SUCCESS (11.588s)
[299.748422] Starting dynamic subtest: pipe-D
[312.008949] Dynamic subtest pipe-D: SUCCESS (12.268s)
[312.009930] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.860s)
[312.819362] [065/130] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[312.919246] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[312.920907] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[313.046879] [066/130] (722s left) gem_ppgtt (shrink-vs-evict-any)
[313.105399] Starting subtest: shrink-vs-evict-any
[318.507558] Subtest shrink-vs-evict-any: SUCCESS (5.397s)
[318.627757] [067/130] (716s left) kms_lease (invalid-create-leases)
[318.731221] Starting subtest: invalid-create-leases
[318.738094] Subtest invalid-create-leases: SUCCESS (0.006s)
[318.879276] [068/130] (716s left) api_intel_bb (misplaced-blitter)
[318.934883] Starting subtest: misplaced-blitter
[318.940734] Subtest misplaced-blitter: SUCCESS (0.009s)
[319.099387] [069/130] (716s left) gem_exec_suspend (basic-s3-devices)
[319.172936] Starting subtest: basic-S3-devices
[319.173822] Starting dynamic subtest: smem
[330.443608] Dynamic subtest smem: SUCCESS (11.263s)
[330.445265] Subtest basic-S3-devices: SUCCESS (11.265s)
[336.659893] [070/130] (704s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[336.783909] Starting subtest: cursorB-vs-flipA-legacy
[336.789892] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[336.950864] [071/130] (704s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[336.995294] Starting subtest: invalid-single-wait-all-unsubmitted
[336.996288] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[337.126335] [072/130] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[337.237524] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[337.239438] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.368058] [073/130] (704s left) kms_cdclk (mode-transition-all-outputs)
[337.456367] Starting subtest: mode-transition-all-outputs
[337.741241] Subtest mode-transition-all-outputs: SKIP (0.285s)
[338.631164] [074/130] (703s left) kms_flip (2x-flip-vs-modeset)
[338.718647] Starting subtest: 2x-flip-vs-modeset
[338.729845] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[338.828957] [075/130] (702s left) kms_rotation_crc (multiplane-rotation)
[338.927757] Starting subtest: multiplane-rotation
[346.153094] Subtest multiplane-rotation: SUCCESS (7.226s)
[346.312452] [076/130] (695s left) kms_async_flips (invalid-async-flip)
[346.401459] Starting subtest: invalid-async-flip
[346.773571] Starting dynamic subtest: pipe-A-eDP-1
[347.809356] Dynamic subtest pipe-A-eDP-1: FAIL (0.834s)
[347.986041] Starting dynamic subtest: pipe-B-eDP-1
[348.852810] Dynamic subtest pipe-B-eDP-1: FAIL (0.751s)
[349.101458] Starting dynamic subtest: pipe-C-eDP-1
[349.874887] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.781s)
[350.228728] Starting dynamic subtest: pipe-D-eDP-1
[351.006091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.785s)
[351.007091] Subtest invalid-async-flip: FAIL (4.604s)
[352.179804] [077/130] (689s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[352.238196] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[352.305770] [078/130] (689s left) kms_big_fb (linear-16bpp-rotate-270)
[352.409548] Starting subtest: linear-16bpp-rotate-270
[352.429297] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[352.585901] [079/130] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[352.691064] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[352.692968] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[352.856160] [080/130] (689s left) kms_psr (pr-sprite-blt)
[352.960201] Starting subtest: pr-sprite-blt
[352.961819] Subtest pr-sprite-blt: SKIP (0.000s)
[353.052104] [081/130] (688s left) kms_flip (flip-vs-fences)
[353.139562] Starting subtest: flip-vs-fences
[353.141444] Subtest flip-vs-fences: SKIP (0.000s)
[353.274949] [082/130] (688s left) kms_cursor_crc (cursor-sliding-256x85)
[353.517880] Starting subtest: cursor-sliding-256x85
[353.556931] Subtest cursor-sliding-256x85: SKIP (0.038s)
[353.757973] [083/130] (688s left) gem_exec_balancer (parallel-out-fence)
[354.002341] Starting subtest: parallel-out-fence
[355.103979] Subtest parallel-out-fence: SUCCESS (1.101s)
[355.238613] [084/130] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[355.335747] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[355.337384] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[355.447223] [085/130] (686s left) gem_exec_fence (submit3)
[355.617761] Starting subtest: submit3
[355.619996] Subtest submit3: SKIP (0.000s)
[357.576291] [086/130] (684s left) kms_pm_rpm (pc8-residency)
[359.690020] Starting subtest: pc8-residency
[359.693001] Subtest pc8-residency: SKIP (0.000s)
[360.080837] [087/130] (682s left) syncobj_timeline (single-wait-available-signaled)
[360.130482] Starting subtest: single-wait-available-signaled
[360.131727] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[360.247531] [088/130] (681s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[360.328294] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[360.329091] Starting dynamic subtest: pipe-A-default-mode
[360.622391] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[360.624173] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.293s)
[361.501258] [089/130] (680s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[361.595452] Starting subtest: plane-upscale-factor-0-25-with-rotation
[361.596371] Starting dynamic subtest: pipe-A
[361.822242] Dynamic subtest pipe-A: SUCCESS (0.227s)
[361.831359] Starting dynamic subtest: pipe-B
[363.162548] Dynamic subtest pipe-B: SUCCESS (1.339s)
[363.173619] Starting dynamic subtest: pipe-C
[364.494784] Dynamic subtest pipe-C: SUCCESS (1.331s)
[364.511019] Starting dynamic subtest: pipe-D
[365.825615] Dynamic subtest pipe-D: SUCCESS (1.329s)
[365.827930] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.231s)
[367.031601] [090/130] (675s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[367.115456] Starting subtest: fbc-psr2-cursor-mmap-gtt
[367.116385] Starting dynamic subtest: eDP-1
[367.118135] Dynamic subtest eDP-1: SKIP (0.000s)
[367.119826] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[367.207725] [091/130] (675s left) kms_addfb_basic (basic-x-tiled-legacy)
[367.258312] Starting subtest: basic-x-tiled-legacy
[367.260514] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[367.420448] [092/130] (674s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[367.507565] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[367.508476] Starting dynamic subtest: pipe-A-default-mode
[367.801975] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[367.803842] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.294s)
[368.658468] [093/130] (673s left) kms_invalid_mode (bad-hsync-start)
[368.751912] Starting subtest: bad-hsync-start
[368.752813] Starting dynamic subtest: pipe-A-eDP-1
[369.042404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[369.051350] Starting dynamic subtest: pipe-B-eDP-1
[369.052189] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[369.060869] Starting dynamic subtest: pipe-C-eDP-1
[369.061890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[369.072097] Starting dynamic subtest: pipe-D-eDP-1
[369.072930] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[369.073795] Subtest bad-hsync-start: SUCCESS (0.295s)
[369.887159] [094/130] (672s left) kms_psr (fbc-pr-sprite-blt)
[369.969588] Starting subtest: fbc-pr-sprite-blt
[369.971363] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[370.060358] [095/130] (672s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[370.175522] Starting subtest: basic-busy-flip-before-cursor-atomic
[370.177539] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[370.343545] [096/130] (672s left) perf (blocking-parameterized)
[370.472201] Starting subtest: blocking-parameterized
[390.497603] Subtest blocking-parameterized: SUCCESS (20.018s)
[390.539039] [097/130] (651s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[390.930295] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[391.779177] [098/130] (650s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[391.863992] Starting subtest: bo-too-small-due-to-tiling
[391.865701] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[391.997003] [099/130] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[392.094895] Starting subtest: fbcpsr-rgb565-draw-render
[399.124931] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.029s)
[399.288485] [100/130] (643s left) i915_drm_fdinfo (all-busy-check-all)
[399.329967] Starting subtest: all-busy-check-all
[399.338073] Subtest all-busy-check-all: SKIP (0.008s)
[399.422237] [101/130] (643s left) prime_mmap (test_forked_cpu_write)
[399.512998] Starting subtest: test_forked_cpu_write
[399.513902] Starting dynamic subtest: test_forked_cpu_write-smem
[399.524987] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.013s)
[399.526006] Subtest test_forked_cpu_write: SUCCESS (0.013s)
[399.649199] [102/130] (643s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[399.743747] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[399.745398] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[399.865434] [103/130] (642s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[399.947164] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[399.948022] Starting dynamic subtest: pipe-A-eDP-1
[399.956645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.966130] Starting dynamic subtest: pipe-B-eDP-1
[399.974339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.983194] Starting dynamic subtest: pipe-C-eDP-1
[399.991326] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[400.001977] Starting dynamic subtest: pipe-D-eDP-1
[400.010135] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[400.011713] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[402.133540] [104/130] (640s left) gem_mmap_gtt (cpuset-big-copy-xy)
[402.199315] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[402.276402] [105/130] (640s left) kms_rotation_crc (bad-pixel-format)
[402.360440] Starting subtest: bad-pixel-format
[402.362314] Subtest bad-pixel-format: SKIP (0.001s)
[402.450920] [106/130] (640s left) gem_exec_balancer (bonded-sync)
[402.512417] Starting subtest: bonded-sync
[402.514470] Subtest bonded-sync: SKIP (0.000s)
[402.841314] [107/130] (640s left) gem_exec_reloc (basic-cpu-active)
[402.914792] Subtest basic-cpu-active: SKIP (0.000s)
[402.996801] [108/130] (639s left) gem_exec_schedule (fairslice)
[403.067416] Starting subtest: fairslice
[403.068408] Starting dynamic subtest: rcs0
[405.093281] Dynamic subtest rcs0: SUCCESS (2.024s)
[405.106886] Starting dynamic subtest: bcs0
[407.118321] Dynamic subtest bcs0: SUCCESS (2.024s)
[407.128139] Starting dynamic subtest: vcs0
[409.138246] Dynamic subtest vcs0: SUCCESS (2.017s)
[409.148094] Starting dynamic subtest: vcs1
[411.154704] Dynamic subtest vcs1: SUCCESS (2.017s)
[411.164795] Starting dynamic subtest: vecs0
[413.174278] Dynamic subtest vecs0: SUCCESS (2.016s)
[413.184569] Starting dynamic subtest: ccs0
[415.193479] Dynamic subtest ccs0: SUCCESS (2.019s)
[415.194405] Subtest fairslice: SUCCESS (12.123s)
[415.503090] [109/130] (627s left) gem_exec_reloc (basic-write-cpu-active)
[415.576437] Subtest basic-write-cpu-active: SKIP (0.000s)
[415.661278] [110/130] (627s left) gem_linear_blits (normal)
[416.041630] Starting subtest: normal
[420.566120] Subtest normal: SUCCESS (4.521s)
[420.718680] [111/130] (622s left) gen9_exec_parse (bb-oversize)
[420.808516] Subtest bb-oversize: SKIP (0.000s)
[420.900897] [112/130] (622s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[421.008952] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[422.043116] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.034s)
[422.233437] [113/130] (620s left) kms_universal_plane (universal-plane-sanity)
[422.337642] Starting subtest: universal-plane-sanity
[422.338566] Starting dynamic subtest: pipe-A-eDP-1
[422.922952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[422.932353] Starting dynamic subtest: pipe-B-eDP-1
[424.142102] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[424.155861] Starting dynamic subtest: pipe-C-eDP-1
[425.354486] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[425.365332] Starting dynamic subtest: pipe-D-eDP-1
[426.588600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[426.589544] Subtest universal-plane-sanity: SUCCESS (4.251s)
[427.464022] [114/130] (615s left) syncobj_timeline (etime-single-wait-submitted)
[427.523643] Starting subtest: etime-single-wait-submitted
[427.630907] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[427.728434] [115/130] (615s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[427.824095] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[427.824891] Starting dynamic subtest: pipe-A-eDP-1
[429.196351] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.368s)
[429.491400] Starting dynamic subtest: pipe-B-eDP-1
[430.525619] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.044s)
[430.799141] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.974s)
[431.653038] [116/130] (611s left) gem_ctx_param (invalid-get-engines)
[431.714714] Starting subtest: invalid-get-engines
[431.715728] Subtest invalid-get-engines: SUCCESS (0.001s)
[431.852026] [117/130] (611s left) i915_suspend (fence-restore-untiled)
[431.903046] Starting subtest: fence-restore-untiled
[431.904783] Subtest fence-restore-untiled: SKIP (0.000s)
[432.017976] [118/130] (611s left) gem_mmap_offset (clear)
[432.075628] Starting subtest: clear
[432.076514] Starting dynamic subtest: smem0
[457.015661] Dynamic subtest smem0: SUCCESS (24.930s)
[457.016815] Subtest clear: SUCCESS (24.932s)
[457.180802] [119/130] (586s left) i915_drm_fdinfo (virtual-idle)
[457.245278] Starting subtest: virtual-idle
[460.336005] Subtest virtual-idle: SUCCESS (3.087s)
[460.429305] [120/130] (582s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[460.522638] Starting subtest: flip-vs-dpms-on-nop-interruptible
[460.528080] Starting dynamic subtest: A-eDP1
[462.423795] Dynamic subtest A-eDP1: SUCCESS (1.895s)
[462.436225] Starting dynamic subtest: B-eDP1
[464.257479] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[464.275415] Starting dynamic subtest: C-eDP1
[466.081261] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[466.092985] Starting dynamic subtest: D-eDP1
[467.908559] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[467.914019] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.389s)
[469.129033] [121/130] (574s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[469.256016] Starting subtest: 4-tiled-64bpp-rotate-270
[469.277788] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.021s)
[469.440623] [122/130] (573s left) gem_exec_flush (basic-wb-pro-default)
[469.508305] Starting subtest: basic-wb-pro-default
[474.968881] Subtest basic-wb-pro-default: SUCCESS (5.459s)
[475.173889] [123/130] (568s left) kms_rotation_crc (exhaust-fences)
[475.270013] Starting subtest: exhaust-fences
[475.271609] Subtest exhaust-fences: SKIP (0.000s)
[475.360939] [124/130] (568s left) kms_flip (flip-vs-rmfb)
[475.453310] Starting subtest: flip-vs-rmfb
[475.455582] Starting dynamic subtest: A-eDP1
[484.107841] Dynamic subtest A-eDP1: SUCCESS (8.650s)
[484.120188] Starting dynamic subtest: B-eDP1
[492.747078] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[492.759849] Starting dynamic subtest: C-eDP1
[501.367897] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[501.381875] Starting dynamic subtest: D-eDP1
[509.993609] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[509.996663] Subtest flip-vs-rmfb: SUCCESS (34.532s)
[511.188844] [125/130] (532s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[511.302780] Starting subtest: x-tiled-8bpp-rotate-90
[511.323938] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[511.481855] [126/130] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[511.573625] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[518.967138] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.391s)
[519.142079] [127/130] (524s left) kms_lease (simple-lease)
[519.251576] Starting subtest: simple-lease
[519.252517] Starting dynamic subtest: pipe-A-eDP-1
[519.749084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[519.758878] Starting dynamic subtest: pipe-B-eDP-1
[521.227682] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.477s)
[521.242170] Starting dynamic subtest: pipe-C-eDP-1
[522.625852] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[522.637231] Starting dynamic subtest: pipe-D-eDP-1
[524.045928] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s)
[524.047118] Subtest simple-lease: SUCCESS (4.793s)
[524.882486] [128/130] (518s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[524.982406] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[524.984103] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[525.118143] [129/130] (518s left) api_intel_allocator (simple-allocator)
[525.173918] Starting subtest: simple-allocator
[525.174815] Starting dynamic subtest: basic
[525.177311] Dynamic subtest basic: SUCCESS (0.004s)
[525.188168] Starting dynamic subtest: parallel-one
[525.352108] Dynamic subtest parallel-one: SUCCESS (0.172s)
[525.363450] Starting dynamic subtest: print
[525.364240] Dynamic subtest print: SUCCESS (0.000s)
[525.373081] Starting dynamic subtest: reuse
[525.373895] Dynamic subtest reuse: SUCCESS (0.000s)
[525.382402] Starting dynamic subtest: reserve
[525.383188] Dynamic subtest reserve: SUCCESS (0.000s)
[525.391581] Starting dynamic subtest: fork-reopen-allocator
[525.392361] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[525.393178] Subtest simple-allocator: SUCCESS (0.194s)
[525.518237] [130/130] (518s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[525.636793] Starting subtest: short-busy-flip-before-cursor-toggle
[525.638573] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[525.808022] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_flush
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: fbdev
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: gem_partial_pwrite_pread
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_readwrite
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_dsc
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: dumb_buffer
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_flink_basic
results: parsing output: 48/ for test: sw_sync
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: i915_pm_rps
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_color
results: parsing output: 60/ for test: kms_getfb
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_busy
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_ppgtt
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: gem_exec_suspend
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cdclk
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: kms_pipe_b_c_ivb
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_invalid_mode
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: prime_mmap
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: gem_linear_blits
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_universal_plane
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: i915_suspend
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_cursor_legacy
Done.