[59.961508] Initializing watchdogs
[59.961556]   /dev/watchdog0
[59.976655] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.980996] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.983165] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.986630] [001/133] (960s left) gem_exec_suspend (basic-s3)
[60.073350] Starting subtest: basic-S3
[60.075814] Starting dynamic subtest: smem
[81.262325] Dynamic subtest smem: SUCCESS (6.840s)
[81.265078] Subtest basic-S3: SUCCESS (6.840s)
[81.504996] [002/133] (939s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[81.865561] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[81.870317] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[82.127498] [003/133] (938s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[82.230804] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[82.235515] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[82.356303] [004/133] (938s left) kms_cdclk (plane-scaling)
[82.479661] Starting subtest: plane-scaling
[82.482191] Starting dynamic subtest: pipe-A-eDP-1
[82.777099] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[82.786490] Starting dynamic subtest: pipe-B-eDP-1
[82.791245] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[82.799326] Starting dynamic subtest: pipe-C-eDP-1
[82.804028] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[82.812312] Starting dynamic subtest: pipe-D-eDP-1
[82.816856] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[82.821332] Subtest plane-scaling: SKIP (0.304s)
[83.569594] [005/133] (937s left) gem_pxp (verify-pxp-stale-buf-execution)
[83.688516] Starting subtest: verify-pxp-stale-buf-execution
[84.747228] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.065s)
[84.859173] [006/133] (935s left) kms_plane_multiple (2x-tiling-x)
[84.954383] Starting subtest: 2x-tiling-x
[84.958998] Subtest 2x-tiling-x: SKIP (0.000s)
[85.053560] [007/133] (935s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[85.154373] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[85.158670] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[85.281242] [008/133] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[85.380868] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[85.384879] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[85.478226] [009/133] (935s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[85.533371] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[85.535733] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[85.662940] [010/133] (935s left) gem_exec_reloc (basic-cpu-wc)
[85.723508] Subtest basic-cpu-wc: SKIP (0.000s)
[85.791415] [011/133] (935s left) kms_pm_rpm (modeset-stress-extra-wait)
[87.426757] Starting subtest: modeset-stress-extra-wait
[141.731148] Subtest modeset-stress-extra-wait: SUCCESS (54.326s)
[141.820413] [012/133] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[141.907380] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[148.592740] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.691s)
[148.715725] [013/133] (872s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[148.828072] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[148.832158] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[148.929188] [014/133] (872s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[149.022129] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[149.026175] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[149.093421] [015/133] (872s left) gem_create (busy-create)
[149.146993] Starting subtest: busy-create
[149.149425] Starting dynamic subtest: smem0
[182.228363] Dynamic subtest smem0: SUCCESS (33.084s)
[182.231098] Subtest busy-create: SUCCESS (33.086s)
[182.409750] [016/133] (838s left) kms_async_flips (alternate-sync-async-flip)
[182.532941] Starting subtest: alternate-sync-async-flip
[182.922497] Starting dynamic subtest: pipe-A-eDP-1
[185.684674] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.762s)
[186.080152] Starting dynamic subtest: pipe-B-eDP-1
[188.834167] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[189.203592] Starting dynamic subtest: pipe-C-eDP-1
[191.964609] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[192.335746] Starting dynamic subtest: pipe-D-eDP-1
[195.097237] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[195.099356] Subtest alternate-sync-async-flip: SUCCESS (12.564s)
[196.263924] [017/133] (824s left) gem_ctx_param (set-priority-not-supported)
[196.323500] Starting subtest: set-priority-not-supported
[196.327899] Subtest set-priority-not-supported: SKIP (0.000s)
[196.394648] [018/133] (824s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[196.493810] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[196.496063] Starting dynamic subtest: pipe-A-eDP-1
[212.585200] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.392s)
[212.596714] Starting dynamic subtest: pipe-B-eDP-1
[229.572464] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.364s)
[229.582378] Starting dynamic subtest: pipe-C-eDP-1
[246.551171] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.332s)
[246.561179] Starting dynamic subtest: pipe-D-eDP-1
[263.547359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.356s)
[263.550292] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.449s)
[264.775602] [019/133] (756s left) api_intel_allocator (default-alignment)
[264.843595] Starting subtest: default-alignment
[264.846615] Subtest default-alignment: SUCCESS (0.003s)
[264.951252] [020/133] (756s left) gem_exec_balancer (full-late-pulse)
[265.009500] Starting subtest: full-late-pulse
[269.851058] Subtest full-late-pulse: SUCCESS (4.858s)
[270.167919] [021/133] (751s left) kms_plane (pixel-format-linear-modifier)
[270.259041] Starting subtest: pixel-format-linear-modifier
[270.285199] Starting dynamic subtest: pipe-A-plane-0
[274.087849] Dynamic subtest pipe-A-plane-0: SUCCESS (3.811s)
[274.096320] Starting dynamic subtest: pipe-A-plane-3
[275.796095] Dynamic subtest pipe-A-plane-3: SUCCESS (1.710s)
[275.804745] Starting dynamic subtest: pipe-A-plane-5
[276.018008] Dynamic subtest pipe-A-plane-5: SUCCESS (0.221s)
[277.139080] Starting dynamic subtest: pipe-B-plane-0
[280.835877] Dynamic subtest pipe-B-plane-0: SUCCESS (3.711s)
[280.844930] Starting dynamic subtest: pipe-B-plane-3
[282.645591] Dynamic subtest pipe-B-plane-3: SUCCESS (1.809s)
[282.654829] Starting dynamic subtest: pipe-B-plane-5
[282.867486] Dynamic subtest pipe-B-plane-5: SUCCESS (0.220s)
[283.190353] Subtest pixel-format-linear-modifier: SUCCESS (12.952s)
[284.025463] [022/133] (737s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[284.409270] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[285.219054] [023/133] (736s left) kms_big_fb (linear-32bpp-rotate-270)
[285.334158] Starting subtest: linear-32bpp-rotate-270
[285.353649] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[285.454692] [024/133] (736s left) gem_softpin (allocator-basic-reserve)
[285.506108] Starting subtest: allocator-basic-reserve
[285.581116] Subtest allocator-basic-reserve: SUCCESS (0.075s)
[285.696873] [025/133] (735s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[285.790662] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[285.795570] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[285.857248] [026/133] (735s left) syncobj_eventfd (binary-wait-signaled)
[285.909068] Starting subtest: binary-wait-signaled
[285.911508] Subtest binary-wait-signaled: SUCCESS (0.000s)
[285.988460] [027/133] (735s left) kms_atomic (plane-cursor-legacy)
[286.090406] Starting subtest: plane-cursor-legacy
[286.093190] Starting dynamic subtest: pipe-A-eDP-1
[286.475887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[286.478393] Subtest plane-cursor-legacy: SUCCESS (0.386s)
[287.268958] [028/133] (734s left) gem_mmap_wc (read-write-distinct)
[287.340254] Subtest read-write-distinct: SKIP (0.000s)
[287.400770] [029/133] (734s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[287.458372] Starting subtest: single-wait-for-submit-available-submitted
[287.461369] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[287.558413] [030/133] (734s left) sriov_basic (enable-vfs-autoprobe-on)
[287.621915] Starting subtest: enable-vfs-autoprobe-on
[287.624755] Starting dynamic subtest: numvfs-1
[287.714415] Dynamic subtest numvfs-1: FAIL (0.032s)
[287.724498] Starting dynamic subtest: numvfs-2
[287.809027] Dynamic subtest numvfs-2: FAIL (0.004s)
[287.818853] Starting dynamic subtest: numvfs-3
[287.904359] Dynamic subtest numvfs-3: FAIL (0.003s)
[287.914382] Starting dynamic subtest: numvfs-4
[287.998041] Dynamic subtest numvfs-4: FAIL (0.004s)
[288.008337] Starting dynamic subtest: numvfs-5
[288.095296] Dynamic subtest numvfs-5: FAIL (0.003s)
[288.105189] Starting dynamic subtest: numvfs-6
[288.186314] Dynamic subtest numvfs-6: FAIL (0.003s)
[288.195420] Starting dynamic subtest: numvfs-7
[288.271738] Dynamic subtest numvfs-7: FAIL (0.003s)
[288.281836] Starting dynamic subtest: numvfs-random
[288.352241] Dynamic subtest numvfs-random: FAIL (0.004s)
[288.361481] Starting dynamic subtest: numvfs-all
[288.434979] Dynamic subtest numvfs-all: FAIL (0.573s)
[288.437044] Subtest enable-vfs-autoprobe-on: FAIL (0.636s)
[288.474888] [031/133] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[288.569770] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[288.573902] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[288.652991] [032/133] (733s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[288.740994] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[288.743208] Starting dynamic subtest: pipe-A-eDP-1
[288.765103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.774464] Starting dynamic subtest: pipe-B-eDP-1
[288.796409] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.805315] Starting dynamic subtest: pipe-C-eDP-1
[288.827095] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.835587] Starting dynamic subtest: pipe-D-eDP-1
[288.857987] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.862199] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[291.033901] [033/133] (730s left) kms_pm_lpsp (screens-disabled)
[292.133005] Starting subtest: screens-disabled
[292.137577] Subtest screens-disabled: SKIP (0.000s)
[292.200377] [034/133] (729s left) kms_getfb (getfb2-accept-nv12)
[292.282800] Starting subtest: getfb2-accept-nv12
[292.285176] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[292.382440] [035/133] (729s left) gen9_exec_parse (shadow-peek)
[292.438959] Subtest shadow-peek: SKIP (0.000s)
[292.508844] [036/133] (729s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[292.703356] Starting subtest: cursor-rapid-movement-64x21
[292.748471] Subtest cursor-rapid-movement-64x21: SKIP (0.040s)
[292.977785] [037/133] (729s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[293.088623] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[293.093894] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[293.183746] [038/133] (728s left) gem_exec_whisper (basic-contexts-priority-all)
[293.248889] Starting subtest: basic-contexts-priority-all
[317.746446] Subtest basic-contexts-priority-all: SUCCESS (24.489s)
[317.947252] [039/133] (704s left) kms_vrr (seamless-rr-switch-virtual)
[318.051346] Starting subtest: seamless-rr-switch-virtual
[318.058831] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[318.120244] [040/133] (704s left) kms_plane (plane-panning-bottom-right-suspend)
[318.218729] Starting subtest: plane-panning-bottom-right-suspend
[318.221084] Starting dynamic subtest: pipe-A
[335.779806] Dynamic subtest pipe-A: SUCCESS (2.831s)
[335.789546] Starting dynamic subtest: pipe-B
[353.769910] Dynamic subtest pipe-B: SUCCESS (3.353s)
[353.772771] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.187s)
[354.584154] [041/133] (667s left) syncobj_timeline (wait-delayed-signal)
[354.641920] Starting subtest: wait-delayed-signal
[354.742270] Subtest wait-delayed-signal: SUCCESS (0.103s)
[354.822642] [042/133] (667s left) kms_scaling_modes (scaling-mode-none)
[354.905625] Starting subtest: scaling-mode-none
[354.907818] Starting dynamic subtest: pipe-A-eDP-1
[355.003893] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[355.015990] Starting dynamic subtest: pipe-B-eDP-1
[355.043336] Dynamic subtest pipe-B-eDP-1: SKIP (0.038s)
[355.052657] Starting dynamic subtest: pipe-C-eDP-1
[355.076496] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[355.086105] Starting dynamic subtest: pipe-D-eDP-1
[355.108179] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[355.112776] Subtest scaling-mode-none: SKIP (0.204s)
[355.226294] [043/133] (667s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[355.323903] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[355.326270] Starting dynamic subtest: pipe-A-eDP-1
[355.465540] Dynamic subtest pipe-A-eDP-1: SKIP (0.145s)
[355.476227] Starting dynamic subtest: pipe-B-eDP-1
[356.661525] Dynamic subtest pipe-B-eDP-1: SKIP (1.195s)
[356.666555] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.346s)
[357.848638] [044/133] (664s left) kms_plane_scaling (planes-upscale-factor-0-25)
[357.942621] Starting subtest: planes-upscale-factor-0-25
[357.944901] Starting dynamic subtest: pipe-A
[358.002901] Dynamic subtest pipe-A: SUCCESS (0.062s)
[358.014198] Starting dynamic subtest: pipe-B
[359.180532] Dynamic subtest pipe-B: SUCCESS (1.181s)
[359.192161] Starting dynamic subtest: pipe-C
[360.275358] Dynamic subtest pipe-C: SUCCESS (1.095s)
[360.284398] Starting dynamic subtest: pipe-D
[361.399307] Dynamic subtest pipe-D: SUCCESS (1.125s)
[361.401684] Subtest planes-upscale-factor-0-25: SUCCESS (3.469s)
[362.550814] [045/133] (659s left) gem_eio (in-flight-immediate)
[362.772352] Starting subtest: in-flight-immediate
[371.153532] Subtest in-flight-immediate: SUCCESS (8.392s)
[371.309909] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[371.313785] [046/133] (651s left) kms_plane_alpha_blend (alpha-7efc)
[371.400753] Starting subtest: alpha-7efc
[371.692116] Starting dynamic subtest: pipe-A-eDP-1
[372.289392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[372.316441] Starting dynamic subtest: pipe-D-eDP-1
[373.642690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[373.645207] Subtest alpha-7efc: SUCCESS (2.244s)
[374.509792] [047/133] (647s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[374.606311] Starting subtest: 4-tiled-addfb-size-offset-overflow
[374.608721] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[374.710325] [048/133] (647s left) gem_mmap (basic-small-bo)
[374.773533] Subtest basic-small-bo: SKIP (0.000s)
[374.839668] [049/133] (647s left) gem_tiled_fence_blits (normal)
[374.892935] Subtest normal: SKIP (0.000s)
[374.979764] [050/133] (647s left) gem_mmap_offset (bad-object)
[375.032822] Starting subtest: bad-object
[375.035281] Subtest bad-object: SUCCESS (0.001s)
[375.136316] [051/133] (647s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[375.234711] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[382.004141] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.777s)
[382.182793] [052/133] (640s left) kms_draw_crc (draw-method-mmap-wc)
[382.278623] Starting subtest: draw-method-mmap-wc
[382.281172] Starting dynamic subtest: xrgb8888-untiled
[382.534885] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[382.544700] Starting dynamic subtest: rgb565-untiled
[382.765160] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[382.775607] Starting dynamic subtest: xrgb2101010-untiled
[382.987443] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[382.997068] Starting dynamic subtest: xbgr16161616f-untiled
[383.220522] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[383.229949] Starting dynamic subtest: xrgb8888-xtiled
[383.353605] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[383.363320] Starting dynamic subtest: rgb565-xtiled
[383.498182] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s)
[383.507611] Starting dynamic subtest: xrgb2101010-xtiled
[383.620513] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[383.630193] Starting dynamic subtest: xbgr16161616f-xtiled
[383.753573] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[383.765307] Starting dynamic subtest: xrgb8888-4tiled
[383.909341] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[383.918905] Starting dynamic subtest: rgb565-4tiled
[384.064382] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[384.073726] Starting dynamic subtest: xrgb2101010-4tiled
[384.208922] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[384.220913] Starting dynamic subtest: xbgr16161616f-4tiled
[384.375923] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.164s)
[384.378201] Subtest draw-method-mmap-wc: SUCCESS (2.101s)
[384.473078] [053/133] (638s left) gem_madvise (dontneed-before-pwrite)
[384.519681] Starting subtest: dontneed-before-pwrite
[384.542771] Subtest dontneed-before-pwrite: SKIP (0.020s)
[384.604703] [054/133] (638s left) kms_display_modes (extended-mode-basic)
[384.682110] Starting subtest: extended-mode-basic
[384.686603] Subtest extended-mode-basic: SKIP (0.000s)
[384.733286] [055/133] (638s left) gem_eio (create)
[384.948188] Starting subtest: create
[385.275595] Subtest create: SUCCESS (0.328s)
[385.410837] [056/133] (637s left) prime_mmap (test_dup)
[385.465277] Starting subtest: test_dup
[385.467490] Starting dynamic subtest: test_dup-smem
[385.494120] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[385.496688] Subtest test_dup: SUCCESS (0.032s)
[385.568356] [057/133] (637s left) gem_reg_read (timestamp-monotonic)
[385.620606] Starting subtest: timestamp-monotonic
[389.830192] Subtest timestamp-monotonic: SUCCESS (4.210s)
[389.908669] [058/133] (633s left) gem_ctx_bad_destroy (double-destroy)
[389.964324] Starting subtest: double-destroy
[389.967165] Subtest double-destroy: SUCCESS (0.000s)
[390.052308] [059/133] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[390.159782] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[390.165761] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[390.267351] [060/133] (632s left) syncobj_wait (single-wait-signaled)
[390.325632] Starting subtest: single-wait-signaled
[390.327885] Subtest single-wait-signaled: SUCCESS (0.000s)
[390.427544] [061/133] (632s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[390.477885] Starting subtest: multi-wait-all-for-submit-signaled
[390.480682] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[390.599159] [062/133] (632s left) kms_cursor_crc (cursor-offscreen-128x128)
[390.845129] Starting subtest: cursor-offscreen-128x128
[390.850252] Starting dynamic subtest: pipe-A-eDP-1
[392.805508] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[392.831980] Starting dynamic subtest: pipe-D-eDP-1
[395.438072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s)
[395.440467] Subtest cursor-offscreen-128x128: SUCCESS (4.592s)
[396.300941] [063/133] (626s left) gem_exec_fence (parallel)
[396.473917] Starting subtest: parallel
[396.476881] Starting dynamic subtest: rcs0
[398.621722] Dynamic subtest rcs0: SUCCESS (2.149s)
[398.632215] Starting dynamic subtest: bcs0
[400.777165] Dynamic subtest bcs0: SUCCESS (2.155s)
[400.788785] Starting dynamic subtest: vcs0
[402.929917] Dynamic subtest vcs0: SUCCESS (2.152s)
[402.940440] Starting dynamic subtest: vcs1
[405.086403] Dynamic subtest vcs1: SUCCESS (2.156s)
[405.097876] Starting dynamic subtest: vecs0
[407.234015] Dynamic subtest vecs0: SUCCESS (2.148s)
[407.247389] Starting dynamic subtest: ccs0
[409.388928] Dynamic subtest ccs0: SUCCESS (2.155s)
[409.391662] Subtest parallel: SUCCESS (12.920s)
[410.403727] [064/133] (612s left) dmabuf_sync_file (import-multiple-read-only)
[410.449232] Starting subtest: import-multiple-read-only
[410.452012] Subtest import-multiple-read-only: SUCCESS (0.003s)
[410.509169] [065/133] (612s left) perf_pmu (render-node-busy-idle)
[410.584765] Starting subtest: render-node-busy-idle
[410.587798] Starting dynamic subtest: rcs0
[411.284963] Dynamic subtest rcs0: SUCCESS (0.699s)
[411.300323] Starting dynamic subtest: bcs0
[411.947976] Dynamic subtest bcs0: SUCCESS (0.659s)
[411.959568] Starting dynamic subtest: vcs0
[413.247471] Dynamic subtest vcs0: SUCCESS (1.296s)
[413.260490] Starting dynamic subtest: vcs1
[415.295516] Dynamic subtest vcs1: SUCCESS (2.046s)
[415.309146] Starting dynamic subtest: vecs0
[417.279245] Dynamic subtest vecs0: SUCCESS (1.981s)
[417.292496] Starting dynamic subtest: ccs0
[417.942758] Dynamic subtest ccs0: SUCCESS (0.662s)
[417.945836] Subtest render-node-busy-idle: SUCCESS (7.362s)
[418.026901] [066/133] (605s left) kms_vblank (ts-continuation-suspend)
[418.156674] Starting subtest: ts-continuation-suspend
[418.158860] Starting dynamic subtest: pipe-A-eDP-1
[434.689411] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.583s)
[434.708326] Starting dynamic subtest: pipe-D-eDP-1
[451.690709] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s)
[451.693535] Subtest ts-continuation-suspend: SUCCESS (3.763s)
[452.497420] [067/133] (570s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[454.236854] Starting subtest: gem-execbuf-stress-pc8
[454.275577] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[454.729310] [068/133] (568s left) gem_lmem_swapping (heavy-verify-random)
[454.774659] Subtest heavy-verify-random: SKIP (0.000s)
[454.823482] [069/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[454.915595] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[454.920568] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[455.006693] [070/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[455.109531] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[455.114097] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[455.205085] [071/133] (568s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[455.311255] Starting subtest: cursorB-vs-flipA-varying-size
[455.316265] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[455.456154] [072/133] (568s left) kms_properties (plane-properties-atomic)
[455.547946] Starting subtest: plane-properties-atomic
[455.550721] Starting dynamic subtest: pipe-A-eDP-1
[456.115733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.571s)
[456.126865] Starting dynamic subtest: pipe-B-eDP-1
[457.395361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.280s)
[457.408105] Starting dynamic subtest: pipe-C-eDP-1
[458.826303] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.434s)
[458.837668] Starting dynamic subtest: pipe-D-eDP-1
[460.053859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[460.056810] Subtest plane-properties-atomic: SUCCESS (4.519s)
[460.854322] [073/133] (562s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[460.925078] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[461.032560] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[461.111349] [074/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[461.215633] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[468.724654] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.521s)
[468.848167] [075/133] (554s left) gem_exec_gttfill (multigpu-basic)
[469.028828] Starting subtest: multigpu-basic
[481.157364] Subtest multigpu-basic: SUCCESS (12.140s)
[481.250164] [076/133] (542s left) fbdev (write)
[481.352281] Starting subtest: write
[481.721392] Subtest write: SUCCESS (0.367s)
[481.788393] [077/133] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[481.897625] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[481.902609] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[481.990708] [078/133] (541s left) kms_psr (psr2-cursor-mmap-cpu)
[482.089259] Starting subtest: psr2-cursor-mmap-cpu
[482.091586] Starting dynamic subtest: eDP-1
[483.836725] Dynamic subtest eDP-1: SUCCESS (1.746s)
[483.839658] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.747s)
[484.639718] [079/133] (539s left) gem_ctx_isolation (preservation-s3)
[484.710823] Starting subtest: preservation-S3
[484.713810] Starting dynamic subtest: rcs0
[501.432823] Dynamic subtest rcs0: SUCCESS (1.321s)
[501.445752] Starting dynamic subtest: bcs0
[517.443792] Dynamic subtest bcs0: SUCCESS (1.282s)
[517.454594] Starting dynamic subtest: vcs0
[533.432954] Dynamic subtest vcs0: SUCCESS (2.813s)
[533.443382] Starting dynamic subtest: vcs1
[551.447478] Dynamic subtest vcs1: SUCCESS (5.054s)
[551.468681] Starting dynamic subtest: vecs0
[569.434729] Dynamic subtest vecs0: SUCCESS (4.936s)
[569.446274] Starting dynamic subtest: ccs0
[587.431025] Dynamic subtest ccs0: SUCCESS (3.289s)
[587.433826] Subtest preservation-S3: SUCCESS (18.701s)
[587.650155] [080/133] (436s left) kms_flip (flip-vs-blocking-wf-vblank)
[587.791184] Starting subtest: flip-vs-blocking-wf-vblank
[587.793863] Starting dynamic subtest: A-eDP1
[596.779840] Dynamic subtest A-eDP1: SUCCESS (9.007s)
[596.791944] Starting dynamic subtest: B-eDP1
[605.702272] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[605.712558] Starting dynamic subtest: C-eDP1
[614.620074] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[614.632835] Starting dynamic subtest: D-eDP1
[623.553526] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[623.559851] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.806s)
[624.769425] [081/133] (399s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[624.873845] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[624.878861] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[624.963442] [082/133] (399s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[625.067051] Starting subtest: fbcpsr-shrfb-scaledprimary
[630.879659] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.818s)
[631.023490] [083/133] (393s left) gem_exec_suspend (basic-s3-devices)
[631.087097] Starting subtest: basic-S3-devices
[631.089922] Starting dynamic subtest: smem
[643.135830] Dynamic subtest smem: SUCCESS (12.053s)
[643.138850] Subtest basic-S3-devices: SUCCESS (12.055s)
[643.324603] [084/133] (380s left) gem_wait (write-wait)
[643.402092] Starting subtest: write-wait
[643.405338] Starting dynamic subtest: all-engines
[644.537436] Dynamic subtest all-engines: SUCCESS (1.135s)
[644.548395] Starting dynamic subtest: rcs0
[645.607093] Dynamic subtest rcs0: SUCCESS (1.067s)
[645.623923] Starting dynamic subtest: bcs0
[646.669203] Dynamic subtest bcs0: SUCCESS (1.061s)
[646.687791] Starting dynamic subtest: vcs0
[647.731343] Dynamic subtest vcs0: SUCCESS (1.060s)
[647.750220] Starting dynamic subtest: vcs1
[648.789381] Dynamic subtest vcs1: SUCCESS (1.056s)
[648.807243] Starting dynamic subtest: vecs0
[649.847327] Dynamic subtest vecs0: SUCCESS (1.055s)
[649.865380] Starting dynamic subtest: ccs0
[650.908516] Dynamic subtest ccs0: SUCCESS (1.059s)
[650.911257] Subtest write-wait: SUCCESS (7.508s)
[651.110939] [085/133] (373s left) kms_color (ctm-0-75)
[651.212416] Starting subtest: ctm-0-75
[651.214714] Starting dynamic subtest: pipe-A-eDP-1
[656.163893] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.953s)
[656.175052] Starting dynamic subtest: pipe-B-eDP-1
[661.879046] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.713s)
[661.890443] Starting dynamic subtest: pipe-C-eDP-1
[667.256023] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.379s)
[667.267535] Starting dynamic subtest: pipe-D-eDP-1
[672.584090] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.325s)
[672.587142] Subtest ctm-0-75: SUCCESS (21.373s)
[673.404616] [086/133] (350s left) gem_exec_balancer (sequential)
[673.465133] Starting subtest: sequential
[676.515682] Subtest sequential: SUCCESS (3.055s)
[676.831047] [087/133] (347s left) gem_lmem_swapping (random)
[676.890514] Subtest random: SKIP (0.000s)
[676.937872] [088/133] (347s left) gem_mmap_offset (pf-nonblock)
[676.993020] Starting subtest: pf-nonblock
[677.001371] Subtest pf-nonblock: SUCCESS (0.011s)
[677.127413] [089/133] (347s left) kms_joiner (basic-force-ultra-joiner)
[677.234970] Starting subtest: basic-force-ultra-joiner
[677.239833] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[677.304535] [090/133] (347s left) syncobj_wait (reset-signaled)
[677.362868] Starting subtest: reset-signaled
[677.365856] Subtest reset-signaled: SUCCESS (0.000s)
[677.488921] [091/133] (346s left) i915_pm_freq_api (freq-reset)
[677.552070] Starting subtest: freq-reset
[677.554881] Starting dynamic subtest: gt0
[677.741974] Dynamic subtest gt0: SUCCESS (0.188s)
[677.754058] Starting dynamic subtest: gt1
[677.910347] Dynamic subtest gt1: SUCCESS (0.167s)
[677.913348] Subtest freq-reset: SUCCESS (0.358s)
[677.987887] [092/133] (346s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[678.096958] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[678.101826] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[678.207407] [093/133] (346s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[678.295022] Starting subtest: fbcpsr-1p-rte
[685.329894] Subtest fbcpsr-1p-rte: SUCCESS (7.040s)
[685.468439] [094/133] (339s left) gem_exec_schedule (smoketest)
[685.645561] Starting subtest: smoketest
[685.648439] Starting dynamic subtest: rcs0
[691.213649] Dynamic subtest rcs0: SUCCESS (5.510s)
[691.224879] Starting dynamic subtest: bcs0
[696.746674] Dynamic subtest bcs0: SUCCESS (5.533s)
[696.757881] Starting dynamic subtest: vcs0
[702.289847] Dynamic subtest vcs0: SUCCESS (5.535s)
[702.304223] Starting dynamic subtest: vcs1
[707.815274] Dynamic subtest vcs1: SUCCESS (5.523s)
[707.831537] Starting dynamic subtest: vecs0
[713.343405] Dynamic subtest vecs0: SUCCESS (5.529s)
[713.359418] Starting dynamic subtest: ccs0
[718.837866] Dynamic subtest ccs0: SUCCESS (5.499s)
[718.840843] Subtest smoketest: SUCCESS (33.141s)
[719.004348] [095/133] (305s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[719.101794] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[719.104335] Starting dynamic subtest: pipe-A-eDP-1
[719.168774] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[719.180987] Starting dynamic subtest: pipe-B-eDP-1
[719.248772] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[719.259773] Starting dynamic subtest: pipe-C-eDP-1
[719.326513] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[719.337559] Starting dynamic subtest: pipe-D-eDP-1
[719.398921] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[719.403558] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[721.304235] [096/133] (303s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[721.379955] Starting subtest: y-tiled-ccs-to-y-tiled
[721.385607] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[721.575088] [097/133] (303s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[721.635673] Starting subtest: multi-wait-all-for-submit-available-submitted
[721.638318] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[721.729838] [098/133] (302s left) gem_exec_reloc (basic-cpu-noreloc)
[721.783168] Subtest basic-cpu-noreloc: SKIP (0.000s)
[721.864432] [099/133] (302s left) kms_lease (lease-unleased-connector)
[721.956650] Starting subtest: lease-unleased-connector
[721.958806] Starting dynamic subtest: pipe-A-eDP-1
[721.964322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[721.974837] Starting dynamic subtest: pipe-B-eDP-1
[721.977192] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[721.987644] Starting dynamic subtest: pipe-C-eDP-1
[721.990313] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[722.000295] Starting dynamic subtest: pipe-D-eDP-1
[722.002602] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[722.004821] Subtest lease-unleased-connector: SUCCESS (0.032s)
[722.101571] [100/133] (302s left) kms_flip (basic-flip-vs-modeset)
[722.188820] Starting subtest: basic-flip-vs-modeset
[722.191081] Starting dynamic subtest: A-eDP1
[724.774284] Dynamic subtest A-eDP1: SUCCESS (2.588s)
[724.785056] Starting dynamic subtest: B-eDP1
[726.958084] Dynamic subtest B-eDP1: SUCCESS (2.182s)
[726.968754] Starting dynamic subtest: C-eDP1
[729.135068] Dynamic subtest C-eDP1: SUCCESS (2.175s)
[729.147074] Starting dynamic subtest: D-eDP1
[731.299935] Dynamic subtest D-eDP1: SUCCESS (2.166s)
[731.302864] Subtest basic-flip-vs-modeset: SUCCESS (9.118s)
[732.109519] [101/133] (292s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[732.212911] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[732.215479] Starting dynamic subtest: pipe-A-eDP-1
[732.236319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[732.247438] Starting dynamic subtest: pipe-B-eDP-1
[732.268956] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[732.279141] Starting dynamic subtest: pipe-C-eDP-1
[732.301185] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[732.311484] Starting dynamic subtest: pipe-D-eDP-1
[732.333848] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[732.336033] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[734.471700] [102/133] (290s left) tools_test (tools_test)
[734.538692] Starting subtest: tools_test
[734.593837] Subtest tools_test: SUCCESS (0.074s)
[734.675897] [103/133] (290s left) gen9_exec_parse (bb-start-param)
[734.737392] Subtest bb-start-param: SKIP (0.000s)
[734.797424] [104/133] (290s left) kms_cursor_crc (cursor-sliding-max-size)
[735.119967] Starting subtest: cursor-sliding-max-size
[735.127838] Subtest cursor-sliding-max-size: SKIP (0.000s)
[735.242674] [105/133] (289s left) gem_eio (in-flight-contexts-immediate)
[735.469604] Starting subtest: in-flight-contexts-immediate
[749.146939] Subtest in-flight-contexts-immediate: SUCCESS (13.680s)
[749.305422] [106/133] (275s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[749.425284] Starting subtest: basic-flip-before-cursor-varying-size
[750.348728] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.922s)
[751.174827] [107/133] (273s left) gem_sync (basic-many-each)
[751.255728] Starting subtest: basic-many-each
[753.530716] Subtest basic-many-each: SUCCESS (2.290s)
[753.720363] [108/133] (271s left) api_intel_bb (full-batch)
[753.771758] Starting subtest: full-batch
[753.781182] Subtest full-batch: SUCCESS (0.012s)
[753.877537] [109/133] (271s left) kms_properties (crtc-properties-legacy)
[753.970797] Starting subtest: crtc-properties-legacy
[753.973653] Starting dynamic subtest: pipe-A-eDP-1
[754.402483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[754.416703] Starting dynamic subtest: pipe-B-eDP-1
[755.531671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[755.543087] Starting dynamic subtest: pipe-C-eDP-1
[756.646876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[756.658085] Starting dynamic subtest: pipe-D-eDP-1
[757.770663] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[757.773406] Subtest crtc-properties-legacy: SUCCESS (3.803s)
[758.595742] [110/133] (266s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[758.703653] Starting subtest: y-tiled-8bpp-rotate-90
[758.708894] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[758.798261] [111/133] (266s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[758.887824] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[758.893035] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[758.984225] [112/133] (266s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[759.081887] Starting subtest: fbc-psr2-cursor-mmap-gtt
[759.084851] Starting dynamic subtest: eDP-1
[759.089836] Dynamic subtest eDP-1: SKIP (0.000s)
[759.095041] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[759.165223] [113/133] (266s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[759.252902] Starting subtest: primary-4-tiled-reflect-x-0
[766.360551] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.112s)
[767.550715] [114/133] (257s left) gem_ctx_param (invalid-ctx-get)
[767.602233] Starting subtest: invalid-ctx-get
[767.604892] Subtest invalid-ctx-get: SUCCESS (0.000s)
[767.677469] [115/133] (257s left) syncobj_wait (single-wait-for-submit-submitted)
[767.738071] Starting subtest: single-wait-for-submit-submitted
[767.844239] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[767.923849] [116/133] (257s left) kms_chamelium_frames (dp-crc-multiple)
[768.321036] Subtest dp-crc-multiple: SKIP (0.000s)
[769.171295] [117/133] (256s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[769.273851] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[769.278691] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[769.365152] [118/133] (256s left) gem_ringfill (basic-all)
[775.171884] Starting subtest: basic-all
[776.327487] Subtest basic-all: SUCCESS (1.156s)
[776.458374] [119/133] (249s left) kms_content_protection (type1)
[776.606943] Starting subtest: type1
[776.612511] Subtest type1: SKIP (0.000s)
[776.730611] [120/133] (248s left) kms_psr (pr-no-drrs)
[776.821898] Starting subtest: pr-no-drrs
[776.826887] Subtest pr-no-drrs: SKIP (0.000s)
[776.898068] [121/133] (248s left) kms_psr (fbc-psr-no-drrs)
[776.980789] Starting subtest: fbc-psr-no-drrs
[776.983293] Starting dynamic subtest: eDP-1
[776.988211] Dynamic subtest eDP-1: SKIP (0.000s)
[776.992888] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[777.066286] [122/133] (248s left) kms_flip (2x-busy-flip)
[777.163070] Starting subtest: 2x-busy-flip
[777.173984] Subtest 2x-busy-flip: SKIP (0.010s)
[777.268432] [123/133] (248s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[777.367794] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[777.372450] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[777.466434] [124/133] (248s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[777.572049] Starting subtest: flip-vs-cursor-toggle
[786.528637] Subtest flip-vs-cursor-toggle: SUCCESS (8.960s)
[787.333859] [125/133] (238s left) gem_exec_schedule (preempt-queue)
[787.409644] Subtest preempt-queue: SKIP (0.000s)
[787.689418] [126/133] (238s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[787.789574] Starting subtest: fbc-pr-cursor-mmap-gtt
[787.794912] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[787.866938] [127/133] (238s left) sw_sync (sync_merge_invalid)
[787.906690] Starting subtest: sync_merge_invalid
[787.925046] Subtest sync_merge_invalid: SUCCESS (0.017s)
[787.993422] [128/133] (238s left) i915_query (query-topology-garbage-items)
[788.054312] Starting subtest: query-topology-garbage-items
[788.056781] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[788.180414] [129/133] (237s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[788.276457] Starting subtest: psr-rgb565-draw-render
[795.232559] Subtest psr-rgb565-draw-render: SUCCESS (6.964s)
[795.347238] [130/133] (230s left) gem_ctx_persistence (legacy-engines-mixed)
[795.414926] Starting subtest: legacy-engines-mixed
[795.417724] Starting dynamic subtest: render
[795.504420] Dynamic subtest render: SUCCESS (0.088s)
[795.517051] Starting dynamic subtest: bsd1
[795.553036] Dynamic subtest bsd1: SUCCESS (0.046s)
[795.564186] Starting dynamic subtest: bsd2
[795.597093] Dynamic subtest bsd2: SUCCESS (0.042s)
[795.607768] Starting dynamic subtest: blt
[795.644062] Dynamic subtest blt: SUCCESS (0.045s)
[795.655062] Starting dynamic subtest: vebox
[795.704048] Dynamic subtest vebox: SUCCESS (0.058s)
[795.706926] Subtest legacy-engines-mixed: SUCCESS (0.290s)
[795.784355] [131/133] (230s left) prime_mmap (test_aperture_limit)
[795.832589] Starting subtest: test_aperture_limit
[795.835074] Starting dynamic subtest: test_aperture_limit-smem
[795.843829] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[795.849092] Subtest test_aperture_limit: SKIP (0.008s)
[795.953749] [132/133] (230s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[796.052489] Starting subtest: yf-tiled-16bpp-rotate-180
[796.057653] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[796.144155] [133/133] (230s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[796.235654] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[797.314680] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[797.427616] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_suspend
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_cdclk
results: parsing output: 4/ for test: gem_pxp
results: parsing output: 5/ for test: kms_plane_multiple
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_create
results: parsing output: 15/ for test: kms_async_flips
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: api_intel_allocator
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: syncobj_eventfd
results: parsing output: 26/ for test: kms_atomic
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: sriov_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_pm_lpsp
results: parsing output: 33/ for test: kms_getfb
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_exec_whisper
results: parsing output: 38/ for test: kms_vrr
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_scaling_modes
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_mmap
results: parsing output: 48/ for test: gem_tiled_fence_blits
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_draw_crc
results: parsing output: 52/ for test: gem_madvise
results: parsing output: 53/ for test: kms_display_modes
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: gem_reg_read
results: parsing output: 57/ for test: gem_ctx_bad_destroy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: dmabuf_sync_file
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_properties
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_gttfill
results: parsing output: 75/ for test: fbdev
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_ctx_isolation
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: gem_wait
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_joiner
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: i915_pm_freq_api
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_lease
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: tools_test
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: gem_sync
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_properties
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_chamelium_frames
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_ringfill
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: sw_sync
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: prime_mmap
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_big_fb
Done.