[60.259777] Initializing watchdogs
[60.259825]   /dev/watchdog0
[60.274960] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.279564] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.281919] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.285200] [001/156] (960s left) syncobj_timeline (host-signal-ordered)
[60.359087] Starting subtest: host-signal-ordered
[60.361485] Subtest host-signal-ordered: SUCCESS (0.001s)
[60.465330] [002/156] (960s left) gem_ctx_isolation (clean)
[60.517887] Starting subtest: clean
[60.520405] Starting dynamic subtest: rcs0
[60.576745] Dynamic subtest rcs0: SUCCESS (0.059s)
[60.585720] Starting dynamic subtest: bcs0
[60.643107] Dynamic subtest bcs0: SUCCESS (0.066s)
[60.653144] Starting dynamic subtest: vcs0
[60.676797] Dynamic subtest vcs0: SUCCESS (0.034s)
[60.684657] Starting dynamic subtest: vcs1
[62.338998] Dynamic subtest vcs1: SUCCESS (1.667s)
[62.347672] Starting dynamic subtest: vecs0
[64.356100] Dynamic subtest vecs0: SUCCESS (2.023s)
[64.364292] Starting dynamic subtest: ccs0
[66.358557] Dynamic subtest ccs0: SUCCESS (2.006s)
[66.360924] Subtest clean: SUCCESS (5.858s)
[66.592598] [003/156] (954s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[66.696199] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[66.700513] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[66.793167] [004/156] (954s left) kms_busy (extended-pageflip-hang-newfb)
[66.900888] Starting subtest: extended-pageflip-hang-newfb
[66.902827] Starting dynamic subtest: pipe-A
[93.192047] Dynamic subtest pipe-A: SUCCESS (26.304s)
[93.203652] Starting dynamic subtest: pipe-D
[108.161562] Dynamic subtest pipe-D: SUCCESS (14.967s)
[108.163951] Subtest extended-pageflip-hang-newfb: SUCCESS (41.275s)
[109.039338] [005/156] (911s left) kms_color (ctm-0-50)
[109.140694] Starting subtest: ctm-0-50
[109.143026] Starting dynamic subtest: pipe-A-eDP-1
[112.671167] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.529s)
[112.679208] Starting dynamic subtest: pipe-B-eDP-1
[116.970844] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.302s)
[116.979404] Starting dynamic subtest: pipe-C-eDP-1
[121.132252] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.160s)
[121.141553] Starting dynamic subtest: pipe-D-eDP-1
[125.134113] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.001s)
[125.136532] Subtest ctm-0-50: SUCCESS (15.994s)
[125.959614] [006/156] (895s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[126.072809] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[126.076875] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[126.190713] [007/156] (894s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[126.294992] Starting subtest: y-tiled-64bpp-rotate-180
[126.299391] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[126.382786] [008/156] (894s left) kms_psr (fbc-psr-cursor-plane-onoff)
[126.474613] Starting subtest: fbc-psr-cursor-plane-onoff
[126.476814] Starting dynamic subtest: eDP-1
[126.481245] Dynamic subtest eDP-1: SKIP (0.000s)
[126.485678] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[126.543305] [009/156] (894s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[126.640846] Starting subtest: fbcpsrhdr-rgb565-draw-render
[126.645426] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[126.722709] [010/156] (894s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[126.823603] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[126.825615] Starting dynamic subtest: pipe-A-eDP-1
[127.274243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[127.284468] Starting dynamic subtest: pipe-B-eDP-1
[127.301643] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[127.313468] Starting dynamic subtest: pipe-C-eDP-1
[127.330309] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[127.338259] Starting dynamic subtest: pipe-D-eDP-1
[127.354872] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[127.356466] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.469s)
[129.535765] [011/156] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[129.645994] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[129.650077] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[129.743127] [012/156] (891s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[129.844887] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[129.849191] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[129.951022] [013/156] (891s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[130.038864] Starting subtest: fb-8bpc-vs-panel-6bpc
[130.041685] Starting dynamic subtest: pipe-A-eDP-1
[131.426941] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.388s)
[131.429702] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.389s)
[132.282796] [014/156] (889s left) gem_mmap_gtt (cpuset-big-copy)
[132.353041] Subtest cpuset-big-copy: SKIP (0.000s)
[132.413193] [015/156] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[132.514219] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[136.198141] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.691s)
[137.393971] [016/156] (884s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[137.497396] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[138.154196] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[138.314750] [017/156] (883s left) gem_exec_reloc (basic-write-read-active)
[138.368883] Subtest basic-write-read-active: SKIP (0.000s)
[138.439667] [018/156] (883s left) kms_cursor_crc (cursor-sliding-128x42)
[138.651974] Starting subtest: cursor-sliding-128x42
[138.704734] Subtest cursor-sliding-128x42: SKIP (0.047s)
[138.904291] [019/156] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[139.012805] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[146.083051] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.077s)
[146.171308] [020/156] (875s left) gem_pxp (create-regular-buffer)
[146.293162] Starting subtest: create-regular-buffer
[146.295726] Subtest create-regular-buffer: SUCCESS (0.000s)
[146.402610] [021/156] (875s left) syncobj_wait (wait-all-for-submit-snapshot)
[146.449888] Starting subtest: wait-all-for-submit-snapshot
[146.530962] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[146.604691] [022/156] (875s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[146.704434] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[146.708570] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[146.796098] [023/156] (874s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[146.888519] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[151.239407] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.356s)
[152.399861] [024/156] (869s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[152.500667] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[156.684551] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.189s)
[157.906167] [025/156] (863s left) kms_rotation_crc (bad-pixel-format)
[157.994821] Starting subtest: bad-pixel-format
[157.999017] Subtest bad-pixel-format: SKIP (0.001s)
[158.067280] [026/156] (863s left) api_intel_bb (misplaced-blitter)
[158.123207] Starting subtest: misplaced-blitter
[158.129297] Subtest misplaced-blitter: SUCCESS (0.008s)
[158.260397] [027/156] (863s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[158.354827] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[158.356726] Starting dynamic subtest: pipe-A-eDP-1
[158.379660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[158.387990] Starting dynamic subtest: pipe-B-eDP-1
[158.408337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[158.416731] Starting dynamic subtest: pipe-C-eDP-1
[158.437160] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[158.446354] Starting dynamic subtest: pipe-D-eDP-1
[158.467058] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[158.469369] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[160.765307] [028/156] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[160.869261] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[160.873839] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[160.981372] [029/156] (860s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[161.028979] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[161.134951] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[161.222852] [030/156] (860s left) gem_exec_fence (syncobj-timeline-repeat)
[161.781154] Starting subtest: syncobj-timeline-repeat
[162.035942] Subtest syncobj-timeline-repeat: SUCCESS (0.254s)
[163.394042] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[163.397381] [031/156] (858s left) kms_flip (2x-plain-flip-ts-check)
[163.488183] Starting subtest: 2x-plain-flip-ts-check
[163.500389] Subtest 2x-plain-flip-ts-check: SKIP (0.012s)
[163.591338] [032/156] (858s left) i915_suspend (forcewake)
[163.638617] Starting subtest: forcewake
[195.851490] Subtest forcewake: SUCCESS (4.016s)
[202.943770] [033/156] (826s left) kms_cursor_crc (cursor-offscreen-256x256)
[203.196551] Starting subtest: cursor-offscreen-256x256
[203.201286] Starting dynamic subtest: pipe-A-eDP-1
[205.134994] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.953s)
[205.164117] Starting dynamic subtest: pipe-D-eDP-1
[207.783674] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.647s)
[207.786150] Subtest cursor-offscreen-256x256: SUCCESS (4.627s)
[208.629953] [034/156] (820s left) sysfs_heartbeat_interval (invalid)
[208.680636] Starting subtest: invalid
[208.682963] Starting dynamic subtest: vecs0
[208.685171] Dynamic subtest vecs0: SUCCESS (0.000s)
[208.695826] Starting dynamic subtest: ccs0
[208.697973] Dynamic subtest ccs0: SUCCESS (0.000s)
[208.707063] Starting dynamic subtest: vcs0
[208.708949] Dynamic subtest vcs0: SUCCESS (0.000s)
[208.718707] Starting dynamic subtest: bcs0
[208.720806] Dynamic subtest bcs0: SUCCESS (0.000s)
[208.729443] Starting dynamic subtest: rcs0
[208.731511] Dynamic subtest rcs0: SUCCESS (0.000s)
[208.739988] Starting dynamic subtest: vcs1
[208.742040] Dynamic subtest vcs1: SUCCESS (0.000s)
[208.744071] Subtest invalid: SUCCESS (0.005s)
[208.782883] [035/156] (820s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[208.896352] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[208.900639] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[209.044998] [036/156] (820s left) kms_prop_blob (invalid-get-prop)
[209.096157] Starting subtest: invalid-get-prop
[209.098394] Subtest invalid-get-prop: SUCCESS (0.000s)
[209.191052] [037/156] (820s left) kms_flip (2x-flip-vs-suspend)
[209.277599] Starting subtest: 2x-flip-vs-suspend
[209.282147] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[209.404217] [038/156] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[209.506885] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[216.620669] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.144s)
[216.734488] [039/156] (812s left) perf (unprivileged-single-ctx-counters)
[216.866541] Starting subtest: unprivileged-single-ctx-counters
[216.870840] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[216.910313] [040/156] (812s left) vgem_basic (dmabuf-fence-before)
[216.954946] Starting subtest: dmabuf-fence-before
[216.956921] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[217.010064] [041/156] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[217.108363] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[223.709188] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.618s)
[223.835466] [042/156] (805s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[223.890116] Starting subtest: multi-wait-available-unsubmitted-submitted
[223.892123] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[223.983720] [043/156] (805s left) kms_flip (2x-blocking-wf_vblank)
[224.072530] Starting subtest: 2x-blocking-wf_vblank
[224.083968] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[224.206441] [044/156] (805s left) kms_chamelium_hpd (vga-hpd-fast)
[224.581656] Subtest vga-hpd-fast: SKIP (0.000s)
[225.375125] [045/156] (804s left) gen9_exec_parse (batch-without-end)
[225.437692] Subtest batch-without-end: SKIP (0.000s)
[225.493685] [046/156] (804s left) gem_mmap_gtt (basic)
[225.550945] Subtest basic: SKIP (0.000s)
[225.606604] [047/156] (804s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move)
[225.698293] Starting subtest: hdr-1p-primscrn-cur-indfb-move
[225.702502] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[225.800740] [048/156] (803s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[225.906443] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[225.910901] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[226.013270] [049/156] (803s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[226.097730] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[226.099910] Starting dynamic subtest: pipe-A
[226.121179] Dynamic subtest pipe-A: SKIP (0.020s)
[226.130898] Starting dynamic subtest: pipe-B
[226.157669] Dynamic subtest pipe-B: SKIP (0.035s)
[226.166767] Starting dynamic subtest: pipe-C
[226.193268] Dynamic subtest pipe-C: SKIP (0.034s)
[226.205891] Starting dynamic subtest: pipe-D
[226.226206] Dynamic subtest pipe-D: SKIP (0.034s)
[226.230448] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.125s)
[226.348478] [050/156] (803s left) kms_setmode (basic-clone-single-crtc)
[226.397319] Starting subtest: basic-clone-single-crtc
[226.402463] Subtest basic-clone-single-crtc: SKIP (0.000s)
[226.513873] [051/156] (803s left) kms_hdr (bpc-switch-suspend)
[226.601535] Starting subtest: bpc-switch-suspend
[226.603408] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[247.994067] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (6.075s)
[248.004058] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[268.983295] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (6.105s)
[268.985823] Subtest bpc-switch-suspend: SUCCESS (12.185s)
[278.115985] [052/156] (760s left) api_intel_allocator (reopen)
[278.178549] Starting subtest: reopen
[278.185044] Subtest reopen: SUCCESS (0.008s)
[278.299242] [053/156] (760s left) gem_mmap_offset (isolation)
[278.348063] Starting subtest: isolation
[278.367456] Subtest isolation: SUCCESS (0.007s)
[278.456865] [054/156] (760s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[278.557615] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[278.562658] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[278.652444] [055/156] (760s left) gem_ctx_persistence (many-contexts)
[278.717445] Starting subtest: many-contexts
[323.814078] Subtest many-contexts: SUCCESS (45.181s)
[323.897901] [056/156] (715s left) kms_draw_crc (draw-method-mmap-cpu)
[323.990426] Starting subtest: draw-method-mmap-cpu
[323.992478] Starting dynamic subtest: xrgb8888-untiled
[324.222610] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[324.233301] Starting dynamic subtest: rgb565-untiled
[324.433664] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[324.443588] Starting dynamic subtest: xrgb2101010-untiled
[324.655665] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[324.665798] Starting dynamic subtest: xbgr16161616f-untiled
[324.878810] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[324.888380] Starting dynamic subtest: xrgb8888-xtiled
[325.011051] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[325.020349] Starting dynamic subtest: rgb565-xtiled
[325.144429] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[325.155999] Starting dynamic subtest: xrgb2101010-xtiled
[325.277427] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[325.287194] Starting dynamic subtest: xbgr16161616f-xtiled
[325.411138] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[325.420289] Starting dynamic subtest: xrgb8888-4tiled
[325.555243] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[325.564811] Starting dynamic subtest: rgb565-4tiled
[325.711324] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[325.721633] Starting dynamic subtest: xrgb2101010-4tiled
[325.857510] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[325.866687] Starting dynamic subtest: xbgr16161616f-4tiled
[326.000139] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[326.002419] Subtest draw-method-mmap-cpu: SUCCESS (2.012s)
[326.094339] [057/156] (713s left) syncobj_eventfd (binary-wait-before-signal)
[326.142107] Starting subtest: binary-wait-before-signal
[326.171355] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[326.248993] [058/156] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[326.347270] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[326.351476] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[326.457985] [059/156] (712s left) kms_plane_lowres (tiling-yf)
[326.544782] Starting subtest: tiling-yf
[326.548967] Subtest tiling-yf: SKIP (0.000s)
[326.618530] [060/156] (712s left) kms_invalid_mode (uint-max-clock)
[326.715999] Starting subtest: uint-max-clock
[326.718086] Starting dynamic subtest: pipe-A-eDP-1
[327.003295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[327.013389] Starting dynamic subtest: pipe-B-eDP-1
[327.015643] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[327.024798] Starting dynamic subtest: pipe-C-eDP-1
[327.027108] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[327.037463] Starting dynamic subtest: pipe-D-eDP-1
[327.039854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[327.042663] Subtest uint-max-clock: SUCCESS (0.296s)
[327.891178] [061/156] (711s left) gem_ctx_shared (exec-single-timeline)
[327.946392] Starting subtest: exec-single-timeline
[327.949262] Starting dynamic subtest: rcs0
[328.973777] Dynamic subtest rcs0: SUCCESS (1.026s)
[328.986980] Starting dynamic subtest: bcs0
[330.062267] Dynamic subtest bcs0: SUCCESS (1.086s)
[330.076474] Starting dynamic subtest: vcs0
[331.151020] Dynamic subtest vcs0: SUCCESS (1.085s)
[331.163672] Starting dynamic subtest: vcs1
[332.239016] Dynamic subtest vcs1: SUCCESS (1.085s)
[332.252555] Starting dynamic subtest: vecs0
[333.326214] Dynamic subtest vecs0: SUCCESS (1.085s)
[333.338787] Starting dynamic subtest: ccs0
[334.414961] Dynamic subtest ccs0: SUCCESS (1.085s)
[334.418267] Subtest exec-single-timeline: SUCCESS (6.469s)
[334.633509] [062/156] (704s left) perf_pmu (enable-race)
[334.679003] Starting subtest: enable-race
[334.681779] Starting dynamic subtest: rcs0
[347.443300] Dynamic subtest rcs0: SUCCESS (12.767s)
[347.452769] Starting dynamic subtest: bcs0
[360.188608] Dynamic subtest bcs0: SUCCESS (12.747s)
[360.198138] Starting dynamic subtest: vcs0
[375.731116] Dynamic subtest vcs0: SUCCESS (15.543s)
[375.743247] Starting dynamic subtest: vcs1
[391.665787] Dynamic subtest vcs1: SUCCESS (15.925s)
[391.677594] Starting dynamic subtest: vecs0
[407.665736] Dynamic subtest vecs0: SUCCESS (15.995s)
[407.677119] Starting dynamic subtest: ccs0
[420.419791] Dynamic subtest ccs0: SUCCESS (12.753s)
[420.422528] Subtest enable-race: SUCCESS (85.745s)
[420.528474] [063/156] (618s left) kms_selftest (drm_cmdline_parser)
[420.567677] Starting subtest: drm_cmdline_parser
[420.594696] Starting dynamic subtest: drm_test_cmdline_force_d_only
[420.683633] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.088s)
[420.693837] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[420.761453] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.078s)
[420.771054] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[420.857861] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.095s)
[420.867302] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[420.946592] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.087s)
[420.956622] Starting dynamic subtest: drm_test_cmdline_force_e_only
[421.039631] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.092s)
[421.052334] Starting dynamic subtest: drm_test_cmdline_res
[421.118605] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.076s)
[421.129495] Starting dynamic subtest: drm_test_cmdline_res_vesa
[421.204829] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.084s)
[421.214818] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[421.289606] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.083s)
[421.299386] Starting dynamic subtest: drm_test_cmdline_res_rblank
[421.372750] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.082s)
[421.382813] Starting dynamic subtest: drm_test_cmdline_res_bpp
[421.473298] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.099s)
[421.483000] Starting dynamic subtest: drm_test_cmdline_res_refresh
[421.554423] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.079s)
[421.565347] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[421.638346] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.081s)
[421.647961] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[421.727432] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.087s)
[421.739924] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[421.805068] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.078s)
[421.814471] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[421.881906] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.075s)
[421.892617] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[421.961672] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.078s)
[421.971205] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[422.042655] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.079s)
[422.052460] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[422.135111] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.092s)
[422.144797] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[422.225741] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.089s)
[422.245509] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[422.313605] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.088s)
[422.330667] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[422.397464] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.082s)
[422.408884] Starting dynamic subtest: drm_test_cmdline_name
[422.476228] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.077s)
[422.486793] Starting dynamic subtest: drm_test_cmdline_name_bpp
[422.554318] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.076s)
[422.563658] Starting dynamic subtest: drm_test_cmdline_name_option
[422.656662] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.102s)
[422.669181] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[422.739578] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.080s)
[422.753572] Starting dynamic subtest: drm_test_cmdline_rotate_0
[422.816734] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.076s)
[422.827151] Starting dynamic subtest: drm_test_cmdline_rotate_90
[422.906628] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.086s)
[422.917529] Starting dynamic subtest: drm_test_cmdline_rotate_180
[422.996477] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.088s)
[423.005372] Starting dynamic subtest: drm_test_cmdline_rotate_270
[423.084838] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.089s)
[423.094543] Starting dynamic subtest: drm_test_cmdline_hmirror
[423.167095] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.082s)
[423.176511] Starting dynamic subtest: drm_test_cmdline_vmirror
[423.251321] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.083s)
[423.260692] Starting dynamic subtest: drm_test_cmdline_margin_options
[423.340369] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.086s)
[423.349447] Starting dynamic subtest: drm_test_cmdline_multiple_options
[423.422720] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.082s)
[423.433929] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[423.500329] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.076s)
[423.511507] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[423.580355] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.079s)
[423.591627] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[423.657130] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.076s)
[423.667484] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[423.743177] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.086s)
[423.753143] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[423.833718] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.090s)
[423.847673] Starting dynamic subtest: drm_test_cmdline_invalid
[423.943575] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.109s)
[423.954006] Starting dynamic subtest: drm_test_cmdline_tv_options
[424.037189] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.093s)
[424.039613] Subtest drm_cmdline_parser: SUCCESS (3.472s)
[424.187463] [064/156] (615s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[424.285958] Starting subtest: psr-rgb565-draw-render
[431.309506] Subtest psr-rgb565-draw-render: SUCCESS (7.029s)
[431.425858] [065/156] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[431.534705] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[431.540598] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[431.624223] [066/156] (607s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[431.678609] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[431.781385] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[431.863500] [067/156] (607s left) gem_render_copy (linear-to-vebox-yf-tiled)
[431.925842] Starting subtest: linear-to-vebox-yf-tiled
[431.931649] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[432.111444] [068/156] (607s left) gem_exec_schedule (submit-late-slice)
[432.192415] Starting subtest: submit-late-slice
[432.194696] Starting dynamic subtest: rcs0
[432.232641] Dynamic subtest rcs0: SUCCESS (0.048s)
[432.242416] Starting dynamic subtest: bcs0
[432.264703] Dynamic subtest bcs0: SUCCESS (0.031s)
[432.274149] Starting dynamic subtest: vcs0
[432.299481] Dynamic subtest vcs0: SUCCESS (0.034s)
[432.311564] Starting dynamic subtest: vcs1
[432.330069] Dynamic subtest vcs1: SUCCESS (0.030s)
[432.341148] Starting dynamic subtest: vecs0
[432.359275] Dynamic subtest vecs0: SUCCESS (0.029s)
[432.368678] Starting dynamic subtest: ccs0
[432.392360] Dynamic subtest ccs0: SUCCESS (0.032s)
[432.395115] Subtest submit-late-slice: SUCCESS (0.209s)
[433.794110] [069/156] (605s left) i915_hangman (gt-engine-hang)
[433.859699] Starting subtest: gt-engine-hang
[433.862573] Starting dynamic subtest: rcs0
[435.667465] Dynamic subtest rcs0: SUCCESS (1.807s)
[435.677983] Starting dynamic subtest: bcs0
[437.647849] Dynamic subtest bcs0: SUCCESS (1.978s)
[437.660246] Starting dynamic subtest: vcs0
[439.694397] Dynamic subtest vcs0: SUCCESS (2.045s)
[439.706508] Starting dynamic subtest: vcs1
[441.680212] Dynamic subtest vcs1: SUCCESS (1.984s)
[441.693019] Starting dynamic subtest: vecs0
[443.663567] Dynamic subtest vecs0: SUCCESS (1.980s)
[443.677365] Starting dynamic subtest: ccs0
[445.647083] Dynamic subtest ccs0: SUCCESS (1.982s)
[445.649984] Subtest gt-engine-hang: SUCCESS (11.791s)
[445.732636] [070/156] (593s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[445.832062] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[445.837246] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[445.933186] [071/156] (593s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[445.995623] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[446.000643] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[446.182473] [072/156] (593s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[446.231779] Starting subtest: multi-wait-for-submit-unsubmitted
[446.333777] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[446.416326] [073/156] (593s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[446.515190] Starting subtest: fbcpsr-rgb565-draw-pwrite
[453.667822] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.159s)
[453.780222] [074/156] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[453.878365] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[461.267673] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.397s)
[461.371965] [075/156] (578s left) perf (buffer-fill)
[461.458941] Starting subtest: buffer-fill
[461.461810] Starting dynamic subtest: 0-rcs0
[463.737405] Dynamic subtest 0-rcs0: SUCCESS (2.277s)
[463.747646] Starting dynamic subtest: 1-vecs0
[468.179894] Dynamic subtest 1-vecs0: SUCCESS (4.442s)
[468.182699] Subtest buffer-fill: SUCCESS (6.722s)
[468.237002] [076/156] (571s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[468.333054] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[468.337674] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[468.438364] [077/156] (571s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[468.535187] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[468.537542] Starting dynamic subtest: pipe-A-eDP-1
[468.547015] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[468.557125] Starting dynamic subtest: pipe-B-eDP-1
[468.566339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.577316] Starting dynamic subtest: pipe-C-eDP-1
[468.587030] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.596014] Starting dynamic subtest: pipe-D-eDP-1
[468.605894] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.610595] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[470.855641] [078/156] (569s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[470.954786] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[471.856723] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.904s)
[472.021004] [079/156] (568s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[472.117606] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[472.122985] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[472.187330] [080/156] (567s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[472.284565] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[472.289810] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[472.360204] [081/156] (567s left) gem_wait (wait)
[472.417479] Starting subtest: wait
[472.420081] Starting dynamic subtest: all-engines
[473.714100] Dynamic subtest all-engines: SUCCESS (1.295s)
[473.726146] Starting dynamic subtest: rcs0
[474.764145] Dynamic subtest rcs0: SUCCESS (1.048s)
[474.777363] Starting dynamic subtest: bcs0
[475.816954] Dynamic subtest bcs0: SUCCESS (1.050s)
[475.829792] Starting dynamic subtest: vcs0
[476.867230] Dynamic subtest vcs0: SUCCESS (1.048s)
[476.879934] Starting dynamic subtest: vcs1
[477.916815] Dynamic subtest vcs1: SUCCESS (1.048s)
[477.931609] Starting dynamic subtest: vecs0
[478.968830] Dynamic subtest vecs0: SUCCESS (1.049s)
[478.981564] Starting dynamic subtest: ccs0
[480.024592] Dynamic subtest ccs0: SUCCESS (1.053s)
[480.027820] Subtest wait: SUCCESS (7.610s)
[480.242047] [082/156] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[480.350437] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[480.355173] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[480.443210] [083/156] (559s left) kms_cursor_crc (cursor-sliding-64x64)
[480.621808] Starting subtest: cursor-sliding-64x64
[480.624682] Starting dynamic subtest: pipe-A-eDP-1
[483.882634] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.258s)
[483.912199] Starting dynamic subtest: pipe-D-eDP-1
[487.780485] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.875s)
[487.783218] Subtest cursor-sliding-64x64: SUCCESS (7.158s)
[488.633333] [084/156] (551s left) kms_psr (psr2-cursor-render)
[488.719501] Starting subtest: psr2-cursor-render
[488.722266] Starting dynamic subtest: eDP-1
[490.422615] Dynamic subtest eDP-1: SUCCESS (1.702s)
[490.425312] Subtest psr2-cursor-render: SUCCESS (1.703s)
[491.305057] [085/156] (549s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[491.436717] Starting subtest: cursorA-vs-flipB-atomic-transitions
[491.442402] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[491.578783] [086/156] (548s left) i915_pm_rps (min-max-config-loaded)
[491.643566] Starting subtest: min-max-config-loaded
[491.649341] Subtest min-max-config-loaded: SKIP (0.001s)
[491.743460] [087/156] (548s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[491.835578] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[491.838160] Starting dynamic subtest: pipe-A-eDP-1
[491.861784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[491.872079] Starting dynamic subtest: pipe-B-eDP-1
[491.896497] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[491.905807] Starting dynamic subtest: pipe-C-eDP-1
[491.931206] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[491.940436] Starting dynamic subtest: pipe-D-eDP-1
[491.966163] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[491.971510] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[494.163733] [088/156] (546s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[494.217652] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[494.292487] [089/156] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[494.383584] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[494.388612] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[494.484630] [090/156] (546s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[494.545803] Starting subtest: invalid-single-wait-all-unsubmitted
[494.548606] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[494.654720] [091/156] (545s left) kms_lease (lease-again)
[494.740515] Starting subtest: lease-again
[494.743100] Starting dynamic subtest: pipe-A-eDP-1
[494.745633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[494.756341] Starting dynamic subtest: pipe-B-eDP-1
[494.758840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[494.768491] Starting dynamic subtest: pipe-C-eDP-1
[494.770947] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[494.781798] Starting dynamic subtest: pipe-D-eDP-1
[494.784582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[494.787567] Subtest lease-again: SUCCESS (0.013s)
[494.856332] [092/156] (545s left) gem_exec_balancer (busy)
[494.904139] Starting subtest: busy
[496.666690] Subtest busy: SUCCESS (1.761s)
[496.991199] [093/156] (543s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[497.085650] Starting subtest: basic-modeset-with-all-modifiers-formats
[497.458196] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[498.243100] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.786s)
[498.254352] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[498.264322] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[498.274089] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[498.286510] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[498.296618] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[498.452805] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[498.465102] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[498.475358] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[498.485168] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[498.497313] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[498.507848] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[498.520212] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.023s)
[498.530477] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[498.541664] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[498.551130] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[498.564486] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[498.581717] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[498.587689] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[498.598016] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[498.608806] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[498.619175] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[498.630784] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[498.641052] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[498.797207] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[498.806802] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[498.819652] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[498.829811] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[498.841786] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[498.851563] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[498.863818] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[498.873544] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[498.886312] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[498.895677] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[498.908590] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[498.918537] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[498.930809] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[498.940742] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[498.952814] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[498.963964] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[498.975093] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[498.985647] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[499.142104] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.167s)
[499.151803] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[499.164235] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[499.173658] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[499.186185] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[499.195519] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[499.208487] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[499.218117] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[499.230770] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[499.240295] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[499.252795] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[499.262190] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[499.275247] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[499.284382] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[499.297313] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[499.306401] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[499.319745] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[499.700742] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.617s)
[500.510693] [094/156] (540s left) gen9_exec_parse (unaligned-jump)
[500.563184] Subtest unaligned-jump: SKIP (0.000s)
[500.631257] [095/156] (540s left) gem_exec_params (secure-non-master)
[500.681421] Starting subtest: secure-non-master
[500.685992] Subtest secure-non-master: SKIP (0.000s)
[500.777292] [096/156] (540s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[500.865655] Starting subtest: sprite-rotation-90-pos-100-0
[500.870567] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[500.943488] [097/156] (539s left) kms_addfb_basic (bad-pitch-256)
[500.995943] Starting subtest: bad-pitch-256
[500.998405] Subtest bad-pitch-256: SUCCESS (0.000s)
[501.147481] [098/156] (539s left) gem_ctx_engines (none)
[501.201571] Starting subtest: none
[501.204437] Subtest none: SUCCESS (0.001s)
[501.400472] [099/156] (539s left) syncobj_wait (single-wait-for-submit-signaled)
[501.447730] Starting subtest: single-wait-for-submit-signaled
[501.450632] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[501.562139] [100/156] (539s left) gem_mmap_wc (write)
[501.626649] Subtest write: SKIP (0.000s)
[501.683244] [101/156] (539s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[501.788360] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[501.793408] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[501.889187] [102/156] (539s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[501.942631] Starting subtest: invalid-multi-wait-all-unsubmitted
[501.945448] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[502.042287] [103/156] (539s left) perf_pmu (busy-double-start)
[502.077653] Starting subtest: busy-double-start
[502.080193] Starting dynamic subtest: rcs0
[505.730814] Dynamic subtest rcs0: FAIL (3.579s)
[505.742073] Starting dynamic subtest: bcs0
[509.229941] Dynamic subtest bcs0: SUCCESS (3.570s)
[509.241798] Starting dynamic subtest: vcs0
[513.219415] Dynamic subtest vcs0: SUCCESS (3.985s)
[513.232233] Starting dynamic subtest: vcs1
[517.255104] Dynamic subtest vcs1: SUCCESS (4.033s)
[517.266848] Starting dynamic subtest: vecs0
[521.218104] Dynamic subtest vecs0: SUCCESS (3.959s)
[521.231953] Starting dynamic subtest: ccs0
[524.868518] Dynamic subtest ccs0: FAIL (3.566s)
[524.870706] Subtest busy-double-start: FAIL (22.703s)
[524.917810] [104/156] (516s left) gem_exec_schedule (pi-ringfull)
[525.105536] Starting subtest: pi-ringfull
[525.108439] Starting dynamic subtest: rcs0
[525.143024] Dynamic subtest rcs0: SUCCESS (0.041s)
[525.153605] Starting dynamic subtest: bcs0
[525.189525] Dynamic subtest bcs0: SUCCESS (0.045s)
[525.199838] Starting dynamic subtest: vcs0
[525.229084] Dynamic subtest vcs0: SUCCESS (0.039s)
[525.240790] Starting dynamic subtest: vcs1
[525.263803] Dynamic subtest vcs1: SUCCESS (0.034s)
[525.274349] Starting dynamic subtest: vecs0
[525.298644] Dynamic subtest vecs0: SUCCESS (0.034s)
[525.309072] Starting dynamic subtest: ccs0
[525.333040] Dynamic subtest ccs0: SUCCESS (0.033s)
[525.335636] Subtest pi-ringfull: SUCCESS (0.232s)
[525.574984] [105/156] (515s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[525.693567] Starting subtest: fbc-2p-pri-indfb-multidraw
[525.698492] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[525.778612] [106/156] (515s left) gem_lmem_swapping (parallel-random-engines)
[525.822625] Subtest parallel-random-engines: SKIP (0.000s)
[525.866761] [107/156] (515s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[526.011629] Starting subtest: dp-mst-lic-type-0-hdcp14
[526.017443] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[526.153100] [108/156] (515s left) kms_pm_lpsp (kms-lpsp)
[527.248088] Starting subtest: kms-lpsp
[527.250593] Starting dynamic subtest: pipe-A-eDP-1
[527.398320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[527.714410] Subtest kms-lpsp: SUCCESS (0.464s)
[528.560317] [109/156] (512s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[528.665602] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[528.670777] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.761144] [110/156] (512s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[528.808321] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[528.810820] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[528.896011] [111/156] (512s left) kms_flip (2x-flip-vs-rmfb)
[528.984409] Starting subtest: 2x-flip-vs-rmfb
[528.996512] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[529.081641] [112/156] (512s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[529.192056] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[529.196508] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[529.293166] [113/156] (512s left) kms_cdclk (plane-scaling)
[529.383096] Starting subtest: plane-scaling
[529.385554] Starting dynamic subtest: pipe-A-eDP-1
[529.676516] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[529.687304] Starting dynamic subtest: pipe-B-eDP-1
[529.692469] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[529.702794] Starting dynamic subtest: pipe-C-eDP-1
[529.707960] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[529.718130] Starting dynamic subtest: pipe-D-eDP-1
[529.723498] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[529.728574] Subtest plane-scaling: SKIP (0.299s)
[530.503740] [114/156] (511s left) drm_buddy (drm_buddy)
[530.541924] Starting subtest: drm_buddy
[530.546592] Subtest drm_buddy: SKIP (0.000s)
[530.597021] [115/156] (511s left) kms_plane_alpha_blend (alpha-7efc)
[530.687520] Starting subtest: alpha-7efc
[530.979597] Starting dynamic subtest: pipe-A-eDP-1
[531.566442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[531.595077] Starting dynamic subtest: pipe-D-eDP-1
[532.899526] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[532.902209] Subtest alpha-7efc: SUCCESS (2.213s)
[533.746532] [116/156] (507s left) kms_chamelium_frames (hdmi-frame-dump)
[534.140646] Subtest hdmi-frame-dump: SKIP (0.000s)
[534.952110] [117/156] (506s left) kms_vblank (wait-forked)
[535.051741] Starting subtest: wait-forked
[535.054789] Starting dynamic subtest: pipe-A-eDP-1
[536.851720] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s)
[536.866558] Starting dynamic subtest: pipe-D-eDP-1
[539.369631] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.517s)
[539.372618] Subtest wait-forked: SUCCESS (4.320s)
[540.238071] [118/156] (501s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[540.332836] Starting subtest: psrhdr-indfb-scaledprimary
[540.337745] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[540.428349] [119/156] (501s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-msflip-blt)
[540.525684] Starting subtest: fbchdr-2p-scndscrn-shrfb-msflip-blt
[540.530566] Subtest fbchdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[540.614618] [120/156] (501s left) kms_psr (fbc-pr-primary-mmap-cpu)
[540.703056] Starting subtest: fbc-pr-primary-mmap-cpu
[540.707960] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[540.782778] [121/156] (501s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[540.878726] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[540.883612] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[540.973524] [122/156] (501s left) kms_plane_scaling (invalid-num-scalers)
[541.067693] Starting subtest: invalid-num-scalers
[541.070220] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[541.088529] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[541.100298] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[541.132201] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.042s)
[541.142739] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[541.169427] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.036s)
[541.179258] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[541.203178] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[541.205376] Subtest invalid-num-scalers: SUCCESS (0.136s)
[541.307740] [123/156] (500s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[541.406606] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[541.412183] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[541.513581] [124/156] (500s left) gem_userptr_blits (readonly-unsync)
[541.574304] Subtest readonly-unsync: SKIP (0.000s)
[541.700252] [125/156] (500s left) gem_basic (multigpu-create-close)
[541.747609] Starting subtest: multigpu-create-close
[541.752299] Subtest multigpu-create-close: SKIP (0.000s)
[541.850710] [126/156] (500s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[541.946177] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[541.950026] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[542.058639] [127/156] (500s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[542.152336] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[542.156784] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[542.259944] [128/156] (500s left) gem_exec_whisper (basic-contexts)
[542.316962] Starting subtest: basic-contexts
[547.780221] Subtest basic-contexts: SUCCESS (5.459s)
[547.964112] [129/156] (494s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[548.072534] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[549.095327] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.025s)
[549.221114] [130/156] (493s left) gem_tiled_partial_pwrite_pread (reads)
[549.285683] Subtest reads: SKIP (0.000s)
[549.344928] [131/156] (493s left) kms_psr (fbc-psr2-primary-render)
[549.439362] Starting subtest: fbc-psr2-primary-render
[549.441374] Starting dynamic subtest: eDP-1
[549.445328] Dynamic subtest eDP-1: SKIP (0.000s)
[549.449538] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[549.516916] [132/156] (492s left) gem_tiled_partial_pwrite_pread (writes)
[549.577092] Subtest writes: SKIP (0.000s)
[549.657235] [133/156] (492s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[549.755272] Starting subtest: fbc-modesetfrombusy
[553.608658] Subtest fbc-modesetfrombusy: SUCCESS (3.858s)
[554.777354] [134/156] (487s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[554.880694] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[558.798086] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.924s)
[559.977671] [135/156] (482s left) gem_mmap_wc (read)
[560.038171] Subtest read: SKIP (0.000s)
[560.097585] [136/156] (482s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[560.192305] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[560.196942] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[560.280667] [137/156] (482s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[560.385331] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[560.390635] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[560.476364] [138/156] (482s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[560.581056] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[560.585666] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[560.662439] [139/156] (482s left) gem_exec_params (sol-reset-not-gen7)
[560.719535] Starting subtest: sol-reset-not-gen7
[560.721895] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[560.847140] [140/156] (481s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[560.894284] Starting subtest: single-wait-all-for-submit-signaled
[560.896743] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[560.995271] [141/156] (481s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[561.101038] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[561.105303] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[561.205404] [142/156] (481s left) gem_wait (invalid-flags)
[561.253263] Starting subtest: invalid-flags
[561.255336] Subtest invalid-flags: SUCCESS (0.000s)
[561.459533] [143/156] (481s left) gem_spin_batch (engines)
[561.518552] Starting subtest: engines
[561.520589] Starting dynamic subtest: rcs0
[564.755886] Dynamic subtest rcs0: SUCCESS (3.235s)
[564.771172] Starting dynamic subtest: bcs0
[567.993781] Dynamic subtest bcs0: SUCCESS (3.235s)
[568.005085] Starting dynamic subtest: vcs0
[571.232253] Dynamic subtest vcs0: SUCCESS (3.235s)
[571.245474] Starting dynamic subtest: vcs1
[574.469866] Dynamic subtest vcs1: SUCCESS (3.232s)
[574.482224] Starting dynamic subtest: vecs0
[577.706743] Dynamic subtest vecs0: SUCCESS (3.236s)
[577.719313] Starting dynamic subtest: ccs0
[580.943568] Dynamic subtest ccs0: SUCCESS (3.235s)
[580.946416] Subtest engines: SUCCESS (19.427s)
[581.174483] [144/156] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[581.277286] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[581.282431] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[581.368716] [145/156] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[581.469275] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[581.474135] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[581.565848] [146/156] (461s left) kms_selftest (drm_format_helper)
[581.601201] Starting subtest: drm_format_helper
[581.646709] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[581.735436] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.088s)
[581.746468] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[581.834384] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.099s)
[581.844379] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[581.933605] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.098s)
[581.944459] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[582.034834] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.101s)
[582.045574] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[582.129808] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.091s)
[582.139750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[582.220207] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.091s)
[582.230885] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[582.315166] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.092s)
[582.326495] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[582.397682] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.082s)
[582.408399] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[582.487388] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.091s)
[582.498053] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[582.585794] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.096s)
[582.595811] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[582.674077] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.085s)
[582.685040] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[582.794492] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.119s)
[582.805600] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[582.875597] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.083s)
[582.886857] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[582.969507] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s)
[582.980798] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[583.052513] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.081s)
[583.063741] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[583.138164] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.085s)
[583.147788] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[583.222580] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.084s)
[583.225385] Subtest drm_format_helper: SUCCESS (1.623s)
[583.386203] [147/156] (459s left) gem_sync (basic-many-each)
[583.460802] Starting subtest: basic-many-each
[585.749519] Subtest basic-many-each: SUCCESS (2.301s)
[585.945684] [148/156] (457s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[586.040595] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[586.045742] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[586.140078] [149/156] (457s left) gem_exec_params (no-bsd)
[586.192624] Starting subtest: no-bsd
[586.198515] Subtest no-bsd: SUCCESS (0.004s)
[587.748815] [150/156] (455s left) gem_exec_schedule (fairslice)
[587.832412] Starting subtest: fairslice
[587.835296] Starting dynamic subtest: rcs0
[589.845783] Dynamic subtest rcs0: SUCCESS (2.025s)
[589.855750] Starting dynamic subtest: bcs0
[591.869845] Dynamic subtest bcs0: SUCCESS (2.024s)
[591.881836] Starting dynamic subtest: vcs0
[593.891832] Dynamic subtest vcs0: SUCCESS (2.021s)
[593.903773] Starting dynamic subtest: vcs1
[595.914080] Dynamic subtest vcs1: SUCCESS (2.019s)
[595.928234] Starting dynamic subtest: vecs0
[597.933154] Dynamic subtest vecs0: SUCCESS (2.018s)
[597.945357] Starting dynamic subtest: ccs0
[599.957849] Dynamic subtest ccs0: SUCCESS (2.024s)
[599.960340] Subtest fairslice: SUCCESS (12.138s)
[600.263680] [151/156] (443s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[600.363327] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[600.368315] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[600.452720] [152/156] (442s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[600.541571] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[600.546386] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[600.636033] [153/156] (442s left) kms_psr (psr-cursor-plane-onoff)
[600.723359] Starting subtest: psr-cursor-plane-onoff
[600.725706] Starting dynamic subtest: eDP-1
[602.456816] Dynamic subtest eDP-1: SUCCESS (1.733s)
[602.459626] Subtest psr-cursor-plane-onoff: SUCCESS (1.734s)
[603.335455] [154/156] (440s left) kms_atomic (crtc-invalid-params)
[603.428291] Starting subtest: crtc-invalid-params
[603.430966] Starting dynamic subtest: pipe-A-eDP-1
[603.787608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[603.789811] Subtest crtc-invalid-params: SUCCESS (0.359s)
[604.653597] [155/156] (438s left) gem_exec_fence (invalid-fence-array)
[605.087139] Starting subtest: invalid-fence-array
[605.092425] Subtest invalid-fence-array: SUCCESS (0.004s)
[606.778590] [156/156] (436s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[606.875746] Starting subtest: x-tiled-8bpp-rotate-90
[606.899628] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[607.008955] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: kms_color
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_ccs
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_dither
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: api_intel_bb
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: sysfs_heartbeat_interval
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_prop_blob
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_setmode
results: parsing output: 50/ for test: kms_hdr
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: gem_mmap_offset
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: kms_draw_crc
results: parsing output: 56/ for test: syncobj_eventfd
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_plane_lowres
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_selftest
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_async_flips
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: gem_ctx_engines
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: kms_pm_lpsp
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_cdclk
results: parsing output: 113/ for test: drm_buddy
results: parsing output: 114/ for test: kms_plane_alpha_blend
results: parsing output: 115/ for test: kms_chamelium_frames
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: gem_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_mmap_wc
results: parsing output: 135/ for test: kms_plane
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_psr2_sf
results: parsing output: 138/ for test: gem_exec_params
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_wait
results: parsing output: 142/ for test: gem_spin_batch
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_selftest
results: parsing output: 146/ for test: gem_sync
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: gem_exec_schedule
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: kms_atomic
results: parsing output: 154/ for test: gem_exec_fence
results: parsing output: 155/ for test: kms_big_fb
Done.