[51.193693] Initializing watchdogs
[51.193770]   /dev/watchdog0
[51.209434] [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]
[51.215588] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.218335] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.220189] [001/154] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[51.322875] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[51.324424] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[51.408419] [002/154] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[51.502110] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[51.503466] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[51.601171] [003/154] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[51.694368] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[51.695717] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[51.797590] [004/154] (960s left) core_debugfs (read-all-entries)
[51.831265] Starting subtest: read-all-entries
[51.870319] Subtest read-all-entries: SUCCESS (0.038s)
[51.962381] [005/154] (959s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[51.997342] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[51.998047] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[52.068632] [006/154] (959s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[52.155534] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[52.156945] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[52.210696] [007/154] (959s left) kms_getfb (getfb-handle-closed)
[52.306530] Starting subtest: getfb-handle-closed
[52.307225] Subtest getfb-handle-closed: SUCCESS (0.000s)
[52.395400] [008/154] (959s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[52.483853] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[52.485362] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[52.542444] [009/154] (959s left) perf (disabled-read-error)
[52.625808] Starting subtest: disabled-read-error
[52.639970] Subtest disabled-read-error: SUCCESS (0.015s)
[52.673664] [010/154] (959s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[52.714505] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[52.836496] [011/154] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[52.929613] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[52.931086] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[53.019576] [012/154] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[53.116237] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[53.117634] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[53.200759] [013/154] (958s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[53.293318] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[53.303249] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s)
[53.361304] [014/154] (958s left) gem_eio (create)
[53.406150] Starting subtest: create
[53.452020] Subtest create: SUCCESS (0.047s)
[53.582371] [015/154] (958s left) gem_exec_flush (basic-wb-pro-default)
[53.626246] Starting subtest: basic-wb-pro-default
[59.055468] Subtest basic-wb-pro-default: SUCCESS (5.429s)
[59.254959] [016/154] (953s left) i915_hangman (detector)
[59.298983] Starting subtest: detector
[59.299755] Starting dynamic subtest: rcs0
[68.090460] Dynamic subtest rcs0: SUCCESS (8.791s)
[68.109210] Starting dynamic subtest: bcs0
[78.041412] Dynamic subtest bcs0: SUCCESS (9.950s)
[78.057873] Starting dynamic subtest: vcs0
[88.019225] Dynamic subtest vcs0: SUCCESS (9.978s)
[88.034796] Starting dynamic subtest: vcs1
[98.053133] Dynamic subtest vcs1: SUCCESS (10.034s)
[98.067307] Starting dynamic subtest: vecs0
[108.045041] Dynamic subtest vecs0: SUCCESS (9.992s)
[108.046373] Subtest detector: SUCCESS (48.748s)
[108.115621] [017/154] (904s left) perf_pmu (init-busy)
[108.153320] Starting subtest: init-busy
[108.154052] Starting dynamic subtest: rcs0
[108.154774] Dynamic subtest rcs0: SUCCESS (0.001s)
[108.161188] Starting dynamic subtest: bcs0
[108.161892] Dynamic subtest bcs0: SUCCESS (0.000s)
[108.168358] Starting dynamic subtest: vcs0
[108.169048] Dynamic subtest vcs0: SUCCESS (0.001s)
[108.174995] Starting dynamic subtest: vcs1
[108.175729] Dynamic subtest vcs1: SUCCESS (0.000s)
[108.181538] Starting dynamic subtest: vecs0
[108.182251] Dynamic subtest vecs0: SUCCESS (0.000s)
[108.182934] Subtest init-busy: SUCCESS (0.004s)
[108.214961] [018/154] (904s left) gem_eio (wait-wedge-10ms)
[108.256478] Starting subtest: wait-wedge-10ms
[108.518341] Subtest wait-wedge-10ms: SUCCESS (0.262s)
[108.634752] [019/154] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[108.726419] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[108.727875] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[108.821364] [020/154] (903s left) gem_mmap_wc (write-wc-read-gtt)
[108.854449] Starting subtest: write-wc-read-gtt
[109.169404] Subtest write-wc-read-gtt: SUCCESS (0.306s)
[109.228281] [021/154] (903s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[109.328547] Starting subtest: y-tiled-8bpp-rotate-180
[110.392950] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.064s)
[110.516205] [022/154] (901s left) kms_flip (basic-flip-vs-dpms)
[110.606213] Starting subtest: basic-flip-vs-dpms
[110.607829] Starting dynamic subtest: A-HDMI-A1
[111.364266] Dynamic subtest A-HDMI-A1: SUCCESS (0.756s)
[111.372155] Starting dynamic subtest: B-HDMI-A1
[112.020642] Dynamic subtest B-HDMI-A1: SUCCESS (0.656s)
[112.030144] Starting dynamic subtest: C-HDMI-A1
[112.730175] Dynamic subtest C-HDMI-A1: SUCCESS (0.709s)
[112.739040] Starting dynamic subtest: D-HDMI-A1
[113.447090] Dynamic subtest D-HDMI-A1: SUCCESS (0.715s)
[113.448679] Subtest basic-flip-vs-dpms: SUCCESS (2.843s)
[113.590470] [023/154] (898s left) i915_drm_fdinfo (virtual-busy-hang)
[113.632755] Starting subtest: virtual-busy-hang
[118.824054] Subtest virtual-busy-hang: SUCCESS (5.191s)
[118.890743] [024/154] (893s left) gem_exec_schedule (preempt-queue-chain)
[118.936225] Starting subtest: preempt-queue-chain
[118.936958] Starting dynamic subtest: rcs0
[119.085288] Dynamic subtest rcs0: SUCCESS (0.140s)
[119.093030] Starting dynamic subtest: bcs0
[119.222340] Dynamic subtest bcs0: SUCCESS (0.137s)
[119.230063] Starting dynamic subtest: vcs0
[119.365696] Dynamic subtest vcs0: SUCCESS (0.143s)
[119.372955] Starting dynamic subtest: vcs1
[119.509977] Dynamic subtest vcs1: SUCCESS (0.144s)
[119.517668] Starting dynamic subtest: vecs0
[119.647377] Dynamic subtest vecs0: SUCCESS (0.137s)
[119.648137] Subtest preempt-queue-chain: SUCCESS (0.703s)
[119.946596] [025/154] (892s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[119.981393] Starting subtest: multi-wait-all-for-submit-signaled
[119.983273] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[120.071841] [026/154] (892s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[120.166326] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[120.167746] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[120.273453] [027/154] (892s left) gem_spin_batch (resubmit-new)
[120.315371] Starting subtest: resubmit-new
[120.316120] Starting dynamic subtest: rcs0
[120.319196] Dynamic subtest rcs0: SUCCESS (0.004s)
[120.328817] Starting dynamic subtest: bcs0
[120.329671] Dynamic subtest bcs0: SUCCESS (0.004s)
[120.339132] Starting dynamic subtest: vcs0
[120.339875] Dynamic subtest vcs0: SUCCESS (0.004s)
[120.346625] Starting dynamic subtest: vcs1
[120.347332] Dynamic subtest vcs1: SUCCESS (0.004s)
[120.353785] Starting dynamic subtest: vecs0
[120.354478] Dynamic subtest vecs0: SUCCESS (0.004s)
[120.355177] Subtest resubmit-new: SUCCESS (0.023s)
[120.518950] [028/154] (892s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[120.611607] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[120.613078] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[120.701008] [029/154] (892s left) kms_dsc (dsc-with-bpc)
[120.788789] Starting subtest: dsc-with-bpc
[120.798660] Subtest dsc-with-bpc: SKIP (0.001s)
[120.850800] [030/154] (891s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[120.943270] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[120.944715] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[121.035330] [031/154] (891s left) i915_pm_rpm (system-suspend-execbuf)
[122.426993] Starting subtest: system-suspend-execbuf
[164.499877] Subtest system-suspend-execbuf: SUCCESS (27.335s)
[164.687333] [032/154] (848s left) prime_mmap_kms (buffer-sharing)
[164.779541] Starting subtest: buffer-sharing
[164.959757] Subtest buffer-sharing: SUCCESS (0.180s)
[165.104047] [033/154] (847s left) gen9_exec_parse (allowed-single)
[165.144823] Subtest allowed-single: SKIP (0.000s)
[165.186766] [034/154] (847s left) kms_pm_rpm (cursor-dpms)
[166.586237] Starting subtest: cursor-dpms
[178.448542] Subtest cursor-dpms: SUCCESS (11.860s)
[178.641571] [035/154] (834s left) drm_read (empty-nonblock)
[178.757073] Starting subtest: empty-nonblock
[178.757800] Subtest empty-nonblock: SUCCESS (0.000s)
[178.881238] [036/154] (834s left) kms_plane_multiple (2x-tiling-4)
[178.968569] Starting subtest: 2x-tiling-4
[178.969953] Subtest 2x-tiling-4: SKIP (0.000s)
[179.024277] [037/154] (834s left) kms_cursor_crc (cursor-random-128x128)
[179.115062] Starting subtest: cursor-random-128x128
[179.119627] Starting dynamic subtest: pipe-A-HDMI-A-1
[181.014420] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.895s)
[181.051307] Starting dynamic subtest: pipe-D-HDMI-A-1
[182.923332] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.881s)
[182.924032] Subtest cursor-random-128x128: SUCCESS (3.809s)
[183.067141] [038/154] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[183.166928] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[183.168351] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[183.266729] [039/154] (829s left) gem_madvise (dontneed-after-mmap)
[183.298738] Starting subtest: dontneed-after-mmap
[183.304085] Subtest dontneed-after-mmap: SUCCESS (0.005s)
[183.397909] [040/154] (829s left) gem_mmap_gtt (flink-race)
[183.432669] Starting subtest: flink-race
[203.536615] Subtest flink-race: SUCCESS (20.071s)
[203.640519] [041/154] (809s left) kms_flip (2x-flip-vs-panning-vs-hang)
[203.731152] Starting subtest: 2x-flip-vs-panning-vs-hang
[203.733466] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[203.802772] [042/154] (809s left) gem_readwrite (read-bad-handle)
[203.837464] Starting subtest: read-bad-handle
[203.838820] Subtest read-bad-handle: SUCCESS (0.000s)
[203.925418] [043/154] (809s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[204.012783] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[204.014743] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.021817] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[204.031824] Starting dynamic subtest: pipe-B-HDMI-A-1
[204.038964] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[204.048496] Starting dynamic subtest: pipe-C-HDMI-A-1
[204.055455] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[204.064476] Starting dynamic subtest: pipe-D-HDMI-A-1
[204.071724] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[204.073089] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[204.270286] [044/154] (809s left) dumb_buffer (map-valid)
[204.306923] Starting subtest: map-valid
[204.307633] Subtest map-valid: SUCCESS (0.000s)
[204.384846] [045/154] (808s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[204.471778] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[204.473241] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[204.641398] [046/154] (808s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[204.735416] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[204.778404] [047/154] (808s left) perf_pmu (busy-check-all)
[204.814979] Starting subtest: busy-check-all
[204.815710] Starting dynamic subtest: rcs0
[205.337953] Dynamic subtest rcs0: SUCCESS (0.522s)
[205.350490] Starting dynamic subtest: bcs0
[205.861098] Dynamic subtest bcs0: SUCCESS (0.521s)
[205.873063] Starting dynamic subtest: vcs0
[206.389040] Dynamic subtest vcs0: SUCCESS (0.526s)
[206.400830] Starting dynamic subtest: vcs1
[206.912795] Dynamic subtest vcs1: SUCCESS (0.522s)
[206.925130] Starting dynamic subtest: vecs0
[207.436857] Dynamic subtest vecs0: SUCCESS (0.522s)
[207.438005] Subtest busy-check-all: SUCCESS (2.622s)
[207.506409] [048/154] (805s left) kms_lease (setcrtc-implicit-plane)
[207.597867] Starting subtest: setcrtc-implicit-plane
[207.598636] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.790747] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.192s)
[207.801726] Starting dynamic subtest: pipe-B-HDMI-A-1
[207.955513] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.164s)
[207.966052] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.143766] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.186s)
[208.154329] Starting dynamic subtest: pipe-D-HDMI-A-1
[208.326260] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.181s)
[208.327113] Subtest setcrtc-implicit-plane: SUCCESS (0.730s)
[208.490172] [049/154] (805s left) syncobj_timeline (single-wait-all-signaled)
[208.527509] Starting subtest: single-wait-all-signaled
[208.528212] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[208.609736] [050/154] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[208.704087] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[208.705553] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[208.776409] [051/154] (804s left) kms_cursor_crc (cursor-random-64x21)
[208.867848] Starting subtest: cursor-random-64x21
[208.872460] Starting dynamic subtest: pipe-A-HDMI-A-1
[210.788460] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.915s)
[210.828607] Starting dynamic subtest: pipe-D-HDMI-A-1
[212.702674] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.884s)
[212.703411] Subtest cursor-random-64x21: SUCCESS (3.835s)
[212.858003] [052/154] (800s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[212.958149] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[212.959559] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[213.067370] [053/154] (800s left) gem_compute (compute-square)
[213.102890] Starting subtest: compute-square
[213.105916] Subtest compute-square: SUCCESS (0.004s)
[213.197652] [054/154] (800s left) gem_exec_fence (syncobj-timeline-wait)
[213.692272] Starting subtest: syncobj-timeline-wait
[213.720387] Subtest syncobj-timeline-wait: SUCCESS (0.037s)
[213.901738] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[213.904445] [055/154] (799s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[214.048094] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[214.154307] [056/154] (799s left) kms_chamelium_color (ctm-0-50)
[214.249799] Subtest ctm-0-50: SKIP (0.000s)
[214.291886] [057/154] (799s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[214.385461] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[214.386828] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[214.492459] [058/154] (799s left) kms_dirtyfb (default-dirtyfb-ioctl)
[214.581800] Starting subtest: default-dirtyfb-ioctl
[214.582581] Starting dynamic subtest: A-HDMI-A-1
[215.800113] Dynamic subtest A-HDMI-A-1: SUCCESS (1.217s)
[215.800852] Subtest default-dirtyfb-ioctl: SUCCESS (1.219s)
[215.944618] [059/154] (797s left) gem_workarounds (reset)
[215.999017] Starting subtest: reset
[216.009447] Subtest reset: SUCCESS (0.010s)
[216.127051] [060/154] (797s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[216.220968] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[216.222404] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[216.325835] [061/154] (797s left) kms_draw_crc (fill-fb)
[216.416528] Starting subtest: fill-fb
[216.634548] Subtest fill-fb: SUCCESS (0.218s)
[216.763427] [062/154] (797s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[216.858011] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[216.859450] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[216.977169] [063/154] (797s left) syncobj_basic (bad-destroy-pad)
[217.011160] Starting subtest: bad-destroy-pad
[217.011908] Subtest bad-destroy-pad: SUCCESS (0.000s)
[217.088603] [064/154] (797s left) gem_exec_schedule (u-submit-golden-slice)
[217.137421] Starting subtest: u-submit-golden-slice
[217.138200] Starting dynamic subtest: rcs0
[217.168779] Dynamic subtest rcs0: SUCCESS (0.031s)
[217.178603] Starting dynamic subtest: bcs0
[217.200047] Dynamic subtest bcs0: SUCCESS (0.030s)
[217.209444] Starting dynamic subtest: vcs0
[217.233188] Dynamic subtest vcs0: SUCCESS (0.032s)
[217.242856] Starting dynamic subtest: vcs1
[217.267981] Dynamic subtest vcs1: SUCCESS (0.034s)
[217.279276] Starting dynamic subtest: vecs0
[217.299098] Dynamic subtest vecs0: SUCCESS (0.030s)
[217.300060] Subtest u-submit-golden-slice: SUCCESS (0.162s)
[217.612021] [065/154] (796s left) i915_query (query-regions-sanity-check)
[217.645524] Starting subtest: query-regions-sanity-check
[217.656879] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[217.769706] [066/154] (796s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[217.860116] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[217.860861] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.878642] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[217.887660] Starting dynamic subtest: pipe-B-HDMI-A-1
[217.906961] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[217.915247] Starting dynamic subtest: pipe-C-HDMI-A-1
[217.933866] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[217.945862] Starting dynamic subtest: pipe-D-HDMI-A-1
[217.964493] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[217.965925] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.013s)
[218.149417] [067/154] (796s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[218.246595] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[218.247990] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[218.336751] [068/154] (796s left) kms_pm_rpm (system-suspend-idle)
[219.735025] Starting subtest: system-suspend-idle
[239.092919] Subtest system-suspend-idle: SUCCESS (4.722s)
[245.386361] [069/154] (775s left) prime_busy (before-wait)
[245.435496] Starting subtest: before-wait
[245.439743] Starting dynamic subtest: rcs0
[245.468270] Dynamic subtest rcs0: SUCCESS (0.028s)
[245.483743] Starting dynamic subtest: bcs0
[245.491191] Dynamic subtest bcs0: SUCCESS (0.021s)
[245.502645] Starting dynamic subtest: vcs0
[245.510766] Dynamic subtest vcs0: SUCCESS (0.018s)
[245.520643] Starting dynamic subtest: vcs1
[245.525447] Dynamic subtest vcs1: SUCCESS (0.014s)
[245.538017] Starting dynamic subtest: vecs0
[245.542775] Dynamic subtest vecs0: SUCCESS (0.016s)
[245.652336] Subtest before-wait: SUCCESS (0.217s)
[245.734916] [070/154] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[245.830714] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[245.832117] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[245.923722] [071/154] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[246.018114] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[246.019594] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.126302] [072/154] (774s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[246.235708] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[246.236411] Starting dynamic subtest: pipe-A-valid-mode
[247.054670] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.818s)
[247.055420] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.820s)
[247.225562] [073/154] (773s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[247.265841] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[247.368523] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[247.452418] [074/154] (773s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[247.542612] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[247.543390] Starting dynamic subtest: pipe-A
[247.693771] Dynamic subtest pipe-A: SUCCESS (0.151s)
[247.705060] Starting dynamic subtest: pipe-B
[247.827764] Dynamic subtest pipe-B: SUCCESS (0.133s)
[247.840071] Starting dynamic subtest: pipe-C
[247.971587] Dynamic subtest pipe-C: SUCCESS (0.143s)
[247.989687] Starting dynamic subtest: pipe-D
[248.113029] Dynamic subtest pipe-D: SUCCESS (0.140s)
[248.113790] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.571s)
[248.318999] [075/154] (772s left) prime_udl
[248.395837] [076/154] (772s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[248.491863] Starting subtest: fbcpsrhdr-modesetfrombusy
[248.493337] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[248.579780] [077/154] (772s left) gem_exec_whisper (basic-contexts-all)
[248.624415] Starting subtest: basic-contexts-all
[250.334742] Subtest basic-contexts-all: SUCCESS (1.709s)
[250.514577] [078/154] (770s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[250.615667] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[250.617070] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[250.725925] [079/154] (770s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[250.866447] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[250.981009] [080/154] (769s left) gem_ctx_persistence (legacy-engines-mixed-process)
[251.023368] Starting subtest: legacy-engines-mixed-process
[251.024144] Starting dynamic subtest: render
[251.419382] Dynamic subtest render: SUCCESS (0.395s)
[251.434391] Starting dynamic subtest: bsd1
[251.774406] Dynamic subtest bsd1: SUCCESS (0.352s)
[251.788685] Starting dynamic subtest: bsd2
[252.138637] Dynamic subtest bsd2: SUCCESS (0.361s)
[252.155924] Starting dynamic subtest: blt
[252.499487] Dynamic subtest blt: SUCCESS (0.358s)
[252.511846] Starting dynamic subtest: vebox
[252.859408] Dynamic subtest vebox: SUCCESS (0.357s)
[252.862630] Subtest legacy-engines-mixed-process: SUCCESS (1.836s)
[252.935890] [081/154] (768s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[253.032474] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[253.033903] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[253.128445] [082/154] (767s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[253.218130] Starting subtest: crc-primary-basic-yf-tiled-ccs
[253.218843] Starting dynamic subtest: pipe-A-HDMI-A-1
[253.225604] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[253.234490] Starting dynamic subtest: pipe-B-HDMI-A-1
[253.241288] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[253.250072] Starting dynamic subtest: pipe-C-HDMI-A-1
[253.256894] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[253.265457] Starting dynamic subtest: pipe-D-HDMI-A-1
[253.272460] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[253.273897] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.009s)
[253.496641] [083/154] (767s left) gem_exec_balancer (bonded-semaphore)
[253.539927] Starting subtest: bonded-semaphore
[257.886998] Subtest bonded-semaphore: SUCCESS (4.311s)
[258.049129] [084/154] (763s left) gem_exec_reloc (basic-write-read)
[258.087777] Starting subtest: basic-write-read
[258.093062] Subtest basic-write-read: SUCCESS (0.005s)
[258.214418] [085/154] (762s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[258.303669] Starting subtest: bad-aux-stride-yf-tiled-ccs
[258.304376] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.311175] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[258.320142] Starting dynamic subtest: pipe-B-HDMI-A-1
[258.327349] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[258.335869] Starting dynamic subtest: pipe-C-HDMI-A-1
[258.343005] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[258.351288] Starting dynamic subtest: pipe-D-HDMI-A-1
[258.358376] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[258.359794] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s)
[258.563500] [086/154] (762s left) gem_render_copy (linear)
[258.606614] Starting subtest: linear
[258.607319] Starting dynamic subtest: smem
[258.671297] Dynamic subtest smem: SUCCESS (0.065s)
[258.672059] Subtest linear: SUCCESS (0.066s)
[258.853444] [087/154] (762s left) syncobj_wait (wait-for-submit-delayed-submit)
[258.888955] Starting subtest: wait-for-submit-delayed-submit
[258.991497] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[259.071904] [088/154] (762s left) gem_mmap_gtt (fault-concurrent-x)
[259.105612] Starting subtest: fault-concurrent-X
[261.860264] Subtest fault-concurrent-X: SUCCESS (2.720s)
[261.961440] [089/154] (759s left) prime_vgem (basic-gtt)
[262.036023] Starting subtest: basic-gtt
[262.053744] Subtest basic-gtt: SUCCESS (0.018s)
[262.168700] [090/154] (759s left) kms_joiner (basic-ultra-joiner)
[262.262822] Starting subtest: basic-ultra-joiner
[262.264194] Subtest basic-ultra-joiner: SKIP (0.000s)
[262.335533] [091/154] (759s left) gem_lmem_swapping (heavy-verify-multi)
[262.373948] Subtest heavy-verify-multi: SKIP (0.000s)
[262.417127] [092/154] (759s left) kms_sequence (get-idle)
[262.506731] Starting subtest: get-idle
[262.507463] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.710424] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.202s)
[263.721378] Starting dynamic subtest: pipe-B-HDMI-A-1
[264.891320] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.179s)
[264.900385] Starting dynamic subtest: pipe-C-HDMI-A-1
[266.085599] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.192s)
[266.095675] Starting dynamic subtest: pipe-D-HDMI-A-1
[267.274995] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.187s)
[267.275760] Subtest get-idle: SUCCESS (4.768s)
[267.389815] [093/154] (754s left) kms_pipe_crc_basic (nonblocking-crc)
[267.489707] Starting subtest: nonblocking-crc
[267.491583] Starting dynamic subtest: pipe-A-HDMI-A-1
[267.848705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s)
[267.859068] Starting dynamic subtest: pipe-B-HDMI-A-1
[268.170721] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.319s)
[268.182428] Starting dynamic subtest: pipe-C-HDMI-A-1
[268.516749] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.345s)
[268.529770] Starting dynamic subtest: pipe-D-HDMI-A-1
[268.872764] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.354s)
[268.873513] Subtest nonblocking-crc: SUCCESS (1.384s)
[269.018570] [094/154] (752s left) prime_mmap (test_userptr)
[269.056924] Starting subtest: test_userptr
[269.057640] Starting dynamic subtest: test_userptr-smem
[269.058398] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[269.059083] Subtest test_userptr: SUCCESS (0.002s)
[269.153532] [095/154] (752s left) kms_async_flips (test-time-stamp)
[269.245612] Starting subtest: test-time-stamp
[269.368763] Starting dynamic subtest: pipe-A-HDMI-A-1
[269.486814] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.117s)
[269.628155] Starting dynamic subtest: pipe-B-HDMI-A-1
[269.709634] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.089s)
[269.824390] Starting dynamic subtest: pipe-C-HDMI-A-1
[269.905968] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.091s)
[270.024518] Starting dynamic subtest: pipe-D-HDMI-A-1
[270.108905] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.092s)
[270.109717] Subtest test-time-stamp: SUCCESS (0.864s)
[270.328766] [096/154] (751s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[270.429904] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[270.431377] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[270.540105] [097/154] (751s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[270.636047] Starting subtest: addfb25-y-tiled-legacy
[270.636778] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[270.747412] [098/154] (750s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[270.840559] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[270.841978] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[270.959650] [099/154] (750s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[271.052576] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[271.054031] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[271.146459] [100/154] (750s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[271.183467] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[271.184175] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[271.256767] [101/154] (750s left) core_setmaster (master-drop-set-shared-fd)
[271.333484] Starting subtest: master-drop-set-shared-fd
[271.348028] Subtest master-drop-set-shared-fd: SUCCESS (0.016s)
[271.385337] [102/154] (750s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[271.477804] Starting subtest: cursorA-vs-flipA-varying-size
[282.334579] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.855s)
[282.466366] [103/154] (739s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[282.564236] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[282.565672] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[282.659483] [104/154] (739s left) kms_scaling_modes (scaling-mode-full)
[282.746683] Starting subtest: scaling-mode-full
[282.750738] Subtest scaling-mode-full: SKIP (0.001s)
[282.818830] [105/154] (739s left) prime_self_import (reimport-vs-gem_close-race)
[282.851926] Starting subtest: reimport-vs-gem_close-race
[287.893341] Subtest reimport-vs-gem_close-race: SUCCESS (5.030s)
[287.983969] [106/154] (734s left) api_intel_allocator (execbuf-with-allocator)
[288.018554] Starting subtest: execbuf-with-allocator
[288.020492] Subtest execbuf-with-allocator: SUCCESS (0.003s)
[288.128631] [107/154] (734s left) gem_partial_pwrite_pread (reads-snoop)
[288.167833] Starting subtest: reads-snoop
[290.015259] Subtest reads-snoop: SUCCESS (1.847s)
[290.127825] [108/154] (732s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[290.238663] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[290.240035] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[290.340866] [109/154] (731s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[290.382575] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[290.383271] Starting dynamic subtest: smem
[290.457943] Dynamic subtest smem: SUCCESS (0.076s)
[290.458690] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.077s)
[290.656282] [110/154] (731s left) gem_eio (suspend)
[290.701607] Starting subtest: suspend
[301.771623] Subtest suspend: SUCCESS (11.070s)
[310.958233] [111/154] (720s left) kms_addfb_basic (small-bo)
[311.061146] Starting subtest: small-bo
[311.061932] Subtest small-bo: SUCCESS (0.000s)
[311.138463] [112/154] (720s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[311.236319] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[311.237764] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[311.341600] [113/154] (720s left) kms_plane (pixel-format-y-tiled-modifier)
[311.429713] Starting subtest: pixel-format-y-tiled-modifier
[311.449224] Starting dynamic subtest: pipe-A-plane-0
[311.732731] Dynamic subtest pipe-A-plane-0: SUCCESS (0.283s)
[311.748343] Starting dynamic subtest: pipe-A-plane-3
[311.974138] Dynamic subtest pipe-A-plane-3: SUCCESS (0.238s)
[311.992599] Starting dynamic subtest: pipe-A-plane-5
[312.224319] Dynamic subtest pipe-A-plane-5: SUCCESS (0.246s)
[312.243343] Starting dynamic subtest: pipe-A-plane-7
[312.244891] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[312.383957] Starting dynamic subtest: pipe-B-plane-0
[312.625267] Dynamic subtest pipe-B-plane-0: SUCCESS (0.250s)
[312.637098] Starting dynamic subtest: pipe-B-plane-3
[312.858992] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[312.872139] Starting dynamic subtest: pipe-B-plane-5
[313.092306] Dynamic subtest pipe-B-plane-5: SUCCESS (0.231s)
[313.109190] Starting dynamic subtest: pipe-B-plane-7
[313.110674] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[313.157854] Subtest pixel-format-y-tiled-modifier: SUCCESS (1.728s)
[313.352446] [114/154] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[313.452458] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[313.453889] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[313.540765] [115/154] (718s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[313.628901] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[313.675034] [116/154] (717s left) gem_partial_pwrite_pread (writes-after-reads)
[313.714270] Starting subtest: writes-after-reads
[326.093502] Subtest writes-after-reads: SUCCESS (12.377s)
[326.186832] [117/154] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[326.283458] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[326.284948] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[326.379281] [118/154] (705s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[326.467677] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[326.468375] Starting dynamic subtest: pipe-A
[327.680683] Dynamic subtest pipe-A: SUCCESS (1.213s)
[327.692833] Starting dynamic subtest: pipe-B
[328.973695] Dynamic subtest pipe-B: SUCCESS (1.292s)
[328.987149] Starting dynamic subtest: pipe-C
[329.183702] Dynamic subtest pipe-C: SUCCESS (0.209s)
[329.202927] Starting dynamic subtest: pipe-D
[329.400972] Dynamic subtest pipe-D: SUCCESS (0.216s)
[329.401700] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (2.934s)
[329.581370] [119/154] (702s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[329.675575] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[329.719508] [120/154] (702s left) kms_content_protection (atomic-hdcp14)
[329.812379] Starting subtest: atomic-hdcp14
[329.817954] Subtest atomic-hdcp14: SKIP (0.003s)
[329.919731] [121/154] (701s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[329.961705] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[329.962411] Starting dynamic subtest: smem
[330.042174] Dynamic subtest smem: SUCCESS (0.081s)
[330.042906] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.082s)
[330.238606] [122/154] (701s left) kms_psr (pr-cursor-plane-move)
[330.327370] Subtest pr-cursor-plane-move: SKIP (0.000s)
[330.377915] [123/154] (701s left) kms_vrr (flip-basic-fastset)
[330.465734] Starting subtest: flip-basic-fastset
[330.467823] Subtest flip-basic-fastset: SKIP (0.000s)
[330.533520] [124/154] (701s left) kms_force_connector_basic (force-connector-state)
[330.659691] Starting subtest: force-connector-state
[330.969172] Subtest force-connector-state: SUCCESS (0.309s)
[331.253079] [125/154] (700s left) kms_psr (psr-cursor-mmap-gtt)
[331.346152] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[331.394910] [126/154] (700s left) gem_exec_balancer (parallel-keep-in-fence)
[331.552678] Subtest parallel-keep-in-fence: SKIP (0.000s)
[331.643751] [127/154] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[331.738309] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[331.739714] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[331.845071] [128/154] (700s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[331.938449] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[331.939882] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[332.033297] [129/154] (700s left) syncobj_wait (single-wait-submitted)
[332.069394] Starting subtest: single-wait-submitted
[332.183483] Subtest single-wait-submitted: SUCCESS (0.107s)
[332.251974] [130/154] (699s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[332.342117] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[332.387652] [131/154] (699s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[332.486094] Starting subtest: yf-tiled-32bpp-rotate-180
[332.487513] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[332.573366] [132/154] (699s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[332.609884] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[332.612138] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[332.674931] [133/154] (699s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[332.765201] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[343.630492] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.864s)
[343.774321] [134/154] (688s left) tools_test (tools_test)
[343.821708] Starting subtest: tools_test
[343.893331] Subtest tools_test: SUCCESS (0.075s)
[343.952390] [135/154] (688s left) gem_mmap_gtt (basic-small-bo)
[343.987429] Starting subtest: basic-small-bo
[344.504032] Subtest basic-small-bo: SUCCESS (0.517s)
[344.608505] [136/154] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[344.754452] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[344.755882] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[344.867679] [137/154] (687s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[344.960695] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[344.962091] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.057466] [138/154] (687s left) gem_ctx_isolation (dirty-switch)
[345.101630] Starting subtest: dirty-switch
[345.102395] Starting dynamic subtest: rcs0
[345.290879] Dynamic subtest rcs0: SUCCESS (0.183s)
[345.300536] Starting dynamic subtest: bcs0
[345.506206] Dynamic subtest bcs0: SUCCESS (0.214s)
[345.521621] Starting dynamic subtest: vcs0
[345.734240] Dynamic subtest vcs0: SUCCESS (0.226s)
[345.743101] Starting dynamic subtest: vcs1
[345.964036] Dynamic subtest vcs1: SUCCESS (0.228s)
[345.973351] Starting dynamic subtest: vecs0
[346.186890] Dynamic subtest vecs0: SUCCESS (0.222s)
[346.187817] Subtest dirty-switch: SUCCESS (1.079s)
[346.366686] [139/154] (686s left) kms_psr (fbc-psr-sprite-plane-onoff)
[346.463472] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[346.508972] [140/154] (686s left) kms_getfb (getfb2-handle-closed)
[346.599337] Starting subtest: getfb2-handle-closed
[346.600271] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[346.710181] [141/154] (685s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[346.811681] Starting subtest: x-tiled-32bpp-rotate-90
[346.892377] Subtest x-tiled-32bpp-rotate-90: SKIP (0.079s)
[347.011174] [142/154] (685s left) gem_sync (basic-each)
[347.057839] Starting subtest: basic-each
[349.176935] Subtest basic-each: SUCCESS (2.119s)
[349.382821] [143/154] (683s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[349.478416] Starting subtest: fbc-rgb565-draw-mmap-cpu
[350.743920] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (1.265s)
[350.865612] [144/154] (681s left) kms_color (deep-color)
[350.959805] Starting subtest: deep-color
[350.966807] Subtest deep-color: SKIP (0.002s)
[351.037012] [145/154] (681s left) kms_big_fb (linear-addfb)
[351.133833] Starting subtest: linear-addfb
[351.134650] Subtest linear-addfb: SUCCESS (0.000s)
[351.221940] [146/154] (681s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[351.315351] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[351.316874] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[351.427471] [147/154] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[351.520741] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[351.522192] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[351.616599] [148/154] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[351.709380] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[351.710808] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[351.798875] [149/154] (681s left) kms_cursor_edge_walk (128x128-top-bottom)
[351.892084] Starting subtest: 128x128-top-bottom
[351.892792] Starting dynamic subtest: pipe-A-HDMI-A-1
[353.689528] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.796s)
[353.700761] Starting dynamic subtest: pipe-D-HDMI-A-1
[355.356789] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.665s)
[355.357611] Subtest 128x128-top-bottom: SUCCESS (3.465s)
[355.481535] [150/154] (677s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[355.581443] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[355.582962] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[355.674023] [151/154] (677s left) gem_exec_fence (syncobj-export)
[356.030876] Starting subtest: syncobj-export
[356.034422] Subtest syncobj-export: SUCCESS (0.004s)
[356.347470] [152/154] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[356.439210] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[356.440813] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[356.532968] [153/154] (676s left) gem_softpin (invalid)
[356.571516] Starting subtest: invalid
[356.574888] Subtest invalid: SUCCESS (0.004s)
[356.698243] [154/154] (676s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[356.790355] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[356.791768] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[356.897821] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: core_debugfs
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: i915_hangman
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_dsc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: prime_mmap_kms
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: drm_read
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_madvise
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_readwrite
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: dumb_buffer
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_compute
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_draw_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_basic
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: i915_query
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: prime_busy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: prime_udl
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: kms_pipe_crc_basic
results: parsing output: 93/ for test: prime_mmap
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: core_setmaster
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_scaling_modes
results: parsing output: 104/ for test: prime_self_import
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: gem_partial_pwrite_pread
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_partial_pwrite_pread
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_vrr
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: tools_test
results: parsing output: 134/ for test: gem_mmap_gtt
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_ctx_isolation
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_getfb
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: gem_sync
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_color
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_edge_walk
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_softpin
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.