[43.968861] Initializing watchdogs
[43.968922]   /dev/watchdog0
[43.984847] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.990540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.993010] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.994940] [001/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[44.033397] Starting subtest: invalid-multi-wait-unsubmitted
[44.034114] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[44.109599] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[44.201687] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[44.203092] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[44.300449] [003/133] (960s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[44.385722] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[44.386429] Starting dynamic subtest: pipe-A-HDMI-A-1
[44.393165] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[44.398946] Starting dynamic subtest: pipe-B-HDMI-A-1
[44.405734] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[44.411336] Starting dynamic subtest: pipe-C-HDMI-A-1
[44.418035] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[44.423720] Starting dynamic subtest: pipe-D-HDMI-A-1
[44.430614] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[44.431964] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[44.622873] [004/133] (959s left) gem_mmap_gtt (basic-small-copy-odd)
[44.660010] Starting subtest: basic-small-copy-odd
[46.519343] Subtest basic-small-copy-odd: SUCCESS (1.860s)
[46.581187] [005/133] (958s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[46.716244] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[46.716940] Starting dynamic subtest: pipe-A-valid-mode
[47.513684] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.796s)
[47.514388] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.797s)
[47.644682] [006/133] (957s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[47.747662] Starting subtest: yf-tiled-32bpp-rotate-180
[47.749098] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[47.840919] [007/133] (956s left) syncobj_timeline (single-wait-available-signaled)
[47.883547] Starting subtest: single-wait-available-signaled
[47.884357] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[47.955742] [008/133] (956s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[48.045727] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[57.037303] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.906s)
[57.179962] [009/133] (947s left) gem_softpin (softpin)
[57.228962] Starting subtest: softpin
[89.570461] Subtest softpin: SUCCESS (32.297s)
[89.666400] [010/133] (915s left) gem_mmap_wc (read)
[89.700163] Starting subtest: read
[89.707748] Subtest read: SUCCESS (0.008s)
[89.804619] [011/133] (915s left) gem_flink_basic (basic)
[89.838728] Starting subtest: basic
[89.839400] Subtest basic: SUCCESS (0.000s)
[89.951627] [012/133] (914s left) gem_exec_params (invalid-bsd1-flag-on-render)
[89.989474] Starting subtest: invalid-bsd1-flag-on-render
[89.990206] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[90.087259] [013/133] (914s left) gem_mmap_gtt (cpuset-big-copy)
[90.119710] Starting subtest: cpuset-big-copy
[102.276232] Subtest cpuset-big-copy: SUCCESS (12.155s)
[102.351190] [014/133] (902s left) perf_pmu (busy-idle-check-all)
[102.437397] Starting subtest: busy-idle-check-all
[102.438108] Starting dynamic subtest: rcs0
[103.058069] Dynamic subtest rcs0: SUCCESS (0.619s)
[103.067721] Starting dynamic subtest: bcs0
[103.681229] Dynamic subtest bcs0: SUCCESS (0.622s)
[103.690988] Starting dynamic subtest: vcs0
[104.304269] Dynamic subtest vcs0: SUCCESS (0.623s)
[104.314845] Starting dynamic subtest: vcs1
[104.927251] Dynamic subtest vcs1: SUCCESS (0.621s)
[104.936917] Starting dynamic subtest: vecs0
[105.549892] Dynamic subtest vecs0: SUCCESS (0.623s)
[105.550985] Subtest busy-idle-check-all: SUCCESS (3.112s)
[105.621836] [015/133] (899s left) gem_render_copy_redux (flink)
[105.661197] Starting subtest: flink
[106.429701] Subtest flink: SUCCESS (0.769s)
[106.553152] [016/133] (898s left) kms_psr (fbc-psr-primary-blt)
[106.645833] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[106.688676] [017/133] (898s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[106.778509] Starting subtest: fbc-rgb565-draw-mmap-cpu
[108.056556] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (1.278s)
[108.222862] [018/133] (896s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[108.315431] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[108.316791] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[108.398232] [019/133] (896s left) gem_ctx_param (invalid-size-get)
[108.432786] Starting subtest: invalid-size-get
[108.433509] Subtest invalid-size-get: SUCCESS (0.000s)
[108.489534] [020/133] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[108.577548] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[108.578932] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[108.686604] [021/133] (896s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[108.774291] Starting subtest: flip-vs-cursor-atomic
[115.148949] Subtest flip-vs-cursor-atomic: SUCCESS (6.374s)
[115.286439] [022/133] (890s left) kms_vblank (wait-busy-hang)
[115.378741] Starting subtest: wait-busy-hang
[115.379471] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.679193] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.299s)
[129.688628] Starting dynamic subtest: pipe-D-HDMI-A-1
[143.492068] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.810s)
[143.492852] Subtest wait-busy-hang: SUCCESS (28.114s)
[143.654601] [023/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[143.747545] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[143.748958] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.850206] [024/133] (861s left) i915_query (test-query-geometry-subslices)
[143.884995] Starting subtest: test-query-geometry-subslices
[143.886439] Subtest test-query-geometry-subslices: SKIP (0.000s)
[143.937617] [025/133] (861s left) kms_chamelium_frames (hdmi-frame-dump)
[144.078877] Subtest hdmi-frame-dump: SKIP (0.000s)
[144.166586] [026/133] (861s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[144.257853] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[144.452945] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.195s)
[144.605937] [027/133] (860s left) kms_psr (psr-dpms)
[144.697708] Subtest psr-dpms: SKIP (0.000s)
[144.738258] [028/133] (860s left) perf (buffer-fill)
[144.832567] Starting subtest: buffer-fill
[144.833308] Starting dynamic subtest: 0-rcs0
[147.103312] Dynamic subtest 0-rcs0: SUCCESS (2.262s)
[147.104040] Subtest buffer-fill: SUCCESS (2.263s)
[147.132951] [029/133] (858s left) kms_feature_discovery (display)
[147.235555] Starting subtest: display
[147.236267] Subtest display: SUCCESS (0.000s)
[147.306122] [030/133] (858s left) syncobj_wait (invalid-single-wait-unsubmitted)
[147.339943] Starting subtest: invalid-single-wait-unsubmitted
[147.340740] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[147.403503] [031/133] (858s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[147.438049] Starting subtest: multi-wait-for-submit-submitted-signaled
[147.439653] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[147.492757] [032/133] (858s left) gem_exec_reloc (basic-concurrent0)
[147.532749] Starting subtest: basic-concurrent0
[152.975146] Subtest basic-concurrent0: SUCCESS (5.398s)
[153.060678] [033/133] (852s left) core_getversion (all-cards)
[153.094041] Starting subtest: all-cards
[153.104957] Subtest all-cards: SUCCESS (0.012s)
[153.140760] [034/133] (852s left) gem_request_retire (retire-vma-not-inactive)
[153.178162] Starting subtest: retire-vma-not-inactive
[153.190681] Subtest retire-vma-not-inactive: SUCCESS (0.012s)
[153.318158] [035/133] (852s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[153.406989] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[153.408556] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[153.506621] [036/133] (852s left) gem_exec_schedule (timeslicing)
[153.551336] Starting subtest: timeslicing
[153.552119] Starting dynamic subtest: rcs0
[153.554921] Dynamic subtest rcs0: SUCCESS (0.003s)
[153.563180] Starting dynamic subtest: bcs0
[153.563896] Dynamic subtest bcs0: SUCCESS (0.003s)
[153.572141] Starting dynamic subtest: vcs0
[153.572855] Dynamic subtest vcs0: SUCCESS (0.003s)
[153.580100] Starting dynamic subtest: vcs1
[153.580808] Dynamic subtest vcs1: SUCCESS (0.003s)
[153.587579] Starting dynamic subtest: vecs0
[153.588273] Dynamic subtest vecs0: SUCCESS (0.003s)
[153.589008] Subtest timeslicing: SUCCESS (0.017s)
[153.875198] [037/133] (852s left) kms_psr (pr-sprite-render)
[153.960400] Subtest pr-sprite-render: SKIP (0.000s)
[153.999198] [038/133] (851s left) kms_frontbuffer_tracking (basic)
[154.087578] Starting subtest: basic
[155.719925] Subtest basic: SUCCESS (1.633s)
[155.826669] [039/133] (850s left) prime_vgem (sync)
[155.924734] Starting subtest: sync
[155.925529] Starting dynamic subtest: rcs0
[155.957561] Dynamic subtest rcs0: SUCCESS (0.032s)
[155.968139] Starting dynamic subtest: bcs0
[155.983783] Dynamic subtest bcs0: SUCCESS (0.025s)
[155.997567] Starting dynamic subtest: vcs0
[156.013518] Dynamic subtest vcs0: SUCCESS (0.029s)
[156.024976] Starting dynamic subtest: vcs1
[156.029763] Dynamic subtest vcs1: SUCCESS (0.015s)
[156.037144] Starting dynamic subtest: vecs0
[156.044646] Dynamic subtest vecs0: SUCCESS (0.014s)
[156.045355] Subtest sync: SUCCESS (0.120s)
[156.162233] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[156.163844] [040/133] (849s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[156.250707] Starting subtest: cursorA-vs-flipA-atomic
[167.103820] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.852s)
[167.239888] [041/133] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[167.334636] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[167.336048] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[167.432481] [042/133] (838s left) prime_vgem (basic-gtt)
[167.473086] Starting subtest: basic-gtt
[167.486775] Subtest basic-gtt: SUCCESS (0.014s)
[167.583399] [043/133] (838s left) gem_ctx_persistence (hostile)
[167.621007] Starting subtest: hostile
[170.400355] Subtest hostile: SUCCESS (2.771s)
[170.513975] [044/133] (835s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[170.652857] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[170.743974] [045/133] (835s left) kms_frontbuffer_tracking (psr-1p-rte)
[170.836883] Starting subtest: psr-1p-rte
[170.838444] Subtest psr-1p-rte: SKIP (0.000s)
[170.936156] [046/133] (835s left) kms_psr (fbc-pr-primary-mmap-gtt)
[171.021883] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[171.067595] [047/133] (835s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[171.154741] Starting subtest: cursorB-vs-flipB-atomic
[171.157057] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[171.219606] [048/133] (835s left) gem_eio (in-flight-internal-10ms)
[171.263880] Starting subtest: in-flight-internal-10ms
[171.536516] Subtest in-flight-internal-10ms: SUCCESS (0.272s)
[171.652171] [049/133] (834s left) kms_cursor_crc (cursor-offscreen-64x64)
[171.741232] Starting subtest: cursor-offscreen-64x64
[171.745535] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.989450] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.243s)
[173.025436] Starting dynamic subtest: pipe-D-HDMI-A-1
[174.232813] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.217s)
[174.233603] Subtest cursor-offscreen-64x64: SUCCESS (2.492s)
[174.390984] [050/133] (831s left) gen7_exec_parse (oacontrol-tracking)
[174.432405] Subtest oacontrol-tracking: SKIP (0.000s)
[174.474645] [051/133] (831s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[174.561582] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[174.562301] Starting dynamic subtest: pipe-A-valid-mode
[175.778405] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.216s)
[175.779101] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.217s)
[175.919641] [052/133] (830s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[176.010823] Starting subtest: disable-crc-after-crtc
[176.012433] Starting dynamic subtest: pipe-A-HDMI-A-1
[176.358353] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.346s)
[176.368406] Starting dynamic subtest: pipe-B-HDMI-A-1
[176.675497] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.314s)
[176.684864] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.003870] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.326s)
[177.013733] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.337981] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.332s)
[177.338780] Subtest disable-crc-after-crtc: SUCCESS (1.327s)
[177.468309] [053/133] (829s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[177.558785] Starting subtest: primary-yf-tiled-reflect-x-0
[177.610415] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.051s)
[177.701332] [054/133] (828s left) gem_ctx_persistence (engines-hang)
[177.739812] Starting subtest: engines-hang
[177.740650] Starting dynamic subtest: rcs0
[177.773599] Dynamic subtest rcs0: SUCCESS (0.034s)
[177.789412] Starting dynamic subtest: bcs0
[177.825649] Dynamic subtest bcs0: SUCCESS (0.051s)
[177.846382] Starting dynamic subtest: vcs0
[177.871671] Dynamic subtest vcs0: SUCCESS (0.044s)
[177.889552] Starting dynamic subtest: vcs1
[177.924615] Dynamic subtest vcs1: SUCCESS (0.051s)
[177.944161] Starting dynamic subtest: vecs0
[177.971544] Dynamic subtest vecs0: SUCCESS (0.045s)
[177.972710] Subtest engines-hang: SUCCESS (0.233s)
[178.058598] [055/133] (828s left) gem_eio (in-flight-1us)
[178.101778] Starting subtest: in-flight-1us
[180.348598] Subtest in-flight-1us: SUCCESS (2.248s)
[180.472076] [056/133] (826s left) gem_mmap_wc (pf-nonblock)
[180.506662] Starting subtest: pf-nonblock
[180.508354] Subtest pf-nonblock: SUCCESS (0.002s)
[180.608025] [057/133] (826s left) kms_flip (plain-flip-fb-recreate-interruptible)
[180.697331] Starting subtest: plain-flip-fb-recreate-interruptible
[180.700149] Starting dynamic subtest: A-HDMI-A1
[188.494653] Dynamic subtest A-HDMI-A1: SUCCESS (7.794s)
[188.511332] Starting dynamic subtest: B-HDMI-A1
[196.273252] Dynamic subtest B-HDMI-A1: SUCCESS (7.776s)
[196.289158] Starting dynamic subtest: C-HDMI-A1
[204.050449] Dynamic subtest C-HDMI-A1: SUCCESS (7.775s)
[204.068391] Starting dynamic subtest: D-HDMI-A1
[211.834335] Dynamic subtest D-HDMI-A1: SUCCESS (7.781s)
[211.839357] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.142s)
[212.018310] [058/133] (794s left) gem_exec_reloc (basic-wc-gtt-active)
[212.057714] Starting subtest: basic-wc-gtt-active
[212.191530] Subtest basic-wc-gtt-active: SUCCESS (0.124s)
[212.305140] [059/133] (794s left) kms_async_flips (async-flip-hang)
[212.390945] Starting subtest: async-flip-hang
[212.506242] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.450676] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.910s)
[227.556927] Starting dynamic subtest: pipe-B-HDMI-A-1
[242.810546] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (15.226s)
[242.902910] Starting dynamic subtest: pipe-C-HDMI-A-1
[257.659152] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.730s)
[257.759344] Starting dynamic subtest: pipe-D-HDMI-A-1
[272.506232] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.720s)
[272.506980] Subtest async-flip-hang: SUCCESS (60.081s)
[272.704096] [060/133] (734s left) gem_exec_flush (basic-wb-set-default)
[272.750098] Starting subtest: basic-wb-set-default
[278.174832] Subtest basic-wb-set-default: SUCCESS (5.426s)
[278.389874] [061/133] (728s left) kms_cursor_edge_walk (128x128-top-edge)
[278.484911] Starting subtest: 128x128-top-edge
[278.486712] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.205584] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.719s)
[280.218041] Starting dynamic subtest: pipe-D-HDMI-A-1
[281.888847] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.682s)
[281.889629] Subtest 128x128-top-edge: SUCCESS (3.405s)
[281.997642] [062/133] (724s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[282.106332] Starting subtest: x-tiled-8bpp-rotate-180
[283.093098] Subtest x-tiled-8bpp-rotate-180: SUCCESS (0.986s)
[283.215756] [063/133] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[283.309742] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[283.311216] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[283.426743] [064/133] (723s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[283.516024] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[283.516726] Starting dynamic subtest: pipe-A-HDMI-A-1
[283.523305] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[283.531558] Starting dynamic subtest: pipe-B-HDMI-A-1
[283.538264] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[283.546384] Starting dynamic subtest: pipe-C-HDMI-A-1
[283.552985] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[283.561149] Starting dynamic subtest: pipe-D-HDMI-A-1
[283.568040] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[283.569423] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[283.763753] [065/133] (723s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[283.862930] Starting subtest: 4-tiled-32bpp-rotate-180
[283.864350] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[283.953509] [066/133] (723s left) gem_exec_fence (syncobj-channel)
[284.292062] Starting subtest: syncobj-channel
[285.322883] Subtest syncobj-channel: SUCCESS (1.022s)
[285.623524] [067/133] (721s left) kms_mmap_write_crc (main)
[285.722397] Starting subtest: main
[285.724591] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.102927] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.378s)
[287.103658] Subtest main: SUCCESS (1.381s)
[287.270479] [068/133] (719s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[287.370429] Starting subtest: y-tiled-32bpp-rotate-180
[288.438470] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.067s)
[288.577572] [069/133] (718s left) kms_pm_rpm (fences-dpms)
[289.988326] Starting subtest: fences-dpms
[294.686333] Subtest fences-dpms: SUCCESS (4.692s)
[294.781896] [070/133] (712s left) gem_ctx_param (set-priority-range)
[294.819693] Starting subtest: set-priority-range
[294.837848] Subtest set-priority-range: SUCCESS (0.019s)
[294.937576] [071/133] (712s left) api_intel_allocator (alloc-simple)
[294.971797] Starting subtest: alloc-simple
[294.973764] Subtest alloc-simple: SUCCESS (0.001s)
[295.078405] [072/133] (712s left) gem_exec_schedule (preempt-other-chain)
[295.124522] Starting subtest: preempt-other-chain
[295.125263] Starting dynamic subtest: rcs0
[295.166275] Dynamic subtest rcs0: SUCCESS (0.041s)
[295.176203] Starting dynamic subtest: bcs0
[295.206564] Dynamic subtest bcs0: SUCCESS (0.039s)
[295.216771] Starting dynamic subtest: vcs0
[295.248945] Dynamic subtest vcs0: SUCCESS (0.041s)
[295.259732] Starting dynamic subtest: vcs1
[295.288022] Dynamic subtest vcs1: SUCCESS (0.037s)
[295.297023] Starting dynamic subtest: vecs0
[295.325476] Dynamic subtest vecs0: SUCCESS (0.037s)
[295.326224] Subtest preempt-other-chain: SUCCESS (0.202s)
[295.665101] [073/133] (711s left) kms_addfb_basic (too-wide)
[295.755191] Starting subtest: too-wide
[295.755969] Subtest too-wide: SUCCESS (0.000s)
[295.860557] [074/133] (711s left) gem_userptr_blits (set-cache-level)
[295.900882] Starting subtest: set-cache-level
[295.901597] Subtest set-cache-level: SUCCESS (0.000s)
[296.029785] [075/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[296.121448] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[296.122923] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[296.193530] [076/133] (711s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[296.281255] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[296.281960] Starting dynamic subtest: pipe-A-HDMI-A-1
[296.284687] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[296.293165] Starting dynamic subtest: pipe-B-HDMI-A-1
[296.295915] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[296.304288] Starting dynamic subtest: pipe-C-HDMI-A-1
[296.307036] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[296.315397] Starting dynamic subtest: pipe-D-HDMI-A-1
[296.318122] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[296.319479] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[296.520988] [077/133] (711s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[296.614390] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[296.623878] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[296.685400] [078/133] (710s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[296.774432] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[296.775909] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[296.835218] [079/133] (710s left) gem_exec_params (rsvd2-dirt)
[296.873694] Starting subtest: rsvd2-dirt
[296.875104] Subtest rsvd2-dirt: SKIP (0.000s)
[296.960832] [080/133] (710s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[297.048124] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[297.048807] Starting dynamic subtest: pipe-A-HDMI-A-1
[297.066267] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[297.074950] Starting dynamic subtest: pipe-B-HDMI-A-1
[297.092795] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[297.101354] Starting dynamic subtest: pipe-C-HDMI-A-1
[297.119208] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[297.128726] Starting dynamic subtest: pipe-D-HDMI-A-1
[297.146675] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[297.148062] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[297.290876] [081/133] (710s left) kms_big_fb (linear-16bpp-rotate-90)
[297.389093] Starting subtest: linear-16bpp-rotate-90
[297.468387] Subtest linear-16bpp-rotate-90: SKIP (0.079s)
[297.574752] [082/133] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[297.664815] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[297.666302] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[297.775471] [083/133] (710s left) kms_chamelium_audio (dp-audio)
[297.919754] Subtest dp-audio: SKIP (0.000s)
[298.014326] [084/133] (709s left) gem_bad_reloc (negative-reloc-lut)
[298.058094] Starting subtest: negative-reloc-lut
[298.060354] Subtest negative-reloc-lut: SUCCESS (0.000s)
[298.158369] [085/133] (709s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[298.250790] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[298.293557] [086/133] (709s left) i915_hangman (detector)
[298.337496] Starting subtest: detector
[298.338197] Starting dynamic subtest: rcs0
[308.064271] Dynamic subtest rcs0: SUCCESS (9.726s)
[308.074397] Starting dynamic subtest: bcs0
[318.027747] Dynamic subtest bcs0: SUCCESS (9.962s)
[318.046300] Starting dynamic subtest: vcs0
[328.009210] Dynamic subtest vcs0: SUCCESS (9.979s)
[328.030487] Starting dynamic subtest: vcs1
[338.049773] Dynamic subtest vcs1: SUCCESS (10.037s)
[338.063884] Starting dynamic subtest: vecs0
[348.044983] Dynamic subtest vecs0: SUCCESS (9.993s)
[348.048650] Subtest detector: SUCCESS (49.709s)
[348.174972] [087/133] (659s left) sysfs_heartbeat_interval (mixed)
[348.215289] Starting subtest: mixed
[348.217345] Starting dynamic subtest: vecs0
[353.381755] Dynamic subtest vecs0: SUCCESS (5.165s)
[353.392977] Starting dynamic subtest: vcs0
[358.525149] Dynamic subtest vcs0: SUCCESS (5.140s)
[358.545155] Starting dynamic subtest: bcs0
[363.681260] Dynamic subtest bcs0: SUCCESS (5.153s)
[363.693622] Starting dynamic subtest: rcs0
[368.843211] Dynamic subtest rcs0: SUCCESS (5.159s)
[368.857927] Starting dynamic subtest: vcs1
[373.986209] Dynamic subtest vcs1: SUCCESS (5.140s)
[373.989512] Subtest mixed: SUCCESS (25.772s)
[374.071039] [088/133] (633s left) kms_universal_plane (universal-plane-pageflip-windowed)
[374.163031] Starting subtest: universal-plane-pageflip-windowed
[374.163778] Starting dynamic subtest: pipe-A-HDMI-A-1
[374.439730] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.276s)
[374.449594] Starting dynamic subtest: pipe-B-HDMI-A-1
[374.696695] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.255s)
[374.707799] Starting dynamic subtest: pipe-C-HDMI-A-1
[374.943595] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.244s)
[374.953733] Starting dynamic subtest: pipe-D-HDMI-A-1
[375.188918] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.243s)
[375.189655] Subtest universal-plane-pageflip-windowed: SUCCESS (1.026s)
[375.314546] [089/133] (632s left) kms_dp_link_training (uhbr-sst)
[375.407937] Starting subtest: uhbr-sst
[375.409309] Subtest uhbr-sst: SKIP (0.000s)
[375.488370] [090/133] (632s left) gem_exec_balancer (bonded-pair)
[375.534281] Starting subtest: bonded-pair
[407.974697] Subtest bonded-pair: SUCCESS (32.433s)
[408.161526] [091/133] (599s left) gem_exec_fence (invalid-fence-array)
[408.483047] Starting subtest: invalid-fence-array
[408.485465] Subtest invalid-fence-array: SUCCESS (0.002s)
[408.812102] [092/133] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[408.906486] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[408.907865] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[409.005617] [093/133] (599s left) kms_psr (psr-cursor-plane-onoff)
[409.095786] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[409.141013] [094/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[409.232045] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[409.233442] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[409.330913] [095/133] (598s left) kms_busy (basic)
[409.423242] Starting subtest: basic
[409.423984] Starting dynamic subtest: flip
[409.766238] Dynamic subtest flip: SUCCESS (0.341s)
[409.776384] Starting dynamic subtest: modeset
[410.338954] Dynamic subtest modeset: SUCCESS (0.572s)
[410.339772] Subtest basic: SUCCESS (0.917s)
[410.468952] [096/133] (597s left) gem_exec_async (forked-writes)
[410.518494] Starting subtest: forked-writes
[410.519301] Starting dynamic subtest: rcs0
[410.545378] Dynamic subtest rcs0: SUCCESS (0.026s)
[410.556761] Starting dynamic subtest: bcs0
[410.571670] Dynamic subtest bcs0: SUCCESS (0.025s)
[410.582962] Starting dynamic subtest: vcs0
[410.598338] Dynamic subtest vcs0: SUCCESS (0.025s)
[410.609973] Starting dynamic subtest: vcs1
[410.624781] Dynamic subtest vcs1: SUCCESS (0.025s)
[410.637572] Starting dynamic subtest: vecs0
[410.654714] Dynamic subtest vecs0: SUCCESS (0.028s)
[410.655510] Subtest forked-writes: SUCCESS (0.137s)
[410.845763] [097/133] (597s left) prime_vgem (coherency-gtt)
[410.893631] Starting subtest: coherency-gtt
[410.895058] Subtest coherency-gtt: SKIP (0.000s)
[411.002329] [098/133] (597s left) kms_properties (colorop-properties-legacy)
[411.095461] Starting subtest: colorop-properties-legacy
[411.096207] Starting dynamic subtest: pipe-A-HDMI-A-1
[411.168831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.073s)
[411.178986] Starting dynamic subtest: pipe-B-HDMI-A-1
[411.296777] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.125s)
[411.307539] Starting dynamic subtest: pipe-C-HDMI-A-1
[411.423182] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.125s)
[411.433321] Starting dynamic subtest: pipe-D-HDMI-A-1
[411.542842] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.117s)
[411.543550] Subtest colorop-properties-legacy: SUCCESS (0.448s)
[411.670631] [099/133] (596s left) gem_mmap_wc (set-cache-level)
[411.710292] Starting subtest: set-cache-level
[411.711025] Subtest set-cache-level: SUCCESS (0.001s)
[411.820650] [100/133] (596s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[411.911866] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[411.913283] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[412.011874] [101/133] (596s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[412.099073] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[412.148044] [102/133] (596s left) syncobj_timeline (32bits-limit)
[412.182506] Starting subtest: 32bits-limit
[412.183212] Subtest 32bits-limit: SUCCESS (0.001s)
[412.243618] [103/133] (596s left) perf_pmu (busy-accuracy-98)
[412.280023] Starting subtest: busy-accuracy-98
[412.280758] Starting dynamic subtest: rcs0
[415.307008] Dynamic subtest rcs0: SUCCESS (3.025s)
[415.317281] Starting dynamic subtest: bcs0
[418.333584] Dynamic subtest bcs0: SUCCESS (3.024s)
[418.343380] Starting dynamic subtest: vcs0
[421.358972] Dynamic subtest vcs0: SUCCESS (3.024s)
[421.368545] Starting dynamic subtest: vcs1
[424.385160] Dynamic subtest vcs1: SUCCESS (3.027s)
[424.395215] Starting dynamic subtest: vecs0
[427.412750] Dynamic subtest vecs0: SUCCESS (3.025s)
[427.413722] Subtest busy-accuracy-98: SUCCESS (15.130s)
[427.501886] [104/133] (581s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[427.593091] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[427.594186] Starting dynamic subtest: pipe-A
[427.723858] Dynamic subtest pipe-A: SUCCESS (0.131s)
[427.736049] Starting dynamic subtest: pipe-B
[427.857063] Dynamic subtest pipe-B: SUCCESS (0.132s)
[427.867060] Starting dynamic subtest: pipe-C
[427.983032] Dynamic subtest pipe-C: SUCCESS (0.125s)
[427.993989] Starting dynamic subtest: pipe-D
[428.119212] Dynamic subtest pipe-D: SUCCESS (0.135s)
[428.121112] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.528s)
[428.294152] [105/133] (580s left) gem_exec_whisper (basic-normal-all)
[428.341860] Starting subtest: basic-normal-all
[429.460391] Subtest basic-normal-all: SUCCESS (1.119s)
[429.665697] [106/133] (579s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[429.770358] Starting subtest: verify-pxp-execution-after-suspend-resume
[436.461957] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.693s)
[444.618533] [107/133] (572s left) gem_exec_reloc (basic-range-active)
[444.661039] Starting subtest: basic-range-active
[444.699996] Subtest basic-range-active: SUCCESS (0.039s)
[444.819054] [108/133] (572s left) kms_content_protection (dp-mst-type-1)
[444.909105] Starting subtest: dp-mst-type-1
[444.910638] Subtest dp-mst-type-1: SKIP (0.000s)
[445.004678] [109/133] (571s left) kms_invalid_mode (bad-htotal)
[445.092869] Starting subtest: bad-htotal
[445.093591] Starting dynamic subtest: pipe-A-HDMI-A-1
[445.146282] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s)
[445.157998] Starting dynamic subtest: pipe-B-HDMI-A-1
[445.158816] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[445.168167] Starting dynamic subtest: pipe-C-HDMI-A-1
[445.168886] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[445.178657] Starting dynamic subtest: pipe-D-HDMI-A-1
[445.179398] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[445.180121] Subtest bad-htotal: SUCCESS (0.065s)
[445.308662] [110/133] (571s left) gem_userptr_blits (unsync-unmap-after-close)
[445.352739] Subtest unsync-unmap-after-close: SKIP (0.000s)
[445.471525] [111/133] (571s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[445.568101] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[445.569526] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[445.664886] [112/133] (571s left) gem_exec_whisper (basic-queues-priority)
[445.709926] Starting subtest: basic-queues-priority
[447.953793] Subtest basic-queues-priority: SUCCESS (2.236s)
[448.133736] [113/133] (568s left) kms_flip (2x-flip-vs-suspend)
[448.222756] Starting subtest: 2x-flip-vs-suspend
[448.225317] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[448.312956] [114/133] (568s left) gem_ctx_engines (execute-one)
[448.356957] Starting subtest: execute-one
[449.608592] Subtest execute-one: SUCCESS (1.244s)
[449.786394] [115/133] (567s left) kms_color_pipeline (plane-ctm3x4)
[449.876475] Starting subtest: plane-ctm3x4
[449.961289] Starting dynamic subtest: pipe-A-plane-0
[450.051906] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[450.071557] Starting dynamic subtest: pipe-A-plane-1
[450.126827] Dynamic subtest pipe-A-plane-1: SUCCESS (0.073s)
[450.142243] Starting dynamic subtest: pipe-A-plane-2
[450.202072] Dynamic subtest pipe-A-plane-2: SUCCESS (0.073s)
[450.415759] Starting dynamic subtest: pipe-B-plane-0
[450.474729] Dynamic subtest pipe-B-plane-0: SUCCESS (0.074s)
[450.491801] Starting dynamic subtest: pipe-B-plane-1
[450.558159] Dynamic subtest pipe-B-plane-1: SUCCESS (0.081s)
[450.574691] Starting dynamic subtest: pipe-B-plane-2
[450.633553] Dynamic subtest pipe-B-plane-2: SUCCESS (0.073s)
[450.842443] Starting dynamic subtest: pipe-C-plane-0
[450.907458] Dynamic subtest pipe-C-plane-0: SUCCESS (0.075s)
[450.922722] Starting dynamic subtest: pipe-C-plane-1
[450.990768] Dynamic subtest pipe-C-plane-1: SUCCESS (0.081s)
[451.006183] Starting dynamic subtest: pipe-C-plane-2
[451.074290] Dynamic subtest pipe-C-plane-2: SUCCESS (0.082s)
[451.291971] Starting dynamic subtest: pipe-D-plane-0
[451.366053] Dynamic subtest pipe-D-plane-0: SUCCESS (0.083s)
[451.378429] Starting dynamic subtest: pipe-D-plane-1
[451.450227] Dynamic subtest pipe-D-plane-1: SUCCESS (0.082s)
[451.467047] Starting dynamic subtest: pipe-D-plane-2
[451.533354] Dynamic subtest pipe-D-plane-2: SUCCESS (0.081s)
[451.582545] Subtest plane-ctm3x4: SUCCESS (1.705s)
[451.690841] [116/133] (565s left) kms_plane (plane-position-hole-dpms)
[451.784016] Starting subtest: plane-position-hole-dpms
[452.004106] Starting dynamic subtest: pipe-A-plane-1
[452.346437] Dynamic subtest pipe-A-plane-1: SUCCESS (0.342s)
[452.357211] Starting dynamic subtest: pipe-A-plane-2
[452.711791] Dynamic subtest pipe-A-plane-2: SUCCESS (0.364s)
[452.722661] Starting dynamic subtest: pipe-A-plane-3
[453.057976] Dynamic subtest pipe-A-plane-3: SUCCESS (0.344s)
[453.071463] Starting dynamic subtest: pipe-A-plane-4
[453.397801] Dynamic subtest pipe-A-plane-4: SUCCESS (0.339s)
[453.410401] Starting dynamic subtest: pipe-A-plane-5
[453.737148] Dynamic subtest pipe-A-plane-5: SUCCESS (0.338s)
[453.750217] Starting dynamic subtest: pipe-A-plane-6
[454.093239] Dynamic subtest pipe-A-plane-6: SUCCESS (0.355s)
[454.103068] Starting dynamic subtest: pipe-A-plane-7
[454.104423] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[454.292208] Starting dynamic subtest: pipe-B-plane-1
[454.589063] Dynamic subtest pipe-B-plane-1: SUCCESS (0.307s)
[454.600583] Starting dynamic subtest: pipe-B-plane-2
[454.898741] Dynamic subtest pipe-B-plane-2: SUCCESS (0.309s)
[454.912036] Starting dynamic subtest: pipe-B-plane-3
[455.208514] Dynamic subtest pipe-B-plane-3: SUCCESS (0.309s)
[455.219364] Starting dynamic subtest: pipe-B-plane-4
[455.540303] Dynamic subtest pipe-B-plane-4: SUCCESS (0.329s)
[455.552353] Starting dynamic subtest: pipe-B-plane-5
[455.839695] Dynamic subtest pipe-B-plane-5: SUCCESS (0.300s)
[455.850737] Starting dynamic subtest: pipe-B-plane-6
[456.168904] Dynamic subtest pipe-B-plane-6: SUCCESS (0.327s)
[456.179770] Starting dynamic subtest: pipe-B-plane-7
[456.181182] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[456.181894] Subtest plane-position-hole-dpms: SUCCESS (4.388s)
[456.348609] [117/133] (560s left) kms_plane_cursor (primary)
[456.444521] Starting subtest: primary
[456.446058] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[457.658823] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.213s)
[457.701633] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[458.900778] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.216s)
[458.943136] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[460.142727] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.216s)
[460.228930] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[461.475549] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.258s)
[461.506198] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[462.708860] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.216s)
[462.741139] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[463.941862] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.216s)
[464.017273] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[465.265741] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.257s)
[465.301451] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[466.499409] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.216s)
[466.532866] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[467.732777] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.216s)
[467.810043] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[469.056967] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.257s)
[469.083294] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[470.290558] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.217s)
[470.322558] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[471.523940] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.216s)
[471.590398] Subtest primary: SUCCESS (15.145s)
[471.700931] [118/133] (545s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[471.800756] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[471.802218] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[471.897794] [119/133] (545s left) gen9_exec_parse (unaligned-access)
[471.935598] Subtest unaligned-access: SKIP (0.000s)
[471.984052] [120/133] (545s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[472.023991] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[472.024731] Starting dynamic subtest: smem
[472.147983] Dynamic subtest smem: SUCCESS (0.113s)
[472.148786] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.114s)
[472.326808] [121/133] (545s left) kms_cursor_crc (cursor-random-64x64)
[472.416453] Starting subtest: cursor-random-64x64
[472.422812] Starting dynamic subtest: pipe-A-HDMI-A-1
[474.334515] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.911s)
[474.376410] Starting dynamic subtest: pipe-D-HDMI-A-1
[476.242465] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.877s)
[476.243238] Subtest cursor-random-64x64: SUCCESS (3.827s)
[476.402837] [122/133] (541s left) dumb_buffer (create-valid-dumb)
[476.440910] Starting subtest: create-valid-dumb
[476.441612] Subtest create-valid-dumb: SUCCESS (0.000s)
[476.541242] [123/133] (541s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[476.575655] Starting subtest: etime-multi-wait-all-submitted-signaled
[476.680306] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[476.761285] [124/133] (540s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[476.871280] Starting subtest: 4-tiled-16bpp-rotate-180
[476.872757] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[476.966346] [125/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[477.057769] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[477.059173] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.143714] [126/133] (540s left) i915_pm_rc6_residency (rc6-idle)
[477.179177] Starting subtest: rc6-idle
[477.182831] Subtest rc6-idle: SKIP (0.004s)
[477.244917] [127/133] (540s left) kms_pm_rpm (universal-planes-dpms)
[478.641290] Starting subtest: universal-planes-dpms
[478.642351] Starting dynamic subtest: plane-35
[486.838510] Dynamic subtest plane-35: SUCCESS (8.196s)
[486.858302] Starting dynamic subtest: plane-65
[495.342700] Dynamic subtest plane-65: SUCCESS (8.500s)
[495.356091] Starting dynamic subtest: plane-95
[503.555713] Dynamic subtest plane-95: SUCCESS (8.210s)
[503.571866] Starting dynamic subtest: plane-125
[511.860922] Dynamic subtest plane-125: SUCCESS (8.302s)
[511.876008] Starting dynamic subtest: plane-135
[520.372055] Dynamic subtest plane-135: SUCCESS (8.508s)
[520.384975] Starting dynamic subtest: plane-145
[528.648990] Dynamic subtest plane-145: SUCCESS (8.274s)
[528.661761] Starting dynamic subtest: plane-155
[537.046928] Dynamic subtest plane-155: SUCCESS (8.387s)
[537.060711] Starting dynamic subtest: plane-165
[545.343726] Dynamic subtest plane-165: SUCCESS (8.302s)
[545.345096] Subtest universal-planes-dpms: SUCCESS (66.703s)
[545.535331] [128/133] (472s left) gem_mmap_offset (bad-object)
[545.573210] Starting subtest: bad-object
[545.573927] Subtest bad-object: SUCCESS (0.001s)
[545.678330] [129/133] (472s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[545.768357] Starting subtest: fbc-modesetfrombusy
[546.425402] Subtest fbc-modesetfrombusy: SUCCESS (0.658s)
[546.543468] [130/133] (471s left) kms_properties (invalid-properties-legacy)
[546.628955] Starting subtest: invalid-properties-legacy
[546.843417] Subtest invalid-properties-legacy: SUCCESS (0.206s)
[546.906797] [131/133] (470s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[546.941285] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[546.941995] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[547.015829] [132/133] (470s left) gem_softpin (evict-single-offset)
[547.053436] Starting subtest: evict-single-offset
[571.253347] Subtest evict-single-offset: SUCCESS (24.199s)
[571.342465] [133/133] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[571.483913] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[571.485260] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[571.587251] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_flink_basic
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_render_copy_redux
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: core_getversion
results: parsing output: 33/ for test: gem_request_retire
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gen7_exec_parse
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_mmap_write_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_chamelium_audio
results: parsing output: 83/ for test: gem_bad_reloc
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: sysfs_heartbeat_interval
results: parsing output: 87/ for test: kms_universal_plane
results: parsing output: 88/ for test: kms_dp_link_training
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_busy
results: parsing output: 95/ for test: gem_exec_async
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_ctx_engines
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_plane_cursor
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.