[108.195488] Initializing watchdogs
[108.195569]   /dev/watchdog0
[108.226607] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[108.242540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[108.247310] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[108.250391] [001/154] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[109.759896] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[109.762657] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[109.924631] [002/154] (958s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[111.426659] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[111.429963] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[111.592527] [003/154] (957s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[113.109952] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[113.113552] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[113.279803] [004/154] (955s left) core_debugfs (read-all-entries)
[113.332324] Starting subtest: read-all-entries
[113.409053] Subtest read-all-entries: SUCCESS (0.076s)
[113.603407] [005/154] (955s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[113.650947] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[113.652482] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[113.766658] [006/154] (955s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[115.255592] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[115.259016] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[115.382400] [007/154] (953s left) kms_getfb (getfb-handle-closed)
[116.885825] Starting subtest: getfb-handle-closed
[116.887722] Subtest getfb-handle-closed: SUCCESS (0.000s)
[117.058506] [008/154] (952s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[118.554928] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[118.558204] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[118.655667] [009/154] (950s left) perf (disabled-read-error)
[118.799653] Starting subtest: disabled-read-error
[118.842912] Subtest disabled-read-error: SUCCESS (0.044s)
[118.916384] [010/154] (950s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[118.982463] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[119.146384] [011/154] (950s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[120.643574] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[120.646246] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[120.889492] [012/154] (948s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[122.392862] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[122.397136] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[122.582202] [013/154] (947s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[124.089809] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[124.109317] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.018s)
[124.233505] [014/154] (945s left) gem_eio (create)
[124.400854] Starting subtest: create
[124.574051] Subtest create: SUCCESS (0.175s)
[126.119417] [015/154] (943s left) gem_exec_flush (basic-wb-pro-default)
[126.187015] Subtest basic-wb-pro-default: SKIP (0.000s)
[126.283122] [016/154] (943s left) i915_hangman (detector)
[126.344056] Starting subtest: detector
[126.345582] Starting dynamic subtest: rcs0
[136.128108] Dynamic subtest rcs0: SUCCESS (9.784s)
[136.142304] Starting dynamic subtest: bcs0
[146.092106] Dynamic subtest bcs0: SUCCESS (9.964s)
[146.104027] Starting dynamic subtest: vcs0
[156.115418] Dynamic subtest vcs0: SUCCESS (10.023s)
[156.130736] Starting dynamic subtest: vcs1
[166.123895] Dynamic subtest vcs1: SUCCESS (10.009s)
[166.143555] Starting dynamic subtest: vecs0
[176.101938] Dynamic subtest vecs0: SUCCESS (9.978s)
[176.103578] Subtest detector: SUCCESS (49.758s)
[176.272261] [017/154] (893s left) perf_pmu (init-busy)
[176.323838] Starting subtest: init-busy
[176.325349] Starting dynamic subtest: rcs0
[176.326883] Dynamic subtest rcs0: SUCCESS (0.002s)
[176.337197] Starting dynamic subtest: bcs0
[176.338879] Dynamic subtest bcs0: SUCCESS (0.001s)
[176.348808] Starting dynamic subtest: vcs0
[176.350531] Dynamic subtest vcs0: SUCCESS (0.001s)
[176.360780] Starting dynamic subtest: vcs1
[176.362475] Dynamic subtest vcs1: SUCCESS (0.001s)
[176.372239] Starting dynamic subtest: vecs0
[176.373910] Dynamic subtest vecs0: SUCCESS (0.001s)
[176.375682] Subtest init-busy: SUCCESS (0.006s)
[176.484139] [018/154] (893s left) gem_eio (wait-wedge-10ms)
[176.647151] Starting subtest: wait-wedge-10ms
[177.825730] Subtest wait-wedge-10ms: SUCCESS (1.179s)
[179.454577] [019/154] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[180.958478] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[180.961404] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[181.125295] [020/154] (889s left) gem_mmap_wc (write-wc-read-gtt)
[181.180513] Subtest write-wc-read-gtt: SKIP (0.000s)
[181.245409] [021/154] (889s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[182.759289] Starting subtest: y-tiled-8bpp-rotate-180
[184.544273] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.781s)
[184.715381] [022/154] (885s left) kms_flip (basic-flip-vs-dpms)
[186.206110] Starting subtest: basic-flip-vs-dpms
[186.212380] Starting dynamic subtest: A-HDMI-A4
[186.959820] Dynamic subtest A-HDMI-A4: SUCCESS (0.746s)
[186.970405] Starting dynamic subtest: B-HDMI-A4
[187.705348] Dynamic subtest B-HDMI-A4: SUCCESS (0.745s)
[187.716106] Starting dynamic subtest: C-HDMI-A4
[188.464158] Dynamic subtest C-HDMI-A4: SUCCESS (0.758s)
[188.474953] Starting dynamic subtest: D-HDMI-A4
[189.217247] Dynamic subtest D-HDMI-A4: SUCCESS (0.754s)
[189.218833] Subtest basic-flip-vs-dpms: SUCCESS (3.013s)
[189.434266] [023/154] (881s left) i915_drm_fdinfo (virtual-busy-hang)
[189.504749] Starting subtest: virtual-busy-hang
[189.508686] Subtest virtual-busy-hang: SKIP (0.001s)
[189.609938] [024/154] (881s left) gem_exec_schedule (preempt-queue-chain)
[189.678984] Subtest preempt-queue-chain: SKIP (0.000s)
[190.053376] [025/154] (880s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[190.112503] Starting subtest: multi-wait-all-for-submit-signaled
[190.114090] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[190.257495] [026/154] (880s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[191.754186] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[191.756876] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[191.905412] [027/154] (879s left) gem_spin_batch (resubmit-new)
[191.983775] Starting subtest: resubmit-new
[191.985286] Starting dynamic subtest: rcs0
[192.004974] Dynamic subtest rcs0: SUCCESS (0.021s)
[192.015896] Starting dynamic subtest: bcs0
[192.017395] Dynamic subtest bcs0: SUCCESS (0.004s)
[192.028461] Starting dynamic subtest: vcs0
[192.030094] Dynamic subtest vcs0: SUCCESS (0.005s)
[192.040472] Starting dynamic subtest: vcs1
[192.042124] Dynamic subtest vcs1: SUCCESS (0.006s)
[192.052215] Starting dynamic subtest: vecs0
[192.053871] Dynamic subtest vecs0: SUCCESS (0.005s)
[192.055530] Subtest resubmit-new: SUCCESS (0.044s)
[192.406357] [028/154] (878s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[193.902524] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[193.905356] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.066165] [029/154] (877s left) kms_dsc (dsc-with-bpc)
[195.562456] Starting subtest: dsc-with-bpc
[195.582437] Subtest dsc-with-bpc: SKIP (0.001s)
[195.699565] [030/154] (875s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[197.221473] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[197.224922] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[197.346820] [031/154] (874s left) i915_pm_rpm (system-suspend-execbuf)
[201.082288] Starting subtest: system-suspend-execbuf
[263.884712] Subtest system-suspend-execbuf: SUCCESS (52.044s)
[264.828801] [032/154] (806s left) prime_mmap_kms (buffer-sharing)
[266.322501] Starting subtest: buffer-sharing
[266.703862] Subtest buffer-sharing: SUCCESS (0.382s)
[266.901152] [033/154] (804s left) gen9_exec_parse (allowed-single)
[266.954719] Subtest allowed-single: SKIP (0.000s)
[267.046164] [034/154] (804s left) kms_pm_rpm (cursor-dpms)
[270.778420] Starting subtest: cursor-dpms
[270.784058] Subtest cursor-dpms: SKIP (0.000s)
[271.728895] [035/154] (799s left) drm_read (empty-nonblock)
[273.283826] Starting subtest: empty-nonblock
[273.285337] Subtest empty-nonblock: SUCCESS (0.000s)
[273.530162] [036/154] (798s left) kms_plane_multiple (2x-tiling-4)
[275.037748] Starting subtest: 2x-tiling-4
[275.040721] Subtest 2x-tiling-4: SKIP (0.000s)
[275.153017] [037/154] (796s left) kms_cursor_crc (cursor-random-128x128)
[276.827347] Starting subtest: cursor-random-128x128
[276.834917] Starting dynamic subtest: pipe-A-HDMI-A-4
[281.453416] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.620s)
[281.489068] Starting dynamic subtest: pipe-D-HDMI-A-4
[285.961256] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.485s)
[285.962997] Subtest cursor-random-128x128: SUCCESS (9.134s)
[286.395019] [038/154] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[287.896333] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[287.898947] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[288.035001] [039/154] (784s left) gem_madvise (dontneed-after-mmap)
[288.091680] Starting subtest: dontneed-after-mmap
[288.097009] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[288.253972] [040/154] (783s left) gem_mmap_gtt (flink-race)
[288.300572] Subtest flink-race: SKIP (0.000s)
[288.372081] [041/154] (783s left) kms_flip (2x-flip-vs-panning-vs-hang)
[289.861949] Starting subtest: 2x-flip-vs-panning-vs-hang
[289.874438] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[289.987305] [042/154] (782s left) gem_readwrite (read-bad-handle)
[290.046568] Subtest read-bad-handle: SKIP (0.000s)
[290.143378] [043/154] (782s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[291.632461] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[291.633813] Starting dynamic subtest: pipe-A-HDMI-A-4
[291.647102] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[291.660071] Starting dynamic subtest: pipe-B-HDMI-A-4
[291.675487] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[291.688049] Starting dynamic subtest: pipe-C-HDMI-A-4
[291.706085] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[291.718695] Starting dynamic subtest: pipe-D-HDMI-A-4
[291.736584] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[291.739930] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[291.910897] [044/154] (780s left) dumb_buffer (map-valid)
[291.960700] Starting subtest: map-valid
[291.962476] Subtest map-valid: SUCCESS (0.000s)
[292.140864] [045/154] (780s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[293.630866] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[293.634058] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[293.848593] [046/154] (778s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[295.342842] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[295.416124] [047/154] (777s left) perf_pmu (busy-check-all)
[295.469165] Starting subtest: busy-check-all
[295.470817] Starting dynamic subtest: rcs0
[296.041031] Dynamic subtest rcs0: SUCCESS (0.571s)
[296.058463] Starting dynamic subtest: bcs0
[296.596577] Dynamic subtest bcs0: SUCCESS (0.553s)
[296.614665] Starting dynamic subtest: vcs0
[297.151590] Dynamic subtest vcs0: SUCCESS (0.551s)
[297.169711] Starting dynamic subtest: vcs1
[297.708022] Dynamic subtest vcs1: SUCCESS (0.552s)
[297.726450] Starting dynamic subtest: vecs0
[298.262790] Dynamic subtest vecs0: SUCCESS (0.551s)
[298.265618] Subtest busy-check-all: SUCCESS (2.794s)
[298.387659] [048/154] (774s left) kms_lease (setcrtc-implicit-plane)
[299.879457] Starting subtest: setcrtc-implicit-plane
[299.881375] Starting dynamic subtest: pipe-A-HDMI-A-4
[300.295432] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.415s)
[300.309063] Starting dynamic subtest: pipe-B-HDMI-A-4
[300.555750] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.258s)
[300.570578] Starting dynamic subtest: pipe-C-HDMI-A-4
[300.819297] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.261s)
[300.834908] Starting dynamic subtest: pipe-D-HDMI-A-4
[301.087065] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.266s)
[301.088844] Subtest setcrtc-implicit-plane: SUCCESS (1.209s)
[301.312949] [049/154] (771s left) syncobj_timeline (single-wait-all-signaled)
[301.363450] Starting subtest: single-wait-all-signaled
[301.365167] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[301.474168] [050/154] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[302.975467] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[302.978357] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[303.158611] [051/154] (769s left) kms_cursor_crc (cursor-random-64x21)
[304.802640] Starting subtest: cursor-random-64x21
[304.810436] Starting dynamic subtest: pipe-A-HDMI-A-4
[309.443862] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.634s)
[309.478735] Starting dynamic subtest: pipe-D-HDMI-A-4
[313.934994] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.467s)
[313.936628] Subtest cursor-random-64x21: SUCCESS (9.131s)
[314.406953] [052/154] (758s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[315.906494] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[315.909795] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[316.070281] [053/154] (757s left) gem_compute (compute-square)
[316.122662] Starting subtest: compute-square
[316.132537] Subtest compute-square: SUCCESS (0.011s)
[316.340067] [054/154] (756s left) gem_exec_fence (syncobj-timeline-wait)
[316.946385] Starting subtest: syncobj-timeline-wait
[317.025415] Subtest syncobj-timeline-wait: SUCCESS (0.085s)
[317.353259] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[317.356095] [055/154] (756s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[318.891850] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[319.022726] [056/154] (754s left) kms_chamelium_color (ctm-0-50)
[320.516872] Subtest ctm-0-50: SKIP (0.000s)
[320.603537] [057/154] (752s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[322.103450] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[322.106932] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[322.285783] [058/154] (751s left) kms_dirtyfb (default-dirtyfb-ioctl)
[323.779105] Starting subtest: default-dirtyfb-ioctl
[323.780834] Starting dynamic subtest: A-HDMI-A-4
[325.209601] Dynamic subtest A-HDMI-A-4: SUCCESS (1.432s)
[325.210945] Subtest default-dirtyfb-ioctl: SUCCESS (1.434s)
[325.390973] [059/154] (748s left) gem_workarounds (reset)
[325.464347] Starting subtest: reset
[325.621148] Subtest reset: SUCCESS (0.155s)
[325.792315] [060/154] (748s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[327.291726] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[327.294909] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[327.450772] [061/154] (746s left) kms_draw_crc (fill-fb)
[328.945204] Starting subtest: fill-fb
[329.494553] Subtest fill-fb: SUCCESS (0.550s)
[329.738621] [062/154] (744s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[331.242608] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[331.245784] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[331.416613] [063/154] (742s left) syncobj_basic (bad-destroy-pad)
[331.465352] Starting subtest: bad-destroy-pad
[331.467011] Subtest bad-destroy-pad: SUCCESS (0.000s)
[331.589975] [064/154] (742s left) gem_exec_schedule (u-submit-golden-slice)
[331.653047] Starting subtest: u-submit-golden-slice
[331.654644] Starting dynamic subtest: rcs0
[331.715947] Dynamic subtest rcs0: SUCCESS (0.063s)
[331.730642] Starting dynamic subtest: bcs0
[331.759428] Dynamic subtest bcs0: SUCCESS (0.042s)
[331.773973] Starting dynamic subtest: vcs0
[331.803214] Dynamic subtest vcs0: SUCCESS (0.043s)
[331.817952] Starting dynamic subtest: vcs1
[331.848767] Dynamic subtest vcs1: SUCCESS (0.045s)
[331.863552] Starting dynamic subtest: vecs0
[331.892829] Dynamic subtest vecs0: SUCCESS (0.043s)
[331.894535] Subtest u-submit-golden-slice: SUCCESS (0.241s)
[332.308335] [065/154] (742s left) i915_query (query-regions-sanity-check)
[332.357427] Starting subtest: query-regions-sanity-check
[332.386553] Subtest query-regions-sanity-check: SUCCESS (0.030s)
[332.616696] [066/154] (741s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[334.108992] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[334.110537] Starting dynamic subtest: pipe-A-HDMI-A-4
[334.151780] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[334.166524] Starting dynamic subtest: pipe-B-HDMI-A-4
[334.227692] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[334.242145] Starting dynamic subtest: pipe-C-HDMI-A-4
[334.285362] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[334.300139] Starting dynamic subtest: pipe-D-HDMI-A-4
[334.348390] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[334.352387] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.019s)
[334.446163] [067/154] (740s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[335.946035] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[335.948986] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[336.123132] [068/154] (738s left) kms_pm_rpm (system-suspend-idle)
[339.760745] Starting subtest: system-suspend-idle
[358.983085] Subtest system-suspend-idle: SUCCESS (4.437s)
[363.061747] [069/154] (714s left) prime_busy (before-wait)
[363.117910] Starting subtest: before-wait
[363.124153] Starting dynamic subtest: rcs0
[363.156968] Dynamic subtest rcs0: SUCCESS (0.033s)
[363.171920] Starting dynamic subtest: bcs0
[363.196827] Dynamic subtest bcs0: SUCCESS (0.039s)
[363.213989] Starting dynamic subtest: vcs0
[363.236866] Dynamic subtest vcs0: SUCCESS (0.039s)
[363.253200] Starting dynamic subtest: vcs1
[363.277922] Dynamic subtest vcs1: SUCCESS (0.040s)
[363.298163] Starting dynamic subtest: vecs0
[363.320062] Dynamic subtest vecs0: SUCCESS (0.041s)
[363.432140] Subtest before-wait: SUCCESS (0.312s)
[363.629293] [070/154] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[365.129866] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[365.133114] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[365.320563] [071/154] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[366.821354] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[366.824865] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.029415] [072/154] (711s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[368.523208] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[368.524794] Starting dynamic subtest: pipe-A-valid-mode
[369.371257] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.848s)
[369.373627] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.850s)
[369.580006] [073/154] (708s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[369.633003] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[369.742323] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[369.971170] [074/154] (708s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[371.461785] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[371.463299] Starting dynamic subtest: pipe-A
[371.625245] Dynamic subtest pipe-A: SUCCESS (0.163s)
[371.645242] Starting dynamic subtest: pipe-B
[371.802149] Dynamic subtest pipe-B: SUCCESS (0.175s)
[371.817002] Starting dynamic subtest: pipe-C
[371.958731] Dynamic subtest pipe-C: SUCCESS (0.156s)
[371.973420] Starting dynamic subtest: pipe-D
[372.116778] Dynamic subtest pipe-D: SUCCESS (0.157s)
[372.118355] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.656s)
[372.355230] [075/154] (706s left) prime_udl
[372.491161] [076/154] (705s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[373.991891] Starting subtest: fbcpsrhdr-modesetfrombusy
[373.995129] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[374.190263] [077/154] (704s left) gem_exec_whisper (basic-contexts-all)
[374.255606] Starting subtest: basic-contexts-all
[380.860746] Subtest basic-contexts-all: SUCCESS (6.600s)
[381.215439] [078/154] (697s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[382.724892] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[382.728694] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[382.928399] [079/154] (695s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[384.468412] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[384.601142] [080/154] (694s left) gem_ctx_persistence (legacy-engines-mixed-process)
[384.659253] Starting subtest: legacy-engines-mixed-process
[384.661004] Starting dynamic subtest: render
[386.435085] Dynamic subtest render: SUCCESS (1.775s)
[386.449990] Starting dynamic subtest: bsd1
[388.398339] Dynamic subtest bsd1: SUCCESS (1.963s)
[388.415754] Starting dynamic subtest: bsd2
[390.399795] Dynamic subtest bsd2: SUCCESS (2.002s)
[390.418333] Starting dynamic subtest: blt
[392.449670] Dynamic subtest blt: SUCCESS (2.049s)
[392.469083] Starting dynamic subtest: vebox
[394.423746] Dynamic subtest vebox: SUCCESS (1.973s)
[394.425925] Subtest legacy-engines-mixed-process: SUCCESS (9.774s)
[394.548132] [081/154] (684s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[396.046905] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[396.050121] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[396.250916] [082/154] (682s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[397.740453] Starting subtest: crc-primary-basic-yf-tiled-ccs
[397.742117] Starting dynamic subtest: pipe-A-HDMI-A-4
[397.758246] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[397.773885] Starting dynamic subtest: pipe-B-HDMI-A-4
[397.790755] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[397.805689] Starting dynamic subtest: pipe-C-HDMI-A-4
[397.822771] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[397.837424] Starting dynamic subtest: pipe-D-HDMI-A-4
[397.851875] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[397.854619] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.013s)
[398.025909] [083/154] (681s left) gem_exec_balancer (bonded-semaphore)
[398.086373] Starting subtest: bonded-semaphore
[398.089527] Subtest bonded-semaphore: SKIP (0.000s)
[398.570828] [084/154] (680s left) gem_exec_reloc (basic-write-read)
[398.624113] Subtest basic-write-read: SKIP (0.000s)
[398.736603] [085/154] (680s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[400.227326] Starting subtest: bad-aux-stride-yf-tiled-ccs
[400.228814] Starting dynamic subtest: pipe-A-HDMI-A-4
[400.243617] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[400.258820] Starting dynamic subtest: pipe-B-HDMI-A-4
[400.274095] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[400.288947] Starting dynamic subtest: pipe-C-HDMI-A-4
[400.304168] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[400.318479] Starting dynamic subtest: pipe-D-HDMI-A-4
[400.334668] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[400.337858] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.010s)
[400.504465] [086/154] (678s left) gem_render_copy (linear)
[400.559286] Starting subtest: linear
[400.561072] Starting dynamic subtest: smem
[400.644013] Dynamic subtest smem: SUCCESS (0.084s)
[400.659326] Starting dynamic subtest: lmem0
[400.784165] Dynamic subtest lmem0: SUCCESS (0.135s)
[400.786131] Subtest linear: SUCCESS (0.222s)
[401.055845] [087/154] (678s left) syncobj_wait (wait-for-submit-delayed-submit)
[401.106587] Starting subtest: wait-for-submit-delayed-submit
[401.210770] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[401.348515] [088/154] (678s left) gem_mmap_gtt (fault-concurrent-x)
[401.397754] Subtest fault-concurrent-X: SKIP (0.000s)
[401.477990] [089/154] (678s left) prime_vgem (basic-gtt)
[401.560774] Starting subtest: basic-gtt
[401.563761] Subtest basic-gtt: SKIP (0.000s)
[401.748172] [090/154] (678s left) kms_joiner (basic-ultra-joiner)
[403.242608] Starting subtest: basic-ultra-joiner
[403.245221] Subtest basic-ultra-joiner: SKIP (0.000s)
[403.354671] [091/154] (676s left) gem_lmem_swapping (heavy-verify-multi)
[407.713327] Starting subtest: heavy-verify-multi
[407.714769] Starting dynamic subtest: lmem0
[423.438944] Dynamic subtest lmem0: SUCCESS (15.724s)
[423.440534] Subtest heavy-verify-multi: SUCCESS (15.727s)
[424.761932] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[424.763076] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true
[424.766668] [092/154] (655s left) kms_sequence (get-idle)
[429.522947] Starting subtest: get-idle
[429.524504] Starting dynamic subtest: pipe-A-HDMI-A-4
[431.919646] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.394s)
[431.933926] Starting dynamic subtest: pipe-B-HDMI-A-4
[434.180888] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.259s)
[434.195856] Starting dynamic subtest: pipe-C-HDMI-A-4
[436.440445] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.248s)
[436.459784] Starting dynamic subtest: pipe-D-HDMI-A-4
[438.680662] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.249s)
[438.682185] Subtest get-idle: SUCCESS (9.159s)
[438.912806] [FACT kms_sequence (get-idle)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[438.916283] [FACT kms_sequence (get-idle)] new: kernel.kmod_is_loaded.i915: true
[438.920320] [093/154] (641s left) kms_pipe_crc_basic (nonblocking-crc)
[440.419469] Starting subtest: nonblocking-crc
[440.421071] Starting dynamic subtest: pipe-A-HDMI-A-4
[441.138006] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.718s)
[441.157075] Starting dynamic subtest: pipe-B-HDMI-A-4
[441.778625] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.626s)
[441.796635] Starting dynamic subtest: pipe-C-HDMI-A-4
[442.314437] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.543s)
[442.330637] Starting dynamic subtest: pipe-D-HDMI-A-4
[442.936072] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.619s)
[442.937759] Subtest nonblocking-crc: SUCCESS (2.519s)
[443.147478] [094/154] (636s left) prime_mmap (test_userptr)
[443.196943] Starting subtest: test_userptr
[443.198287] Starting dynamic subtest: test_userptr-smem
[443.199604] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[443.200902] Subtest test_userptr: SUCCESS (0.002s)
[443.378105] [095/154] (636s left) kms_async_flips (test-time-stamp)
[444.872109] Starting subtest: test-time-stamp
[445.109544] Starting dynamic subtest: pipe-A-HDMI-A-4
[445.516802] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.406s)
[445.726051] Starting dynamic subtest: pipe-B-HDMI-A-4
[445.828229] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.112s)
[446.016321] Starting dynamic subtest: pipe-C-HDMI-A-4
[446.129944] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.124s)
[446.314671] Starting dynamic subtest: pipe-D-HDMI-A-4
[446.420844] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.117s)
[446.422290] Subtest test-time-stamp: SUCCESS (1.553s)
[446.823173] [096/154] (633s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[448.324383] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[448.327321] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[448.481563] [097/154] (631s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[449.974825] Starting subtest: addfb25-y-tiled-legacy
[449.976255] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[450.206304] [098/154] (630s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[451.704615] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[451.707915] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[451.895539] [099/154] (628s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[453.395884] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[453.399637] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[453.555702] [100/154] (627s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[453.607325] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[453.608880] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[453.719772] [101/154] (627s left) core_setmaster (master-drop-set-shared-fd)
[453.850485] Starting subtest: master-drop-set-shared-fd
[453.864812] Subtest master-drop-set-shared-fd: SUCCESS (0.016s)
[453.934848] [102/154] (626s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[455.426157] Starting subtest: cursorA-vs-flipA-varying-size
[466.353036] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.927s)
[466.562966] [103/154] (614s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[468.069179] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[468.072809] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[468.249358] [104/154] (612s left) kms_scaling_modes (scaling-mode-full)
[469.740984] Starting subtest: scaling-mode-full
[469.750311] Subtest scaling-mode-full: SKIP (0.001s)
[469.942053] [105/154] (611s left) prime_self_import (reimport-vs-gem_close-race)
[469.989632] Starting subtest: reimport-vs-gem_close-race
[475.022661] Subtest reimport-vs-gem_close-race: SUCCESS (5.033s)
[475.179087] [106/154] (606s left) api_intel_allocator (execbuf-with-allocator)
[475.251931] Starting subtest: execbuf-with-allocator
[475.271923] Subtest execbuf-with-allocator: SUCCESS (0.022s)
[475.502223] [107/154] (605s left) gem_partial_pwrite_pread (reads-snoop)
[475.579595] Subtest reads-snoop: SKIP (0.000s)
[475.679659] [108/154] (605s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[477.187947] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[477.190927] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[477.361507] [109/154] (604s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[477.416245] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[477.417653] Starting dynamic subtest: smem
[477.523276] Dynamic subtest smem: SUCCESS (0.102s)
[477.537046] Starting dynamic subtest: lmem0
[478.634471] Dynamic subtest lmem0: SUCCESS (1.110s)
[478.636134] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.216s)
[478.906574] [110/154] (602s left) gem_eio (suspend)
[479.077684] Starting subtest: suspend
[491.989419] Subtest suspend: SUCCESS (12.914s)
[498.584570] [111/154] (588s left) kms_addfb_basic (small-bo)
[500.083297] Starting subtest: small-bo
[500.084791] Subtest small-bo: SUCCESS (0.000s)
[500.269765] [112/154] (586s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[501.812138] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[501.815278] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[501.990704] [113/154] (585s left) kms_plane (pixel-format-y-tiled-modifier)
[503.484290] Starting subtest: pixel-format-y-tiled-modifier
[503.514768] Starting dynamic subtest: pipe-A-plane-0
[504.215343] Dynamic subtest pipe-A-plane-0: SUCCESS (0.699s)
[504.263240] Starting dynamic subtest: pipe-A-plane-3
[504.682302] Dynamic subtest pipe-A-plane-3: SUCCESS (0.461s)
[504.734673] Starting dynamic subtest: pipe-A-plane-5
[505.181850] Dynamic subtest pipe-A-plane-5: SUCCESS (0.494s)
[505.213073] Starting dynamic subtest: pipe-A-plane-7
[505.216662] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[505.345434] Starting dynamic subtest: pipe-B-plane-0
[505.866146] Dynamic subtest pipe-B-plane-0: SUCCESS (0.533s)
[505.917320] Starting dynamic subtest: pipe-B-plane-3
[506.348454] Dynamic subtest pipe-B-plane-3: SUCCESS (0.475s)
[506.396106] Starting dynamic subtest: pipe-B-plane-5
[506.849454] Dynamic subtest pipe-B-plane-5: SUCCESS (0.496s)
[506.868384] Starting dynamic subtest: pipe-B-plane-7
[506.871445] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[506.904695] Subtest pixel-format-y-tiled-modifier: SUCCESS (3.421s)
[507.167250] [114/154] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[508.665731] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[508.668628] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[508.861626] [115/154] (578s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[510.352705] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[510.432761] [116/154] (576s left) gem_partial_pwrite_pread (writes-after-reads)
[510.494144] Subtest writes-after-reads: SKIP (0.000s)
[510.601979] [117/154] (576s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[512.101016] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[512.103589] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[512.279951] [118/154] (575s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[513.769902] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[513.771509] Starting dynamic subtest: pipe-A
[516.582505] Dynamic subtest pipe-A: SUCCESS (2.812s)
[516.609520] Starting dynamic subtest: pipe-B
[519.306013] Dynamic subtest pipe-B: SUCCESS (2.721s)
[519.333582] Starting dynamic subtest: pipe-C
[519.612237] Dynamic subtest pipe-C: SUCCESS (0.304s)
[519.630004] Starting dynamic subtest: pipe-D
[519.919887] Dynamic subtest pipe-D: SUCCESS (0.306s)
[519.921533] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.152s)
[520.165631] [119/154] (567s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[521.662428] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[521.742951] [120/154] (565s left) kms_content_protection (atomic-hdcp14)
[523.291251] Starting subtest: atomic-hdcp14
[523.295737] Subtest atomic-hdcp14: SKIP (0.002s)
[523.516206] [121/154] (564s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[523.571850] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[523.573445] Starting dynamic subtest: smem
[523.679399] Dynamic subtest smem: SUCCESS (0.104s)
[523.693942] Starting dynamic subtest: lmem0
[524.791872] Dynamic subtest lmem0: SUCCESS (1.110s)
[524.793719] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (1.217s)
[525.072443] [122/154] (562s left) kms_psr (pr-cursor-plane-move)
[526.578275] Subtest pr-cursor-plane-move: SKIP (0.000s)
[526.657758] [123/154] (561s left) kms_vrr (flip-basic-fastset)
[528.147580] Starting subtest: flip-basic-fastset
[528.151784] Subtest flip-basic-fastset: SKIP (0.000s)
[528.269498] [124/154] (559s left) kms_force_connector_basic (force-connector-state)
[528.409065] Starting subtest: force-connector-state
[530.112123] Subtest force-connector-state: SUCCESS (1.705s)
[531.855476] [125/154] (556s left) kms_psr (psr-cursor-mmap-gtt)
[533.350457] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[533.434643] [126/154] (554s left) gem_exec_balancer (parallel-keep-in-fence)
[533.857305] Starting subtest: parallel-keep-in-fence
[536.239692] Subtest parallel-keep-in-fence: SUCCESS (2.382s)
[536.358278] [127/154] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[537.874119] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[537.877787] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[538.102573] [128/154] (550s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[539.600735] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[539.604086] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[539.782944] [129/154] (548s left) syncobj_wait (single-wait-submitted)
[539.831879] Starting subtest: single-wait-submitted
[539.942222] Subtest single-wait-submitted: SUCCESS (0.106s)
[540.166606] [130/154] (548s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[541.661357] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[541.737233] [131/154] (546s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[543.246622] Starting subtest: yf-tiled-32bpp-rotate-180
[543.250247] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[543.443283] [132/154] (545s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[543.495133] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[543.496765] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[543.619369] [133/154] (545s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[545.145822] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[556.092102] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.946s)
[556.293200] [134/154] (532s left) tools_test (tools_test)
[556.361698] Starting subtest: tools_test
[556.460742] Subtest tools_test: SUCCESS (0.107s)
[556.574742] [135/154] (532s left) gem_mmap_gtt (basic-small-bo)
[556.625137] Subtest basic-small-bo: SKIP (0.000s)
[556.713669] [136/154] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[558.208651] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[558.211444] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[558.399859] [137/154] (530s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[559.900138] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[559.913841] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[560.086334] [138/154] (529s left) gem_ctx_isolation (dirty-switch)
[560.145686] Starting subtest: dirty-switch
[560.147165] Starting dynamic subtest: rcs0
[560.951841] Dynamic subtest rcs0: SUCCESS (0.805s)
[560.969269] Starting dynamic subtest: bcs0
[561.792524] Dynamic subtest bcs0: SUCCESS (0.839s)
[561.807942] Starting dynamic subtest: vcs0
[562.634367] Dynamic subtest vcs0: SUCCESS (0.840s)
[562.650097] Starting dynamic subtest: vcs1
[563.488798] Dynamic subtest vcs1: SUCCESS (0.853s)
[563.504135] Starting dynamic subtest: vecs0
[564.345869] Dynamic subtest vecs0: SUCCESS (0.856s)
[564.347364] Subtest dirty-switch: SUCCESS (4.202s)
[564.712508] [139/154] (524s left) kms_psr (fbc-psr-sprite-plane-onoff)
[566.208484] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[566.295497] [140/154] (523s left) kms_getfb (getfb2-handle-closed)
[567.790344] Starting subtest: getfb2-handle-closed
[567.792122] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[567.942509] [141/154] (521s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[569.454115] Starting subtest: x-tiled-32bpp-rotate-90
[569.563361] Subtest x-tiled-32bpp-rotate-90: SKIP (0.108s)
[569.716447] [142/154] (520s left) gem_sync (basic-each)
[569.782627] Starting subtest: basic-each
[572.161107] Subtest basic-each: SUCCESS (2.382s)
[572.517915] [143/154] (517s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[574.018100] Starting subtest: fbc-rgb565-draw-mmap-cpu
[576.545859] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.532s)
[576.754951] [144/154] (513s left) kms_color (deep-color)
[578.269498] Starting subtest: deep-color
[578.286365] Subtest deep-color: SKIP (0.003s)
[578.395154] [145/154] (511s left) kms_big_fb (linear-addfb)
[579.915518] Starting subtest: linear-addfb
[579.917042] Subtest linear-addfb: SUCCESS (0.000s)
[580.154076] [146/154] (510s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[581.656621] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[581.660359] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[581.819001] [147/154] (508s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[583.320312] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[583.323565] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[583.526641] [148/154] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[585.040359] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[585.043619] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[585.230730] [149/154] (505s left) kms_cursor_edge_walk (128x128-top-bottom)
[586.724090] Starting subtest: 128x128-top-bottom
[586.725842] Starting dynamic subtest: pipe-A-HDMI-A-4
[590.045367] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.321s)
[590.060551] Starting dynamic subtest: pipe-D-HDMI-A-4
[593.269712] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.222s)
[593.271266] Subtest 128x128-top-bottom: SUCCESS (6.548s)
[593.478665] [150/154] (497s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[594.977004] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[594.979872] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[595.160801] [151/154] (495s left) gem_exec_fence (syncobj-export)
[595.591880] Starting subtest: syncobj-export
[595.611729] Subtest syncobj-export: SUCCESS (0.020s)
[596.050689] [152/154] (494s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[597.546666] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[597.549728] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[597.795983] [153/154] (493s left) gem_softpin (invalid)
[597.849354] Starting subtest: invalid
[597.864565] Subtest invalid: SUCCESS (0.015s)
[598.070240] [154/154] (493s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[599.568500] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[599.571560] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[599.734382] 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.