[84.001812] Initializing watchdogs
[84.002064]   /dev/watchdog0
[84.043956] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[84.057519] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[84.063623] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[84.069281] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[84.228175] Starting subtest: plane-upscale-20x20-with-rotation
[84.229089] Starting dynamic subtest: pipe-A
[84.230775] Dynamic subtest pipe-A: SKIP (0.000s)
[84.243556] Starting dynamic subtest: pipe-B
[84.245197] Dynamic subtest pipe-B: SKIP (0.000s)
[84.257803] Starting dynamic subtest: pipe-C
[84.259547] Dynamic subtest pipe-C: SKIP (0.000s)
[84.261126] Subtest plane-upscale-20x20-with-rotation: SKIP (0.001s)
[84.323527] [002/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[84.474427] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[84.559319] [003/130] (960s left) kms_big_fb (linear-8bpp-rotate-180)
[84.704482] Subtest linear-8bpp-rotate-180: SKIP (0.000s)
[84.777557] [004/130] (960s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[84.932224] Starting subtest: blocking-absolute-wf_vblank-interruptible
[84.934832] Subtest blocking-absolute-wf_vblank-interruptible: SKIP (0.002s)
[85.014634] [005/130] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[85.163090] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[85.244633] [006/130] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[85.392432] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[85.470623] [007/130] (959s left) gem_ctx_exec (basic-norecovery)
[85.565895] Starting subtest: basic-norecovery
[85.604770] Subtest basic-norecovery: SUCCESS (0.037s)
[85.709815] [008/130] (959s left) kms_psr (psr-primary-page-flip)
[85.858960] Subtest psr-primary-page-flip: SKIP (0.000s)
[85.929923] [009/130] (959s left) core_getstats
[86.093265] [010/130] (959s left) i915_hangman (detector)
[86.220985] Starting subtest: detector
[86.222947] Starting dynamic subtest: rcs0
[96.247770] Dynamic subtest rcs0: SUCCESS (10.024s)
[96.261324] Starting dynamic subtest: bcs0
[106.230758] Dynamic subtest bcs0: SUCCESS (9.979s)
[106.244948] Starting dynamic subtest: vcs0
[116.228034] Dynamic subtest vcs0: SUCCESS (9.995s)
[116.241898] Starting dynamic subtest: vecs0
[126.183229] Dynamic subtest vecs0: SUCCESS (9.953s)
[126.184981] Subtest detector: SUCCESS (39.954s)
[126.310027] [011/130] (918s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[126.456269] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[126.526387] [012/130] (918s left) gem_lmem_swapping (parallel-random-engines)
[126.631935] Subtest parallel-random-engines: SKIP (0.000s)
[126.702678] [013/130] (918s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[126.852059] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[126.934454] [014/130] (918s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[127.080386] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[127.152733] [015/130] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[127.301294] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[127.384867] [016/130] (918s left) gem_ctx_persistence (legacy-engines-hostile)
[127.489228] Starting subtest: legacy-engines-hostile
[127.490175] Starting dynamic subtest: render
[127.531949] Dynamic subtest render: SUCCESS (0.042s)
[127.546329] Starting dynamic subtest: bsd
[127.629761] Dynamic subtest bsd: SUCCESS (0.096s)
[127.644070] Starting dynamic subtest: blt
[127.723993] Dynamic subtest blt: SUCCESS (0.092s)
[127.738363] Starting dynamic subtest: vebox
[127.828762] Dynamic subtest vebox: SUCCESS (0.103s)
[127.830380] Subtest legacy-engines-hostile: SUCCESS (0.340s)
[127.905025] [017/130] (917s left) prime_vgem (shrink)
[128.056485] Starting subtest: shrink
[128.076299] Subtest shrink: SUCCESS (0.020s)
[128.197346] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[128.201786] [018/130] (917s left) gem_exec_schedule (preempt-queue-chain)
[128.329484] Starting subtest: preempt-queue-chain
[128.330968] Starting dynamic subtest: rcs0
[128.726128] Dynamic subtest rcs0: SUCCESS (0.395s)
[128.744774] Starting dynamic subtest: bcs0
[129.114893] Dynamic subtest bcs0: SUCCESS (0.390s)
[129.133985] Starting dynamic subtest: vcs0
[129.493592] Dynamic subtest vcs0: SUCCESS (0.378s)
[129.513392] Starting dynamic subtest: vecs0
[129.874521] Dynamic subtest vecs0: SUCCESS (0.380s)
[129.875701] Subtest preempt-queue-chain: SUCCESS (1.546s)
[130.230785] [019/130] (915s left) kms_flip (flip-vs-panning-vs-hang)
[130.378875] Starting subtest: flip-vs-panning-vs-hang
[130.380898] Subtest flip-vs-panning-vs-hang: SKIP (0.002s)
[130.484737] [020/130] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[130.632205] Subtest cursor-rapid-movement-256x256: SKIP (0.000s)
[130.711991] [021/130] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[130.862802] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[130.954928] [022/130] (915s left) gem_exec_balancer (sliced)
[131.075256] Starting subtest: sliced
[135.223027] Subtest sliced: SUCCESS (4.148s)
[135.432789] [023/130] (910s left) kms_psr (fbc-psr-suspend)
[135.582761] Subtest fbc-psr-suspend: SKIP (0.000s)
[135.663924] [024/130] (910s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[135.814537] Subtest fbcpsr-stridechange: SKIP (0.000s)
[135.905904] [025/130] (910s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[136.052777] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[136.133224] [026/130] (910s left) gem_mmap_gtt (basic-read-write-distinct)
[136.225107] Starting subtest: basic-read-write-distinct
[136.257468] Subtest basic-read-write-distinct: SUCCESS (0.032s)
[136.349714] [027/130] (910s left) perf_pmu (busy-accuracy-2)
[136.457293] Starting subtest: busy-accuracy-2
[136.458317] Starting dynamic subtest: rcs0
[139.575877] Dynamic subtest rcs0: SUCCESS (3.118s)
[139.591845] Starting dynamic subtest: bcs0
[142.692128] Dynamic subtest bcs0: SUCCESS (3.116s)
[142.707882] Starting dynamic subtest: vcs0
[145.807311] Dynamic subtest vcs0: SUCCESS (3.115s)
[145.824313] Starting dynamic subtest: vecs0
[148.925899] Dynamic subtest vecs0: SUCCESS (3.118s)
[148.927306] Subtest busy-accuracy-2: SUCCESS (12.469s)
[149.020314] [028/130] (897s left) gem_create (create-ext-set-pat)
[149.235472] Starting subtest: create-ext-set-pat
[149.237458] Subtest create-ext-set-pat: SKIP (0.000s)
[149.319753] [029/130] (897s left) gem_exec_reloc (basic-wc-cpu-active)
[149.426837] Starting subtest: basic-wc-cpu-active
[149.566859] Subtest basic-wc-cpu-active: SUCCESS (0.139s)
[149.683499] [030/130] (897s left) gem_ctx_persistence (userptr)
[149.790026] Starting subtest: userptr
[149.899302] Subtest userptr: SUCCESS (0.109s)
[149.991536] [031/130] (896s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[150.087265] Starting subtest: multi-wait-all-for-submit-unsubmitted
[150.189815] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[150.279476] [032/130] (896s left) gem_busy (close-race)
[150.398258] Starting subtest: close-race
[172.666332] Subtest close-race: SUCCESS (22.269s)
[173.045103] [033/130] (874s left) kms_addfb_basic (small-bo)
[173.293943] Starting subtest: small-bo
[173.294874] Subtest small-bo: SUCCESS (0.000s)
[173.396746] [034/130] (873s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[173.543729] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[173.649402] [035/130] (873s left) syncobj_timeline (invalid-transfer-non-existent-point)
[173.754367] Starting subtest: invalid-transfer-non-existent-point
[173.755474] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[173.840541] [036/130] (873s left) kms_lease (lease-revoke)
[173.988849] Subtest lease-revoke: SKIP (0.000s)
[174.081388] [037/130] (873s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[174.228816] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[174.320540] [038/130] (873s left) gem_mmap_offset (partial-remap)
[174.414581] Starting subtest: partial-remap
[174.415652] Starting dynamic subtest: smem0
[174.431278] Dynamic subtest smem0: SUCCESS (0.013s)
[174.432260] Subtest partial-remap: SUCCESS (0.013s)
[174.537497] [039/130] (873s left) gem_exec_whisper (basic-fds-priority)
[174.659276] Starting subtest: basic-fds-priority
[184.225332] Subtest basic-fds-priority: SUCCESS (9.564s)
[184.428478] [040/130] (863s left) gem_softpin (allocator-nopin)
[184.534754] Starting subtest: allocator-nopin
[184.739686] Subtest allocator-nopin: SUCCESS (0.205s)
[184.876543] [041/130] (862s left) gem_exec_reloc (basic-concurrent16)
[184.988652] Starting subtest: basic-concurrent16
[190.469385] Subtest basic-concurrent16: SUCCESS (5.481s)
[190.631293] [042/130] (857s left) kms_vrr (negative-basic)
[190.781733] Subtest negative-basic: SKIP (0.000s)
[190.865859] [043/130] (857s left) syncobj_timeline (single-wait-all-signaled)
[190.962473] Starting subtest: single-wait-all-signaled
[190.963530] Subtest single-wait-all-signaled: SUCCESS (0.002s)
[191.049152] [044/130] (857s left) kms_psr (fbc-psr2-primary-page-flip)
[191.193457] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[191.280163] [045/130] (856s left) kms_feature_discovery (display-4x)
[191.428974] Starting subtest: display-4x
[191.431867] Subtest display-4x: SKIP (0.000s)
[191.514524] [046/130] (856s left) kms_pm_rpm (universal-planes)
[192.918846] Starting subtest: universal-planes
[192.920826] Subtest universal-planes: SKIP (0.000s)
[193.008997] [047/130] (855s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[193.200401] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[193.290949] [048/130] (855s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[193.398138] Starting subtest: basic-cpu-gtt-noreloc
[193.409024] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.011s)
[193.534356] [049/130] (855s left) kms_scaling_modes (scaling-mode-full-aspect)
[193.681363] Subtest scaling-mode-full-aspect: SKIP (0.000s)
[193.764114] [050/130] (854s left) kms_color (degamma)
[193.908715] Starting subtest: degamma
[193.910679] Subtest degamma: SKIP (0.000s)
[193.995273] [051/130] (854s left) kms_cursor_crc (cursor-offscreen-256x85)
[194.141123] Subtest cursor-offscreen-256x85: SKIP (0.000s)
[194.223564] [052/130] (854s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[194.376477] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.000s)
[194.455537] [053/130] (854s left) perf_pmu (busy-start)
[194.560922] Starting subtest: busy-start
[194.561933] Starting dynamic subtest: rcs0
[197.093368] Dynamic subtest rcs0: SUCCESS (2.532s)
[197.118742] Starting dynamic subtest: bcs0
[199.618940] Dynamic subtest bcs0: SUCCESS (2.525s)
[199.641398] Starting dynamic subtest: vcs0
[202.152873] Dynamic subtest vcs0: SUCCESS (2.532s)
[202.175734] Starting dynamic subtest: vecs0
[204.683680] Dynamic subtest vecs0: SUCCESS (2.530s)
[204.685273] Subtest busy-start: SUCCESS (10.122s)
[204.778826] [054/130] (844s left) gem_spin_batch (spin-each)
[204.894689] Starting subtest: spin-each
[208.186379] Subtest spin-each: SUCCESS (3.292s)
[208.421657] [055/130] (840s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[208.564167] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[208.660356] [056/130] (840s left) kms_chamelium_frames (hdmi-crc-multiple)
[208.815265] Subtest hdmi-crc-multiple: SKIP (0.000s)
[208.901745] [057/130] (840s left) gen9_exec_parse (bb-start-out)
[209.017166] Starting subtest: bb-start-out
[209.020334] Subtest bb-start-out: SUCCESS (0.004s)
[209.263878] [058/130] (840s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[209.415261] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.000s)
[209.493480] [059/130] (839s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[209.638861] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[209.734692] [060/130] (839s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[209.884875] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[209.968891] [061/130] (839s left) kms_flip (absolute-wf_vblank)
[210.114858] Starting subtest: absolute-wf_vblank
[210.117839] Subtest absolute-wf_vblank: SKIP (0.002s)
[210.219693] [062/130] (839s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[210.313414] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[210.422209] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[210.509408] [063/130] (839s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[210.602684] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[210.604755] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[210.690448] [064/130] (839s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[210.842637] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[210.844927] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.001s)
[210.938088] [065/130] (839s left) kms_cursor_crc (cursor-onscreen-128x42)
[211.083026] Subtest cursor-onscreen-128x42: SKIP (0.000s)
[211.164975] [066/130] (838s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[211.311159] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[211.396922] [067/130] (838s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[211.543444] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[211.626475] [068/130] (838s left) kms_vblank (query-idle)
[211.770907] Subtest query-idle: SKIP (0.000s)
[211.867201] [069/130] (838s left) gem_exec_reloc (basic-cpu-read-active)
[211.974239] Starting subtest: basic-cpu-read-active
[212.113032] Subtest basic-cpu-read-active: SUCCESS (0.139s)
[212.235547] [070/130] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[212.379954] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[212.470973] [071/130] (838s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[212.620889] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[212.704392] [072/130] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[212.849715] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[212.946917] [073/130] (837s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[213.093931] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[213.185234] [074/130] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[213.330569] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[213.426455] [075/130] (837s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[213.573657] Subtest fbc-modesetfrombusy: SKIP (0.000s)
[213.669711] [076/130] (837s left) gem_tiled_blits (basic)
[213.917751] Starting subtest: basic
[213.958286] Subtest basic: SUCCESS (0.045s)
[214.102338] [077/130] (836s left) gem_eio (context-create)
[214.325252] Starting subtest: context-create
[214.374848] Subtest context-create: SUCCESS (0.049s)
[214.509515] [078/130] (836s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[214.618672] Starting subtest: x-tiled-to-vebox-y-tiled
[214.620445] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[214.823528] [079/130] (836s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[214.975408] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[215.055639] [080/130] (836s left) kms_plane_alpha_blend (alpha-7efc)
[215.201231] Starting subtest: alpha-7efc
[215.202998] Subtest alpha-7efc: SKIP (0.000s)
[215.294544] [081/130] (836s left) i915_selftest (perf)
[216.491023] Starting subtest: perf
[216.492136] Starting dynamic subtest: engine_cs
[218.851802] Dynamic subtest engine_cs: SUCCESS (2.360s)
[218.869943] Starting dynamic subtest: request
[224.185056] Dynamic subtest request: SUCCESS (5.332s)
[224.201542] Starting dynamic subtest: migrate
[228.565849] Dynamic subtest migrate: SUCCESS (4.379s)
[228.582395] Starting dynamic subtest: region
[232.535070] Dynamic subtest region: SUCCESS (3.967s)
[232.536139] Subtest perf: SUCCESS (16.043s)
[232.607969] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[232.610879] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[232.614532] [082/130] (818s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[234.500740] Subtest short-flip-before-cursor-toggle: SKIP (0.000s)
[234.609276] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[234.613499] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[234.619387] [083/130] (817s left) kms_pm_rpm (modeset-lpsp-stress)
[235.893247] Starting subtest: modeset-lpsp-stress
[236.033514] Subtest modeset-lpsp-stress: SKIP (0.140s)
[236.118232] [084/130] (815s left) gem_exec_flush (basic-wb-rw-before-default)
[236.270243] Starting subtest: basic-wb-rw-before-default
[241.716638] Subtest basic-wb-rw-before-default: SUCCESS (5.446s)
[241.919376] [085/130] (809s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[242.068904] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[242.153421] [086/130] (809s left) i915_query (query-regions-unallocated)
[242.246157] Starting subtest: query-regions-unallocated
[242.247315] Subtest query-regions-unallocated: SUCCESS (0.000s)
[242.329915] [087/130] (809s left) gem_exec_flush (basic-batch-kernel-default-wb)
[242.445925] Starting subtest: basic-batch-kernel-default-wb
[248.208424] Subtest basic-batch-kernel-default-wb: SUCCESS (5.762s)
[248.416170] [088/130] (803s left) syncobj_wait (multi-wait-all-signaled)
[248.512716] Starting subtest: multi-wait-all-signaled
[248.515444] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[248.604625] [089/130] (803s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[248.750468] Subtest fbc-dirtyfb-ioctl: SKIP (0.000s)
[248.832755] [090/130] (803s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[248.979990] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[249.063429] [091/130] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[249.213911] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[249.306560] [092/130] (803s left) kms_fbcon_fbt (fbc-suspend)
[249.405368] Starting subtest: fbc-suspend
[249.412987] Subtest fbc-suspend: SKIP (0.006s)
[249.498030] [093/130] (803s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[249.641184] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[249.722707] [094/130] (802s left) gem_exec_schedule (u-submit-early-slice)
[249.847152] Starting subtest: u-submit-early-slice
[249.848695] Starting dynamic subtest: rcs0
[249.907137] Dynamic subtest rcs0: SUCCESS (0.060s)
[249.930357] Starting dynamic subtest: bcs0
[249.962996] Dynamic subtest bcs0: SUCCESS (0.054s)
[249.982443] Starting dynamic subtest: vcs0
[250.016852] Dynamic subtest vcs0: SUCCESS (0.053s)
[250.037534] Starting dynamic subtest: vecs0
[250.068722] Dynamic subtest vecs0: SUCCESS (0.052s)
[250.070699] Subtest u-submit-early-slice: SUCCESS (0.222s)
[250.427717] [095/130] (802s left) vgem_basic (debugfs)
[250.520944] Starting subtest: debugfs
[250.521904] Subtest debugfs: SUCCESS (0.001s)
[250.605476] [096/130] (802s left) gen7_exec_parse (batch-without-end)
[250.708566] Subtest batch-without-end: SKIP (0.000s)
[250.792487] [097/130] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[250.937036] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[251.032478] [098/130] (801s left) dmabuf_sync_file (export-basic)
[251.123299] Starting subtest: export-basic
[251.125309] Subtest export-basic: SUCCESS (0.003s)
[251.208563] [099/130] (801s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[251.353115] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[251.436668] [100/130] (801s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[251.587851] Subtest cursorB-vs-flipB-atomic: SKIP (0.000s)
[251.665752] [101/130] (801s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[251.763271] Starting subtest: cpuset-medium-copy-XY
[262.077031] Subtest cpuset-medium-copy-XY: SUCCESS (10.314s)
[262.197630] [102/130] (791s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[264.925863] Starting subtest: protected-encrypted-src-copy-not-readible
[264.927634] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[265.016869] [103/130] (788s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[265.171032] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[265.173054] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.000s)
[265.255707] [104/130] (788s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[265.401963] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[265.495207] [105/130] (788s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[266.138665] Starting subtest: syncobj-timeline-invalid-flags
[266.139833] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[266.366851] [106/130] (787s left) gem_basic (create-close)
[266.459649] Starting subtest: create-close
[266.461652] Subtest create-close: SUCCESS (0.000s)
[266.576101] [107/130] (787s left) api_intel_allocator (reloc-allocator)
[266.668528] Starting subtest: reloc-allocator
[266.669502] Starting dynamic subtest: basic
[266.676959] Dynamic subtest basic: SUCCESS (0.008s)
[266.695911] Starting dynamic subtest: parallel-one
[266.696878] Dynamic subtest parallel-one: SUCCESS (0.012s)
[266.714941] Starting dynamic subtest: print
[266.715937] Dynamic subtest print: SUCCESS (0.000s)
[266.734076] Starting dynamic subtest: reuse
[266.735074] Dynamic subtest reuse: SUCCESS (0.000s)
[266.759241] Starting dynamic subtest: fork-reopen-allocator
[266.760332] Dynamic subtest fork-reopen-allocator: SUCCESS (0.032s)
[266.761345] Subtest reloc-allocator: SUCCESS (0.054s)
[266.846125] [108/130] (787s left) kms_psr (pr-primary-blt)
[266.992965] Subtest pr-primary-blt: SKIP (0.000s)
[267.077494] [109/130] (786s left) gem_ctx_bad_destroy (double-destroy)
[267.171643] Starting subtest: double-destroy
[267.172544] Subtest double-destroy: SUCCESS (0.000s)
[267.258998] [110/130] (786s left) core_getclient
[267.433255] [111/130] (786s left) syncobj_wait (wait-all-delayed-signal)
[267.538436] Starting subtest: wait-all-delayed-signal
[267.643270] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[267.738725] [112/130] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[267.883182] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[267.975170] [113/130] (786s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[268.122472] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[268.205959] [114/130] (786s left) kms_async_flips (test-time-stamp)
[268.350333] Subtest test-time-stamp: SKIP (0.000s)
[268.432413] [115/130] (786s left) kms_invalid_mode (bad-vsync-end)
[268.578360] Starting subtest: bad-vsync-end
[268.580284] Subtest bad-vsync-end: SKIP (0.000s)
[268.662637] [116/130] (785s left) gem_exec_suspend (basic)
[268.778123] Starting subtest: basic
[268.779060] Starting dynamic subtest: smem
[269.822595] Dynamic subtest smem: SUCCESS (1.043s)
[269.823785] Subtest basic: SUCCESS (1.044s)
[270.018304] [117/130] (784s left) api_intel_bb (blit-noreloc-purge-cache)
[270.110840] Starting subtest: blit-noreloc-purge-cache
[270.127911] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[270.241784] [118/130] (784s left) kms_plane (pixel-format-source-clamping)
[270.384610] Starting subtest: pixel-format-source-clamping
[270.386363] Subtest pixel-format-source-clamping: SKIP (0.000s)
[270.471980] [119/130] (784s left) i915_query (query-topology-kernel-writes)
[270.563979] Starting subtest: query-topology-kernel-writes
[270.565255] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[270.652523] [120/130] (784s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[270.806546] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[270.890273] [121/130] (784s left) gem_exec_reloc (basic-cpu-active)
[270.999775] Starting subtest: basic-cpu-active
[271.142733] Subtest basic-cpu-active: SUCCESS (0.142s)
[271.265677] [122/130] (783s left) gem_exec_fence (concurrent)
[271.505334] Starting subtest: concurrent
[271.506560] Starting dynamic subtest: rcs0
[271.547558] Dynamic subtest rcs0: SUCCESS (0.042s)
[271.567596] Starting dynamic subtest: bcs0
[271.583887] Dynamic subtest bcs0: SUCCESS (0.037s)
[271.609019] Starting dynamic subtest: vcs0
[271.617223] Dynamic subtest vcs0: SUCCESS (0.033s)
[271.636059] Starting dynamic subtest: vecs0
[271.651653] Dynamic subtest vecs0: SUCCESS (0.033s)
[271.652896] Subtest concurrent: SUCCESS (0.148s)
[272.290143] [123/130] (782s left) perf (short-reads)
[272.498689] Starting subtest: short-reads
[272.550247] Subtest short-reads: SUCCESS (0.050s)
[272.640910] [124/130] (782s left) dumb_buffer (create-clear)
[272.733965] Starting subtest: create-clear
[314.340653] Subtest create-clear: SUCCESS (41.607s)
[314.449296] [125/130] (740s left) kms_psr2_su (page_flip-p010)
[314.543466] Subtest page_flip-P010: SKIP (0.000s)
[314.631530] [126/130] (740s left) i915_pm_rc6_residency (rc6-idle)
[314.724477] Starting subtest: rc6-idle
[314.760421] Subtest rc6-idle: SKIP (0.035s)
[314.871495] [127/130] (740s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[315.020247] Starting subtest: plane-scaler-unity-scaling-with-rotation
[315.021178] Starting dynamic subtest: pipe-A
[315.023246] Dynamic subtest pipe-A: SKIP (0.000s)
[315.041738] Starting dynamic subtest: pipe-B
[315.044316] Dynamic subtest pipe-B: SKIP (0.000s)
[315.062253] Starting dynamic subtest: pipe-C
[315.064117] Dynamic subtest pipe-C: SKIP (0.000s)
[315.065892] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.002s)
[315.143163] [128/130] (740s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[315.286989] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[315.379646] [129/130] (740s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[315.532601] Subtest cursor-vs-flip-legacy: SKIP (0.000s)
[315.612315] [130/130] (740s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[315.706508] Starting subtest: multi-wait-available-submitted-signaled
[315.708602] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[315.805329] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: core_getstats
results: parsing output: 9/ for test: i915_hangman
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_scaling_modes
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_tiled_blits
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_fbcon_fbt
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_basic
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: core_getclient
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_exec_suspend
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: dumb_buffer
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: syncobj_timeline
Done.