[89.249687] Initializing watchdogs
[89.249951]   /dev/watchdog0
[89.294512] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.308571] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.315264] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.320300] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[89.482652] Starting subtest: plane-upscale-20x20-with-rotation
[89.483627] Starting dynamic subtest: pipe-A
[89.485281] Dynamic subtest pipe-A: SKIP (0.000s)
[89.498131] Starting dynamic subtest: pipe-B
[89.499749] Dynamic subtest pipe-B: SKIP (0.000s)
[89.512650] Starting dynamic subtest: pipe-C
[89.514365] Dynamic subtest pipe-C: SKIP (0.000s)
[89.515924] Subtest plane-upscale-20x20-with-rotation: SKIP (0.001s)
[89.588255] [002/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[89.736113] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[89.816395] [003/130] (960s left) kms_big_fb (linear-8bpp-rotate-180)
[89.963263] Subtest linear-8bpp-rotate-180: SKIP (0.000s)
[90.034318] [004/130] (960s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[90.188493] Starting subtest: blocking-absolute-wf_vblank-interruptible
[90.191351] Subtest blocking-absolute-wf_vblank-interruptible: SKIP (0.002s)
[90.283851] [005/130] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[90.437062] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[90.522525] [006/130] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[90.669827] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[90.750578] [007/130] (959s left) gem_ctx_exec (basic-norecovery)
[90.847983] Starting subtest: basic-norecovery
[90.882327] Subtest basic-norecovery: SUCCESS (0.035s)
[91.002820] [008/130] (959s left) kms_psr (psr-primary-page-flip)
[91.147370] Subtest psr-primary-page-flip: SKIP (0.000s)
[91.223402] [009/130] (959s left) core_getstats
[91.389696] [010/130] (959s left) i915_hangman (detector)
[91.514324] Starting subtest: detector
[91.515325] Starting dynamic subtest: rcs0
[101.300076] Dynamic subtest rcs0: SUCCESS (9.785s)
[101.313975] Starting dynamic subtest: bcs0
[111.234829] Dynamic subtest bcs0: SUCCESS (9.933s)
[111.248990] Starting dynamic subtest: vcs0
[121.224669] Dynamic subtest vcs0: SUCCESS (9.990s)
[121.239543] Starting dynamic subtest: vecs0
[131.191521] Dynamic subtest vecs0: SUCCESS (9.967s)
[131.192993] Subtest detector: SUCCESS (39.679s)
[131.314645] [011/130] (919s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[131.463982] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[131.534911] [012/130] (919s left) gem_lmem_swapping (parallel-random-engines)
[131.643254] Subtest parallel-random-engines: SKIP (0.000s)
[131.718813] [013/130] (918s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[131.867073] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[131.947513] [014/130] (918s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[132.092345] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[132.163047] [015/130] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[132.309849] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[132.395974] [016/130] (918s left) gem_ctx_persistence (legacy-engines-hostile)
[132.501189] Starting subtest: legacy-engines-hostile
[132.502249] Starting dynamic subtest: render
[132.607818] Dynamic subtest render: SUCCESS (0.105s)
[132.623087] Starting dynamic subtest: bsd
[132.706827] Dynamic subtest bsd: SUCCESS (0.097s)
[132.722296] Starting dynamic subtest: blt
[132.805892] Dynamic subtest blt: SUCCESS (0.096s)
[132.820314] Starting dynamic subtest: vebox
[132.902146] Dynamic subtest vebox: SUCCESS (0.094s)
[132.903351] Subtest legacy-engines-hostile: SUCCESS (0.401s)
[132.982652] [017/130] (918s left) prime_vgem (shrink)
[133.135995] Starting subtest: shrink
[133.156768] Subtest shrink: SUCCESS (0.020s)
[133.261549] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[133.265337] [018/130] (917s left) gem_exec_schedule (preempt-queue-chain)
[133.391238] Starting subtest: preempt-queue-chain
[133.392111] Starting dynamic subtest: rcs0
[133.770679] Dynamic subtest rcs0: SUCCESS (0.380s)
[133.788796] Starting dynamic subtest: bcs0
[134.153768] Dynamic subtest bcs0: SUCCESS (0.382s)
[134.171821] Starting dynamic subtest: vcs0
[134.531204] Dynamic subtest vcs0: SUCCESS (0.377s)
[134.554259] Starting dynamic subtest: vecs0
[134.906936] Dynamic subtest vecs0: SUCCESS (0.375s)
[134.908149] Subtest preempt-queue-chain: SUCCESS (1.517s)
[135.252881] [019/130] (915s left) kms_flip (flip-vs-panning-vs-hang)
[135.399141] Starting subtest: flip-vs-panning-vs-hang
[135.400897] Subtest flip-vs-panning-vs-hang: SKIP (0.001s)
[135.500138] [020/130] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[135.645803] Subtest cursor-rapid-movement-256x256: SKIP (0.000s)
[135.730244] [021/130] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[135.877154] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[135.967072] [022/130] (915s left) gem_exec_balancer (sliced)
[136.089678] Starting subtest: sliced
[140.209341] Subtest sliced: SUCCESS (4.120s)
[140.422802] [023/130] (911s left) kms_psr (fbc-psr-suspend)
[140.572976] Subtest fbc-psr-suspend: SKIP (0.000s)
[140.654516] [024/130] (910s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[140.799020] Subtest fbcpsr-stridechange: SKIP (0.000s)
[140.886956] [025/130] (910s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[141.034061] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[141.115318] [026/130] (910s left) gem_mmap_gtt (basic-read-write-distinct)
[141.208892] Starting subtest: basic-read-write-distinct
[141.241195] Subtest basic-read-write-distinct: SUCCESS (0.032s)
[141.349693] [027/130] (910s left) perf_pmu (busy-accuracy-2)
[141.452770] Starting subtest: busy-accuracy-2
[141.453944] Starting dynamic subtest: rcs0
[144.571784] Dynamic subtest rcs0: SUCCESS (3.118s)
[144.587344] Starting dynamic subtest: bcs0
[147.693564] Dynamic subtest bcs0: SUCCESS (3.120s)
[147.710176] Starting dynamic subtest: vcs0
[150.806927] Dynamic subtest vcs0: SUCCESS (3.113s)
[150.823695] Starting dynamic subtest: vecs0
[153.926747] Dynamic subtest vecs0: SUCCESS (3.118s)
[153.928799] Subtest busy-accuracy-2: SUCCESS (12.472s)
[154.014867] [028/130] (897s left) gem_create (create-ext-set-pat)
[154.231477] Starting subtest: create-ext-set-pat
[154.234153] Subtest create-ext-set-pat: SKIP (0.000s)
[154.315736] [029/130] (897s left) gem_exec_reloc (basic-wc-cpu-active)
[154.421930] Starting subtest: basic-wc-cpu-active
[154.558680] Subtest basic-wc-cpu-active: SUCCESS (0.136s)
[154.677493] [030/130] (897s left) gem_ctx_persistence (userptr)
[154.782260] Starting subtest: userptr
[154.900136] Subtest userptr: SUCCESS (0.118s)
[154.987048] [031/130] (897s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[155.082960] Starting subtest: multi-wait-all-for-submit-unsubmitted
[155.192326] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[155.285519] [032/130] (897s left) gem_busy (close-race)
[155.404581] Starting subtest: close-race
[177.660641] Subtest close-race: SUCCESS (22.254s)
[178.012362] [033/130] (874s left) kms_addfb_basic (small-bo)
[178.268252] Starting subtest: small-bo
[178.269217] Subtest small-bo: SUCCESS (0.000s)
[178.370637] [034/130] (874s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[178.520910] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[178.614754] [035/130] (873s left) syncobj_timeline (invalid-transfer-non-existent-point)
[178.720612] Starting subtest: invalid-transfer-non-existent-point
[178.721608] Subtest invalid-transfer-non-existent-point: SUCCESS (0.001s)
[178.806135] [036/130] (873s left) kms_lease (lease-revoke)
[178.952468] Subtest lease-revoke: SKIP (0.000s)
[179.037098] [037/130] (873s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[179.186180] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[179.276193] [038/130] (873s left) gem_mmap_offset (partial-remap)
[179.368371] Starting subtest: partial-remap
[179.369320] Starting dynamic subtest: smem0
[179.384404] Dynamic subtest smem0: SUCCESS (0.013s)
[179.385347] Subtest partial-remap: SUCCESS (0.013s)
[179.487719] [039/130] (873s left) gem_exec_whisper (basic-fds-priority)
[179.613637] Starting subtest: basic-fds-priority
[189.247382] Subtest basic-fds-priority: SUCCESS (9.633s)
[189.452638] [040/130] (863s left) gem_softpin (allocator-nopin)
[189.559065] Starting subtest: allocator-nopin
[189.763195] Subtest allocator-nopin: SUCCESS (0.203s)
[189.878283] [041/130] (863s left) gem_exec_reloc (basic-concurrent16)
[189.986973] Starting subtest: basic-concurrent16
[195.460034] Subtest basic-concurrent16: SUCCESS (5.471s)
[195.606418] [042/130] (857s left) kms_vrr (negative-basic)
[195.752292] Subtest negative-basic: SKIP (0.000s)
[195.836454] [043/130] (857s left) syncobj_timeline (single-wait-all-signaled)
[195.930900] Starting subtest: single-wait-all-signaled
[195.932975] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[196.024370] [044/130] (857s left) kms_psr (fbc-psr2-primary-page-flip)
[196.173080] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[196.256558] [045/130] (857s left) kms_feature_discovery (display-4x)
[196.401654] Starting subtest: display-4x
[196.403583] Subtest display-4x: SKIP (0.000s)
[196.485455] [046/130] (857s left) kms_pm_rpm (universal-planes)
[197.833932] Starting subtest: universal-planes
[197.835447] Subtest universal-planes: SKIP (0.000s)
[197.919982] [047/130] (855s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[198.111952] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[198.195200] [048/130] (855s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[198.301082] Starting subtest: basic-cpu-gtt-noreloc
[198.314690] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.011s)
[198.434304] [049/130] (855s left) kms_scaling_modes (scaling-mode-full-aspect)
[198.580568] Subtest scaling-mode-full-aspect: SKIP (0.000s)
[198.666581] [050/130] (855s left) kms_color (degamma)
[198.812856] Starting subtest: degamma
[198.815028] Subtest degamma: SKIP (0.000s)
[198.898738] [051/130] (855s left) kms_cursor_crc (cursor-offscreen-256x85)
[199.045241] Subtest cursor-offscreen-256x85: SKIP (0.000s)
[199.130663] [052/130] (854s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[199.288589] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.000s)
[199.367923] [053/130] (854s left) perf_pmu (busy-start)
[199.472773] Starting subtest: busy-start
[199.473757] Starting dynamic subtest: rcs0
[202.003692] Dynamic subtest rcs0: SUCCESS (2.531s)
[202.021947] Starting dynamic subtest: bcs0
[204.533051] Dynamic subtest bcs0: SUCCESS (2.529s)
[204.552625] Starting dynamic subtest: vcs0
[207.063543] Dynamic subtest vcs0: SUCCESS (2.529s)
[207.093666] Starting dynamic subtest: vecs0
[209.594487] Dynamic subtest vecs0: SUCCESS (2.530s)
[209.596026] Subtest busy-start: SUCCESS (10.122s)
[209.690070] [054/130] (844s left) gem_spin_batch (spin-each)
[209.805513] Starting subtest: spin-each
[213.094358] Subtest spin-each: SUCCESS (3.288s)
[213.313980] [055/130] (841s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[213.461785] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[213.558975] [056/130] (840s left) kms_chamelium_frames (hdmi-crc-multiple)
[213.714240] Subtest hdmi-crc-multiple: SKIP (0.000s)
[213.800767] [057/130] (840s left) gen9_exec_parse (bb-start-out)
[213.919224] Starting subtest: bb-start-out
[213.921968] Subtest bb-start-out: SUCCESS (0.004s)
[214.158530] [058/130] (840s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[214.308837] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.000s)
[214.390422] [059/130] (840s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[214.538390] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[214.630924] [060/130] (840s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[214.777386] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[214.859852] [061/130] (840s left) kms_flip (absolute-wf_vblank)
[215.006014] Starting subtest: absolute-wf_vblank
[215.008750] Subtest absolute-wf_vblank: SKIP (0.002s)
[215.110985] [062/130] (839s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[215.205213] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[215.309921] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[215.406546] [063/130] (839s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[215.502657] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[215.504594] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[215.589575] [064/130] (839s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[215.745990] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[215.747840] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.001s)
[215.841864] [065/130] (839s left) kms_cursor_crc (cursor-onscreen-128x42)
[215.985187] Subtest cursor-onscreen-128x42: SKIP (0.000s)
[216.068417] [066/130] (839s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[216.212899] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[216.297807] [067/130] (839s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[216.444365] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[216.527887] [068/130] (838s left) kms_vblank (query-idle)
[216.676832] Subtest query-idle: SKIP (0.000s)
[216.761997] [069/130] (838s left) gem_exec_reloc (basic-cpu-read-active)
[216.867675] Starting subtest: basic-cpu-read-active
[217.005845] Subtest basic-cpu-read-active: SUCCESS (0.137s)
[217.161487] [070/130] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[217.311336] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.403204] [071/130] (838s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[217.555283] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[217.640210] [072/130] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[217.787989] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[217.878838] [073/130] (838s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[218.023624] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[218.113898] [074/130] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[218.260978] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[218.352445] [075/130] (837s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[218.497572] Subtest fbc-modesetfrombusy: SKIP (0.000s)
[218.592457] [076/130] (837s left) gem_tiled_blits (basic)
[218.843987] Starting subtest: basic
[218.887995] Subtest basic: SUCCESS (0.044s)
[219.033991] [077/130] (837s left) gem_eio (context-create)
[219.256309] Starting subtest: context-create
[219.299446] Subtest context-create: SUCCESS (0.041s)
[219.443615] [078/130] (836s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[219.551975] Starting subtest: x-tiled-to-vebox-y-tiled
[219.553835] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[219.749055] [079/130] (836s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[219.905130] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[219.990846] [080/130] (836s left) kms_plane_alpha_blend (alpha-7efc)
[220.136059] Starting subtest: alpha-7efc
[220.137697] Subtest alpha-7efc: SKIP (0.000s)
[220.234472] [081/130] (836s left) i915_selftest (perf)
[221.475377] Starting subtest: perf
[221.476490] Starting dynamic subtest: engine_cs
[226.055192] Dynamic subtest engine_cs: SUCCESS (4.580s)
[226.071774] Starting dynamic subtest: request
[231.950681] Dynamic subtest request: SUCCESS (5.894s)
[231.967052] Starting dynamic subtest: migrate
[236.619483] Dynamic subtest migrate: SUCCESS (4.668s)
[236.635891] Starting dynamic subtest: region
[240.537861] Dynamic subtest region: SUCCESS (3.918s)
[240.538877] Subtest perf: SUCCESS (19.064s)
[240.601563] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[240.604543] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[240.607612] [082/130] (816s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[244.993733] Subtest short-flip-before-cursor-toggle: SKIP (0.000s)
[245.073852] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[245.081336] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[245.086565] [083/130] (811s left) kms_pm_rpm (modeset-lpsp-stress)
[246.356440] Starting subtest: modeset-lpsp-stress
[246.496360] Subtest modeset-lpsp-stress: SKIP (0.139s)
[246.584287] [084/130] (810s left) gem_exec_flush (basic-wb-rw-before-default)
[246.742420] Starting subtest: basic-wb-rw-before-default
[252.187641] Subtest basic-wb-rw-before-default: SUCCESS (5.445s)
[252.415638] [085/130] (804s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[252.561168] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[252.644115] [086/130] (804s left) i915_query (query-regions-unallocated)
[252.736375] Starting subtest: query-regions-unallocated
[252.737626] Subtest query-regions-unallocated: SUCCESS (0.000s)
[252.824151] [087/130] (804s left) gem_exec_flush (basic-batch-kernel-default-wb)
[252.938615] Starting subtest: basic-batch-kernel-default-wb
[258.747642] Subtest basic-batch-kernel-default-wb: SUCCESS (5.808s)
[258.964551] [088/130] (798s left) syncobj_wait (multi-wait-all-signaled)
[259.061291] Starting subtest: multi-wait-all-signaled
[259.063772] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[259.146664] [089/130] (798s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[259.288315] Subtest fbc-dirtyfb-ioctl: SKIP (0.000s)
[259.373727] [090/130] (798s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[259.521811] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[259.602697] [091/130] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[259.748995] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[259.864517] [092/130] (797s left) kms_fbcon_fbt (fbc-suspend)
[259.960892] Starting subtest: fbc-suspend
[259.967995] Subtest fbc-suspend: SKIP (0.006s)
[260.051926] [093/130] (797s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[260.195161] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[260.277632] [094/130] (797s left) gem_exec_schedule (u-submit-early-slice)
[260.402065] Starting subtest: u-submit-early-slice
[260.403077] Starting dynamic subtest: rcs0
[260.470419] Dynamic subtest rcs0: SUCCESS (0.068s)
[260.491172] Starting dynamic subtest: bcs0
[260.530406] Dynamic subtest bcs0: SUCCESS (0.057s)
[260.550629] Starting dynamic subtest: vcs0
[260.579025] Dynamic subtest vcs0: SUCCESS (0.051s)
[260.598929] Starting dynamic subtest: vecs0
[260.633815] Dynamic subtest vecs0: SUCCESS (0.053s)
[260.635118] Subtest u-submit-early-slice: SUCCESS (0.233s)
[260.989681] [095/130] (796s left) vgem_basic (debugfs)
[261.082619] Starting subtest: debugfs
[261.083424] Subtest debugfs: SUCCESS (0.002s)
[261.165895] [096/130] (796s left) gen7_exec_parse (batch-without-end)
[261.270517] Subtest batch-without-end: SKIP (0.000s)
[261.357680] [097/130] (796s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[261.504277] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[261.595643] [098/130] (796s left) dmabuf_sync_file (export-basic)
[261.685626] Starting subtest: export-basic
[261.687807] Subtest export-basic: SUCCESS (0.003s)
[261.769273] [099/130] (796s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[261.913058] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[261.996443] [100/130] (796s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[262.149243] Subtest cursorB-vs-flipB-atomic: SKIP (0.000s)
[262.229472] [101/130] (796s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[262.325647] Starting subtest: cpuset-medium-copy-XY
[272.704664] Subtest cpuset-medium-copy-XY: SUCCESS (10.378s)
[272.831403] [102/130] (785s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[275.562236] Starting subtest: protected-encrypted-src-copy-not-readible
[275.564170] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[275.646333] [103/130] (782s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[275.800117] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[275.801774] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.000s)
[275.883638] [104/130] (782s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[276.031605] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[276.125770] [105/130] (782s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[276.768509] Starting subtest: syncobj-timeline-invalid-flags
[276.769750] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[277.005275] [106/130] (781s left) gem_basic (create-close)
[277.094940] Starting subtest: create-close
[277.096626] Subtest create-close: SUCCESS (0.000s)
[277.194957] [107/130] (781s left) api_intel_allocator (reloc-allocator)
[277.286535] Starting subtest: reloc-allocator
[277.287505] Starting dynamic subtest: basic
[277.294022] Dynamic subtest basic: SUCCESS (0.008s)
[277.311822] Starting dynamic subtest: parallel-one
[277.312781] Dynamic subtest parallel-one: SUCCESS (0.010s)
[277.330250] Starting dynamic subtest: print
[277.331310] Dynamic subtest print: SUCCESS (0.000s)
[277.348773] Starting dynamic subtest: reuse
[277.349746] Dynamic subtest reuse: SUCCESS (0.000s)
[277.367203] Starting dynamic subtest: fork-reopen-allocator
[277.368281] Dynamic subtest fork-reopen-allocator: SUCCESS (0.030s)
[277.369435] Subtest reloc-allocator: SUCCESS (0.051s)
[277.458028] [108/130] (781s left) kms_psr (pr-primary-blt)
[277.602957] Subtest pr-primary-blt: SKIP (0.000s)
[277.686932] [109/130] (781s left) gem_ctx_bad_destroy (double-destroy)
[277.779199] Starting subtest: double-destroy
[277.780054] Subtest double-destroy: SUCCESS (0.000s)
[277.866719] [110/130] (781s left) core_getclient
[278.043614] [111/130] (781s left) syncobj_wait (wait-all-delayed-signal)
[278.145452] Starting subtest: wait-all-delayed-signal
[278.249942] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[278.344155] [112/130] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[278.489959] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[278.582743] [113/130] (780s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[278.729601] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[278.812588] [114/130] (780s left) kms_async_flips (test-time-stamp)
[278.958012] Subtest test-time-stamp: SKIP (0.000s)
[279.041472] [115/130] (780s left) kms_invalid_mode (bad-vsync-end)
[279.186605] Starting subtest: bad-vsync-end
[279.188419] Subtest bad-vsync-end: SKIP (0.000s)
[279.272243] [116/130] (780s left) gem_exec_suspend (basic)
[279.388260] Starting subtest: basic
[279.389148] Starting dynamic subtest: smem
[280.431933] Dynamic subtest smem: SUCCESS (1.044s)
[280.432913] Subtest basic: SUCCESS (1.045s)
[280.631471] [117/130] (779s left) api_intel_bb (blit-noreloc-purge-cache)
[280.726382] Starting subtest: blit-noreloc-purge-cache
[280.744064] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[280.870604] [118/130] (779s left) kms_plane (pixel-format-source-clamping)
[281.016481] Starting subtest: pixel-format-source-clamping
[281.018279] Subtest pixel-format-source-clamping: SKIP (0.000s)
[281.101328] [119/130] (778s left) i915_query (query-topology-kernel-writes)
[281.193667] Starting subtest: query-topology-kernel-writes
[281.194589] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[281.278690] [120/130] (778s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[281.429839] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[281.512213] [121/130] (778s left) gem_exec_reloc (basic-cpu-active)
[281.620105] Starting subtest: basic-cpu-active
[281.762357] Subtest basic-cpu-active: SUCCESS (0.143s)
[281.885987] [122/130] (778s left) gem_exec_fence (concurrent)
[282.121024] Starting subtest: concurrent
[282.121998] Starting dynamic subtest: rcs0
[282.165761] Dynamic subtest rcs0: SUCCESS (0.043s)
[282.187530] Starting dynamic subtest: bcs0
[282.202419] Dynamic subtest bcs0: SUCCESS (0.036s)
[282.221367] Starting dynamic subtest: vcs0
[282.237448] Dynamic subtest vcs0: SUCCESS (0.034s)
[282.260947] Starting dynamic subtest: vecs0
[282.270355] Dynamic subtest vecs0: SUCCESS (0.032s)
[282.271300] Subtest concurrent: SUCCESS (0.150s)
[282.905296] [123/130] (777s left) perf (short-reads)
[283.112636] Starting subtest: short-reads
[283.165032] Subtest short-reads: SUCCESS (0.048s)
[283.248879] [124/130] (777s left) dumb_buffer (create-clear)
[283.341207] Starting subtest: create-clear
[323.884570] Subtest create-clear: SUCCESS (40.541s)
[324.223394] [125/130] (736s left) kms_psr2_su (page_flip-p010)
[324.327546] Subtest page_flip-P010: SKIP (0.000s)
[324.419756] [126/130] (736s left) i915_pm_rc6_residency (rc6-idle)
[324.510306] Starting subtest: rc6-idle
[324.548820] Subtest rc6-idle: SKIP (0.038s)
[324.656702] [127/130] (736s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[324.800112] Starting subtest: plane-scaler-unity-scaling-with-rotation
[324.800962] Starting dynamic subtest: pipe-A
[324.802492] Dynamic subtest pipe-A: SKIP (0.000s)
[324.820926] Starting dynamic subtest: pipe-B
[324.823028] Dynamic subtest pipe-B: SKIP (0.000s)
[324.840665] Starting dynamic subtest: pipe-C
[324.842381] Dynamic subtest pipe-C: SKIP (0.000s)
[324.844021] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.002s)
[324.923592] [128/130] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[325.067773] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[325.165510] [129/130] (735s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[325.318198] Subtest cursor-vs-flip-legacy: SKIP (0.000s)
[325.398548] [130/130] (735s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[325.494844] Starting subtest: multi-wait-available-submitted-signaled
[325.496924] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[325.584511] 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.