[46.645662] Initializing watchdogs
[46.645724]   /dev/watchdog0
[46.660915] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[46.666857] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.669563] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.671552] [001/131] (960s left) template (a)
[46.705871] Starting subtest: A
[46.706544] Subtest A: SUCCESS (0.000s)
[46.790141] [002/131] (960s left) syncobj_timeline (reset-multiple-signaled)
[46.822012] Starting subtest: reset-multiple-signaled
[46.823410] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[46.905858] [003/131] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[47.005074] Starting subtest: x-tiled-8bpp-rotate-180
[47.987451] Subtest x-tiled-8bpp-rotate-180: SUCCESS (0.986s)
[48.130973] [004/131] (959s left) kms_addfb_basic (legacy-format)
[48.164680] Starting subtest: legacy-format
[48.203302] Subtest legacy-format: SUCCESS (0.037s)
[48.348277] [005/131] (958s left) kms_getfb (getfb-repeated-different-handles)
[48.432737] Starting subtest: getfb-repeated-different-handles
[48.433420] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[48.522482] [006/131] (958s left) syncobj_timeline (multi-wait-all-signaled)
[48.556020] Starting subtest: multi-wait-all-signaled
[48.556755] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[48.629924] [007/131] (958s left) i915_pm_rps (thresholds-idle-park)
[48.670922] Starting subtest: thresholds-idle-park
[48.671589] Starting dynamic subtest: gt0
[64.211213] Dynamic subtest gt0: SUCCESS (15.578s)
[64.212432] Subtest thresholds-idle-park: SUCCESS (15.579s)
[64.284338] [008/131] (943s left) prime_mmap (test_aperture_limit)
[64.317972] Starting subtest: test_aperture_limit
[64.318692] Starting dynamic subtest: test_aperture_limit-smem
[64.328488] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.010s)
[64.329188] Subtest test_aperture_limit: SUCCESS (0.011s)
[64.425787] [009/131] (943s left) sysfs_preempt_timeout (idempotent)
[64.460589] Starting subtest: idempotent
[64.461350] Starting dynamic subtest: vecs0
[64.462036] Dynamic subtest vecs0: SUCCESS (0.001s)
[64.467349] Starting dynamic subtest: vcs0
[64.468034] Dynamic subtest vcs0: SUCCESS (0.001s)
[64.473734] Starting dynamic subtest: bcs0
[64.474406] Dynamic subtest bcs0: SUCCESS (0.001s)
[64.479685] Starting dynamic subtest: rcs0
[64.480352] Dynamic subtest rcs0: SUCCESS (0.001s)
[64.485452] Starting dynamic subtest: vcs1
[64.486116] Dynamic subtest vcs1: SUCCESS (0.001s)
[64.486758] Subtest idempotent: SUCCESS (0.005s)
[64.539333] [010/131] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[64.628382] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[64.629684] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.745042] [011/131] (942s left) kms_cursor_crc (cursor-random-max-size)
[64.832268] Starting subtest: cursor-random-max-size
[64.834431] Subtest cursor-random-max-size: SKIP (0.000s)
[64.953251] [012/131] (942s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[65.035782] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[65.036462] Starting dynamic subtest: pipe-A-valid-mode
[65.086743] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[65.088134] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.051s)
[65.196821] [013/131] (942s left) gen9_exec_parse (bb-start-out)
[65.233173] Subtest bb-start-out: SKIP (0.000s)
[65.266707] [014/131] (942s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[65.354407] Starting subtest: psr-rgb101010-draw-pwrite
[65.355747] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[65.463518] [015/131] (942s left) kms_joiner (basic-big-joiner)
[65.548601] Starting subtest: basic-big-joiner
[65.549983] Subtest basic-big-joiner: SKIP (0.000s)
[65.624775] [016/131] (942s left) gem_exec_fence (syncobj-timeline-chain-engines)
[66.096714] Starting subtest: syncobj-timeline-chain-engines
[66.160939] Subtest syncobj-timeline-chain-engines: SUCCESS (0.073s)
[66.347896] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[66.351165] [017/131] (941s left) i915_hangman (gt-engine-hang)
[66.392444] Starting subtest: gt-engine-hang
[66.393167] Starting dynamic subtest: rcs0
[67.385174] Dynamic subtest rcs0: SUCCESS (0.984s)
[67.391520] Starting dynamic subtest: bcs0
[68.137723] Dynamic subtest bcs0: SUCCESS (0.753s)
[68.144072] Starting dynamic subtest: vcs0
[68.723784] Dynamic subtest vcs0: SUCCESS (0.594s)
[68.733021] Starting dynamic subtest: vcs1
[69.311743] Dynamic subtest vcs1: SUCCESS (0.587s)
[69.320837] Starting dynamic subtest: vecs0
[69.905630] Dynamic subtest vecs0: SUCCESS (0.593s)
[69.906659] Subtest gt-engine-hang: SUCCESS (3.515s)
[70.003720] [018/131] (937s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[70.039636] Starting subtest: legacy-engines-hostile-preempt
[70.040349] Starting dynamic subtest: render
[70.149536] Dynamic subtest render: SUCCESS (0.109s)
[70.159360] Starting dynamic subtest: bsd1
[70.258624] Dynamic subtest bsd1: SUCCESS (0.108s)
[70.273653] Starting dynamic subtest: bsd2
[70.361440] Dynamic subtest bsd2: SUCCESS (0.101s)
[70.373140] Starting dynamic subtest: blt
[70.453405] Dynamic subtest blt: SUCCESS (0.091s)
[70.464980] Starting dynamic subtest: vebox
[70.555505] Dynamic subtest vebox: SUCCESS (0.101s)
[70.556461] Subtest legacy-engines-hostile-preempt: SUCCESS (0.516s)
[70.643983] [019/131] (937s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[70.676170] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[70.676916] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[70.752878] [020/131] (937s left) gem_mmap_offset (mmap-unmap)
[70.785563] Starting subtest: mmap-unmap
[70.786262] Starting dynamic subtest: smem0
[101.751778] Dynamic subtest smem0: SUCCESS (30.959s)
[101.752632] Subtest mmap-unmap: SUCCESS (30.959s)
[101.863895] [021/131] (906s left) gem_exec_reloc (basic-write-read-active)
[101.900507] Starting subtest: basic-write-read-active
[102.025528] Subtest basic-write-read-active: SUCCESS (0.116s)
[102.156985] [022/131] (905s left) vgem_basic (dmabuf-fence-before)
[102.191574] Starting subtest: dmabuf-fence-before
[102.192329] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[102.270460] [023/131] (905s left) kms_vblank (wait-forked-hang)
[102.353809] Starting subtest: wait-forked-hang
[102.354542] Starting dynamic subtest: pipe-A-HDMI-A-1
[116.875811] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.521s)
[116.884477] Starting dynamic subtest: pipe-D-HDMI-A-1
[130.691111] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.811s)
[130.691817] Subtest wait-forked-hang: SUCCESS (28.338s)
[130.860458] [024/131] (877s left) gem_reg_read (timestamp-moving)
[130.901948] Starting subtest: timestamp-moving
[131.911030] Subtest timestamp-moving: SUCCESS (1.001s)
[131.981839] [025/131] (876s left) gem_exec_balancer (full)
[132.020475] Starting subtest: full
[133.582921] Subtest full: SUCCESS (1.562s)
[133.787613] [026/131] (874s left) kms_addfb_basic (invalid-set-prop-any)
[133.819571] Starting subtest: invalid-set-prop-any
[133.820262] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[133.973254] [027/131] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[134.060490] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[134.061829] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[134.167727] [028/131] (873s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[134.251773] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[134.253271] Starting dynamic subtest: pipe-A-HDMI-A-1
[134.255910] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[134.262060] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.264700] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[134.270779] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.273396] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[134.279283] Starting dynamic subtest: pipe-D-HDMI-A-1
[134.281947] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[134.283318] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[134.494766] [029/131] (873s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[134.588141] Starting subtest: y-tiled-16bpp-rotate-0
[135.728196] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.140s)
[135.881697] [030/131] (872s left) api_intel_bb (object-reloc-purge-cache)
[135.912920] Starting subtest: object-reloc-purge-cache
[135.917197] Subtest object-reloc-purge-cache: SUCCESS (0.004s)
[136.049992] [031/131] (872s left) device_reset (unbind-reset-rebind)
[136.094056] Starting subtest: unbind-reset-rebind
[137.916633] Subtest unbind-reset-rebind: SUCCESS (1.813s)
[137.950678] [032/131] (870s left) kms_pm_rpm (legacy-planes)
[139.344681] Starting subtest: legacy-planes
[139.345575] Starting dynamic subtest: plane-63
[147.717363] Dynamic subtest plane-63: SUCCESS (8.373s)
[147.726765] Starting dynamic subtest: plane-93
[155.890957] Dynamic subtest plane-93: SUCCESS (8.172s)
[155.899820] Starting dynamic subtest: plane-123
[164.291332] Dynamic subtest plane-123: SUCCESS (8.399s)
[164.305385] Starting dynamic subtest: plane-133
[172.657987] Dynamic subtest plane-133: SUCCESS (8.365s)
[172.671829] Starting dynamic subtest: plane-143
[180.924060] Dynamic subtest plane-143: SUCCESS (8.265s)
[180.933471] Starting dynamic subtest: plane-153
[189.104995] Dynamic subtest plane-153: SUCCESS (8.180s)
[189.106169] Subtest legacy-planes: SUCCESS (49.762s)
[189.288882] [033/131] (819s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[189.376688] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[189.378054] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[189.502784] [034/131] (818s left) gem_mmap_offset (ptrace)
[189.534600] Starting subtest: ptrace
[189.535615] Starting dynamic subtest: smem0-gtt
[189.562452] Dynamic subtest smem0-gtt: SUCCESS (0.027s)
[189.569054] Starting dynamic subtest: smem0-wb
[189.579509] Dynamic subtest smem0-wb: SUCCESS (0.016s)
[189.586035] Starting dynamic subtest: smem0-wc
[189.598544] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[189.604898] Starting dynamic subtest: smem0-uc
[189.617829] Dynamic subtest smem0-uc: SUCCESS (0.019s)
[189.618538] Subtest ptrace: SUCCESS (0.084s)
[189.769474] [035/131] (818s left) api_intel_bb (blit-noreloc-purge-cache)
[189.802247] Starting subtest: blit-noreloc-purge-cache
[189.807239] Subtest blit-noreloc-purge-cache: SUCCESS (0.006s)
[189.943869] [036/131] (818s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[190.031918] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[190.033389] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[190.142129] [037/131] (818s left) kms_vblank (ts-continuation-suspend)
[190.227063] Starting subtest: ts-continuation-suspend
[190.227767] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.328816] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.923s)
[206.340008] Starting dynamic subtest: pipe-D-HDMI-A-1
[223.295846] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.262s)
[223.296547] Subtest ts-continuation-suspend: SUCCESS (3.190s)
[232.523004] [038/131] (785s left) kms_rotation_crc (sprite-rotation-180)
[232.616182] Starting subtest: sprite-rotation-180
[236.069433] Subtest sprite-rotation-180: SUCCESS (3.476s)
[236.269987] [039/131] (781s left) kms_cursor_legacy (single-bo)
[236.357460] Starting subtest: single-bo
[236.358214] Starting dynamic subtest: pipe-A
[241.751428] Dynamic subtest pipe-A: SUCCESS (5.380s)
[241.760161] Starting dynamic subtest: pipe-B
[247.119070] Dynamic subtest pipe-B: SUCCESS (5.378s)
[247.128151] Starting dynamic subtest: pipe-C
[252.491312] Dynamic subtest pipe-C: SUCCESS (5.378s)
[252.500123] Starting dynamic subtest: pipe-D
[257.865477] Dynamic subtest pipe-D: SUCCESS (5.378s)
[257.875144] Starting dynamic subtest: all-pipes
[263.242762] Dynamic subtest all-pipes: SUCCESS (5.379s)
[263.243713] Subtest single-bo: SUCCESS (26.897s)
[263.292615] [040/131] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[263.383743] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[263.385133] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.504183] [041/131] (754s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[263.586924] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[263.587693] Starting dynamic subtest: pipe-A
[264.799428] Dynamic subtest pipe-A: SUCCESS (1.212s)
[264.810642] Starting dynamic subtest: pipe-B
[266.066074] Dynamic subtest pipe-B: SUCCESS (1.265s)
[266.077637] Starting dynamic subtest: pipe-C
[266.267209] Dynamic subtest pipe-C: SUCCESS (0.200s)
[266.278105] Starting dynamic subtest: pipe-D
[266.468233] Dynamic subtest pipe-D: SUCCESS (0.200s)
[266.468960] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.881s)
[266.671885] [042/131] (751s left) kms_flip (2x-flip-vs-dpms-on-nop)
[266.759564] Starting subtest: 2x-flip-vs-dpms-on-nop
[266.768188] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[266.865339] [043/131] (750s left) gem_lmem_swapping (verify-ccs)
[266.902545] Subtest verify-ccs: SKIP (0.000s)
[266.942272] [044/131] (750s left) kms_psr (psr-primary-mmap-cpu)
[267.027828] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[267.067514] [045/131] (750s left) kms_content_protection (uevent-hdcp14)
[267.155973] Starting subtest: uevent-hdcp14
[267.170154] Subtest uevent-hdcp14: SKIP (0.013s)
[267.277781] [046/131] (750s left) gem_wait (invalid-buf)
[267.313121] Starting subtest: invalid-buf
[267.313877] Subtest invalid-buf: SUCCESS (0.000s)
[267.550791] [047/131] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[267.639852] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[267.641253] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[267.750021] [048/131] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[267.838519] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[267.839958] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.966069] [049/131] (750s left) kms_async_flips (test-time-stamp)
[268.050997] Starting subtest: test-time-stamp
[268.167278] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.274379] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.106s)
[268.406622] Starting dynamic subtest: pipe-B-HDMI-A-1
[268.486241] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.086s)
[268.599380] Starting dynamic subtest: pipe-C-HDMI-A-1
[268.692992] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.101s)
[268.827538] Starting dynamic subtest: pipe-D-HDMI-A-1
[268.916564] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.096s)
[268.917311] Subtest test-time-stamp: SUCCESS (0.867s)
[269.162305] [050/131] (748s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[269.255935] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[269.257317] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[269.363289] [051/131] (748s left) gem_ctx_exec (basic-norecovery)
[269.396556] Starting subtest: basic-norecovery
[269.412439] Subtest basic-norecovery: SUCCESS (0.015s)
[269.556104] [052/131] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[269.644250] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[269.645657] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[269.752994] [053/131] (748s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[269.787149] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[269.900673] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[269.988152] [054/131] (748s left) gem_exec_whisper (basic-fds-priority-all)
[270.029130] Starting subtest: basic-fds-priority-all
[274.133384] Subtest basic-fds-priority-all: SUCCESS (4.103s)
[274.332195] [055/131] (743s left) kms_psr (fbc-psr-primary-blt)
[274.421333] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[274.465201] [056/131] (743s left) gem_reg_read (bad-register)
[274.498189] Starting subtest: bad-register
[274.498968] Subtest bad-register: SUCCESS (0.000s)
[274.587214] [057/131] (743s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[274.673205] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[285.524783] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.853s)
[285.672990] [058/131] (732s left) kms_psr (pr-primary-render)
[285.767748] Subtest pr-primary-render: SKIP (0.000s)
[285.810743] [059/131] (732s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[285.892476] Starting subtest: bad-rotation-90-y-tiled-ccs
[285.894761] Starting dynamic subtest: pipe-A-HDMI-A-1
[285.901464] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[285.910885] Starting dynamic subtest: pipe-B-HDMI-A-1
[285.917282] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[285.924458] Starting dynamic subtest: pipe-C-HDMI-A-1
[285.930911] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[285.938151] Starting dynamic subtest: pipe-D-HDMI-A-1
[285.944799] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[285.946224] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s)
[286.142290] [060/131] (732s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[286.226668] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[286.270982] [061/131] (732s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[286.357633] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[287.616871] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.259s)
[287.758832] [062/131] (730s left) gem_exec_schedule (thriceslice)
[287.800704] Starting subtest: thriceslice
[287.801395] Starting dynamic subtest: rcs0
[287.805482] Dynamic subtest rcs0: SUCCESS (0.004s)
[287.814852] Starting dynamic subtest: bcs0
[287.815548] Dynamic subtest bcs0: SUCCESS (0.003s)
[287.823355] Starting dynamic subtest: vcs0
[287.824046] Dynamic subtest vcs0: SUCCESS (0.004s)
[287.831573] Starting dynamic subtest: vcs1
[287.832252] Dynamic subtest vcs1: SUCCESS (0.003s)
[287.839225] Starting dynamic subtest: vecs0
[287.839906] Dynamic subtest vecs0: SUCCESS (0.003s)
[287.840563] Subtest thriceslice: SUCCESS (0.023s)
[288.137525] [063/131] (730s left) syncobj_wait (wait-for-submit-complex)
[288.170199] Starting subtest: wait-for-submit-complex
[288.232244] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[288.319833] [064/131] (730s left) gem_sync (basic-many-each)
[288.361906] Starting subtest: basic-many-each
[290.610789] Subtest basic-many-each: SUCCESS (2.226s)
[290.804501] [065/131] (727s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[290.893150] Starting subtest: plane-upscale-factor-0-25-with-rotation
[290.893866] Starting dynamic subtest: pipe-A
[291.954917] Dynamic subtest pipe-A: SKIP (1.061s)
[291.962790] Starting dynamic subtest: pipe-B
[293.076401] Dynamic subtest pipe-B: SKIP (1.121s)
[293.084073] Starting dynamic subtest: pipe-C
[294.166677] Dynamic subtest pipe-C: SKIP (1.090s)
[294.174276] Starting dynamic subtest: pipe-D
[295.279527] Dynamic subtest pipe-D: SKIP (1.113s)
[295.281629] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.388s)
[295.473049] [066/131] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[295.575158] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[296.976451] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.403s)
[297.104545] [067/131] (721s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[297.192976] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[297.194802] Starting dynamic subtest: pipe-A-HDMI-A-1
[297.201465] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[297.208980] Starting dynamic subtest: pipe-B-HDMI-A-1
[297.215861] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[297.223348] Starting dynamic subtest: pipe-C-HDMI-A-1
[297.230040] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[297.237328] Starting dynamic subtest: pipe-D-HDMI-A-1
[297.244009] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[297.245335] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[297.440438] [068/131] (721s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[297.530629] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[297.532071] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[297.652019] [069/131] (721s left) gem_pread (display)
[297.684318] Starting subtest: display
[298.519386] Subtest display: SUCCESS (0.827s)
[298.620452] [070/131] (720s left) gem_userptr_blits (coherency-sync)
[298.666370] Starting subtest: coherency-sync
[299.141036] Subtest coherency-sync: SKIP (0.461s)
[299.282238] [071/131] (719s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[299.423022] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[299.459661] [072/131] (719s left) gem_softpin (evict-prime-sanity-check)
[299.497265] Starting subtest: evict-prime-sanity-check
[299.497981] Starting dynamic subtest: rcs0
[300.630787] Dynamic subtest rcs0: SUCCESS (1.133s)
[300.646493] Starting dynamic subtest: bcs0
[301.768761] Dynamic subtest bcs0: SUCCESS (1.136s)
[301.788114] Starting dynamic subtest: vcs0
[302.889769] Dynamic subtest vcs0: SUCCESS (1.119s)
[302.907693] Starting dynamic subtest: vcs1
[304.014828] Dynamic subtest vcs1: SUCCESS (1.123s)
[304.031783] Starting dynamic subtest: vecs0
[305.144834] Dynamic subtest vecs0: SUCCESS (1.128s)
[305.159553] Starting dynamic subtest: all
[306.293051] Dynamic subtest all: SUCCESS (1.146s)
[306.294251] Subtest evict-prime-sanity-check: SUCCESS (6.799s)
[306.391415] [073/131] (712s left) perf_pmu (init-busy)
[306.427959] Starting subtest: init-busy
[306.428669] Starting dynamic subtest: rcs0
[306.429402] Dynamic subtest rcs0: SUCCESS (0.001s)
[306.437595] Starting dynamic subtest: bcs0
[306.438292] Dynamic subtest bcs0: SUCCESS (0.000s)
[306.446820] Starting dynamic subtest: vcs0
[306.447526] Dynamic subtest vcs0: SUCCESS (0.000s)
[306.455281] Starting dynamic subtest: vcs1
[306.455969] Dynamic subtest vcs1: SUCCESS (0.000s)
[306.463458] Starting dynamic subtest: vecs0
[306.464149] Dynamic subtest vecs0: SUCCESS (0.000s)
[306.464839] Subtest init-busy: SUCCESS (0.007s)
[306.512695] [074/131] (712s left) gem_ctx_shared (single-timeline)
[306.552624] Starting subtest: single-timeline
[306.558481] Subtest single-timeline: SUCCESS (0.004s)
[306.751611] [075/131] (712s left) kms_getfb (getfb2-handle-zero)
[306.840976] Starting subtest: getfb2-handle-zero
[306.841698] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[306.956957] [076/131] (712s left) drm_read (empty-block)
[307.085637] Starting subtest: empty-block
[308.086226] Subtest empty-block: SUCCESS (1.001s)
[308.211077] [077/131] (710s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[308.352680] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[308.469318] [078/131] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[308.560195] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[308.561584] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[308.687788] [079/131] (710s left) kms_selftest (drm_format_helper)
[308.733784] Starting subtest: drm_format_helper
[308.739954] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[308.833305] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.092s)
[308.848446] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[308.918673] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.085s)
[308.935596] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[309.008492] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.086s)
[309.024792] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[309.091441] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.082s)
[309.108927] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[309.172298] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.078s)
[309.190102] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[309.255245] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.080s)
[309.271254] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[309.328228] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.070s)
[309.344609] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[309.410989] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.080s)
[309.425404] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[309.487707] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.075s)
[309.503260] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[309.574232] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.083s)
[309.589322] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[309.651395] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.075s)
[309.668026] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[309.744479] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.090s)
[309.759257] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[309.828233] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.081s)
[309.842844] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[309.935109] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.104s)
[309.950651] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[310.019774] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.081s)
[310.035234] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[310.104728] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.082s)
[310.119517] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[310.198873] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.092s)
[310.199751] Subtest drm_format_helper: SUCCESS (1.468s)
[310.363572] [080/131] (708s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[310.454907] Starting subtest: fbc-shrfb-scaledprimary
[313.306885] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.853s)
[313.463785] [081/131] (705s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[313.497918] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[313.498634] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[313.586294] [082/131] (705s left) kms_flip (modeset-vs-vblank-race)
[313.672613] Starting subtest: modeset-vs-vblank-race
[313.674824] Starting dynamic subtest: A-HDMI-A1
[316.502852] Dynamic subtest A-HDMI-A1: SUCCESS (2.829s)
[316.512866] Starting dynamic subtest: B-HDMI-A1
[319.348586] Dynamic subtest B-HDMI-A1: SUCCESS (2.846s)
[319.358014] Starting dynamic subtest: C-HDMI-A1
[322.212981] Dynamic subtest C-HDMI-A1: SUCCESS (2.864s)
[322.222520] Starting dynamic subtest: D-HDMI-A1
[325.015175] Dynamic subtest D-HDMI-A1: SUCCESS (2.802s)
[325.017786] Subtest modeset-vs-vblank-race: SUCCESS (11.350s)
[325.208705] [083/131] (694s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[325.248640] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[325.286878] [084/131] (694s left) kms_pipe_crc_basic (suspend-read-crc)
[325.372039] Starting subtest: suspend-read-crc
[325.373900] Starting dynamic subtest: pipe-A-HDMI-A-1
[342.524492] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.729s)
[342.535199] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.500755] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.667s)
[359.512232] Starting dynamic subtest: pipe-C-HDMI-A-1
[376.499926] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.684s)
[376.511897] Starting dynamic subtest: pipe-D-HDMI-A-1
[393.511586] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.834s)
[393.512371] Subtest suspend-read-crc: SUCCESS (6.922s)
[402.698720] [085/131] (625s left) kms_cdclk (plane-scaling)
[402.731924] Subtest plane-scaling: SKIP (0.000s)
[402.775064] [086/131] (625s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[402.871805] Starting subtest: yf-tiled-16bpp-rotate-180
[402.873264] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[402.995599] [087/131] (625s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[403.078803] Starting subtest: flip-vs-dpms-off-vs-modeset
[403.081209] Starting dynamic subtest: A-HDMI-A1
[403.767052] Dynamic subtest A-HDMI-A1: SUCCESS (0.691s)
[403.776491] Starting dynamic subtest: B-HDMI-A1
[404.435524] Dynamic subtest B-HDMI-A1: SUCCESS (0.670s)
[404.444289] Starting dynamic subtest: C-HDMI-A1
[405.037691] Dynamic subtest C-HDMI-A1: SUCCESS (0.605s)
[405.047615] Starting dynamic subtest: D-HDMI-A1
[405.658194] Dynamic subtest D-HDMI-A1: SUCCESS (0.622s)
[405.659179] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.597s)
[405.819651] [088/131] (622s left) gem_exec_whisper (basic-queues-forked)
[405.864875] Starting subtest: basic-queues-forked
[408.012705] Subtest basic-queues-forked: SUCCESS (2.147s)
[408.207588] [089/131] (620s left) gem_softpin (noreloc-s3)
[408.245294] Starting subtest: noreloc-S3
[428.369732] Subtest noreloc-S3: SUCCESS (5.392s)
[432.510678] [090/131] (600s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[432.560588] Starting subtest: tiled-to-tiled
[432.691752] Subtest tiled-to-tiled: SUCCESS (0.122s)
[432.819010] [091/131] (600s left) kms_lease (lease-invalid-crtc)
[432.905312] Starting subtest: lease-invalid-crtc
[432.907075] Starting dynamic subtest: pipe-A-HDMI-A-1
[432.907759] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[432.915807] Starting dynamic subtest: pipe-B-HDMI-A-1
[432.916501] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[432.924626] Starting dynamic subtest: pipe-C-HDMI-A-1
[432.925381] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[432.933135] Starting dynamic subtest: pipe-D-HDMI-A-1
[432.933842] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[432.934524] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[432.993077] [092/131] (599s left) perf (polling-parameterized)
[433.096724] Starting subtest: polling-parameterized
[453.150245] Subtest polling-parameterized: SUCCESS (20.061s)
[453.200187] [093/131] (579s left) kms_plane (plane-panning-bottom-right)
[453.300352] Starting subtest: plane-panning-bottom-right
[453.301051] Starting dynamic subtest: pipe-A
[453.663167] Dynamic subtest pipe-A: SUCCESS (0.362s)
[453.673546] Starting dynamic subtest: pipe-B
[454.028982] Dynamic subtest pipe-B: SUCCESS (0.363s)
[454.029704] Subtest plane-panning-bottom-right: SUCCESS (0.730s)
[454.199067] [094/131] (578s left) gem_exec_fence (syncobj-unused-fence)
[454.540410] Starting subtest: syncobj-unused-fence
[454.542497] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[454.861310] [095/131] (578s left) dumb_buffer (map-valid)
[454.894802] Starting subtest: map-valid
[454.895543] Subtest map-valid: SUCCESS (0.000s)
[454.998941] [096/131] (578s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[455.085031] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[455.126701] [097/131] (577s left) gem_exec_schedule (preempt-other-chain)
[455.171883] Starting subtest: preempt-other-chain
[455.172608] Starting dynamic subtest: rcs0
[455.210901] Dynamic subtest rcs0: SUCCESS (0.038s)
[455.220066] Starting dynamic subtest: bcs0
[455.251558] Dynamic subtest bcs0: SUCCESS (0.040s)
[455.261450] Starting dynamic subtest: vcs0
[455.291532] Dynamic subtest vcs0: SUCCESS (0.039s)
[455.301554] Starting dynamic subtest: vcs1
[455.331862] Dynamic subtest vcs1: SUCCESS (0.039s)
[455.340689] Starting dynamic subtest: vecs0
[455.370494] Dynamic subtest vecs0: SUCCESS (0.038s)
[455.371248] Subtest preempt-other-chain: SUCCESS (0.199s)
[455.686147] [098/131] (577s left) gem_render_copy (yf-tiled-ccs-to-linear)
[455.724768] Starting subtest: yf-tiled-ccs-to-linear
[455.725546] Starting dynamic subtest: smem
[455.791566] Dynamic subtest smem: SUCCESS (0.066s)
[455.792375] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.067s)
[455.991417] [099/131] (577s left) kms_prop_blob (blob-multiple)
[456.023145] Starting subtest: blob-multiple
[456.025024] Subtest blob-multiple: SUCCESS (0.001s)
[456.117237] [100/131] (577s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[456.203598] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[456.204328] Starting dynamic subtest: pipe-A-valid-mode
[457.383235] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.178s)
[457.383952] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (1.180s)
[457.565267] [101/131] (575s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[457.604309] Starting subtest: no-spare-fences-busy-interruptible
[459.774823] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.171s)
[459.917527] [102/131] (573s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[460.013874] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[460.015352] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[460.141116] [103/131] (573s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[460.180471] Starting subtest: y-tiled-to-vebox-x-tiled
[460.181178] Starting dynamic subtest: smem
[460.276439] Dynamic subtest smem: SUCCESS (0.095s)
[460.277163] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.096s)
[460.476892] [104/131] (572s left) vgem_basic (create)
[460.511526] Starting subtest: create
[460.512227] Subtest create: SUCCESS (0.000s)
[460.589571] [105/131] (572s left) gem_exec_params (secure-non-master)
[460.625506] Starting subtest: secure-non-master
[460.626972] Subtest secure-non-master: SKIP (0.000s)
[460.742085] [106/131] (572s left) syncobj_eventfd (invalid-bad-flags)
[460.775938] Starting subtest: invalid-bad-flags
[460.776683] Subtest invalid-bad-flags: SUCCESS (0.000s)
[460.864763] [107/131] (572s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[460.900588] Starting subtest: writes-after-reads-uncached
[473.115767] Subtest writes-after-reads-uncached: SUCCESS (12.213s)
[473.245947] [108/131] (560s left) gem_exec_fence (basic-wait)
[473.401527] Starting subtest: basic-wait
[473.402814] Starting dynamic subtest: rcs0
[473.440888] Dynamic subtest rcs0: SUCCESS (0.038s)
[473.459211] Starting dynamic subtest: bcs0
[473.488664] Dynamic subtest bcs0: SUCCESS (0.046s)
[473.506300] Starting dynamic subtest: vcs0
[473.519703] Dynamic subtest vcs0: SUCCESS (0.029s)
[473.533873] Starting dynamic subtest: vcs1
[473.549668] Dynamic subtest vcs1: SUCCESS (0.028s)
[473.562288] Starting dynamic subtest: vecs0
[473.582873] Dynamic subtest vecs0: SUCCESS (0.032s)
[473.583909] Subtest basic-wait: SUCCESS (0.183s)
[474.055364] [109/131] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[474.145971] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[474.147409] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[474.248190] [110/131] (559s left) kms_cursor_crc (cursor-sliding-512x512)
[474.338438] Starting subtest: cursor-sliding-512x512
[474.339882] Subtest cursor-sliding-512x512: SKIP (0.001s)
[474.461839] [111/131] (559s left) gem_exec_reloc (basic-write-cpu)
[474.500081] Starting subtest: basic-write-cpu
[474.505255] Subtest basic-write-cpu: SUCCESS (0.005s)
[474.636211] [112/131] (559s left) gem_vm_create (invalid-destroy)
[474.673222] Starting subtest: invalid-destroy
[474.675038] Subtest invalid-destroy: SUCCESS (0.001s)
[474.788089] [113/131] (559s left) gem_close_race (multigpu-basic-process)
[474.829987] Starting subtest: multigpu-basic-process
[474.831426] Subtest multigpu-basic-process: SKIP (0.000s)
[475.021654] [114/131] (558s left) kms_busy (extended-pageflip-hang-newfb)
[475.112008] Starting subtest: extended-pageflip-hang-newfb
[475.112758] Starting dynamic subtest: pipe-A
[489.475143] Dynamic subtest pipe-A: SUCCESS (14.364s)
[489.490764] Starting dynamic subtest: pipe-D
[503.286797] Dynamic subtest pipe-D: SUCCESS (13.807s)
[503.287587] Subtest extended-pageflip-hang-newfb: SUCCESS (28.181s)
[503.428860] [115/131] (530s left) gen9_exec_parse (unaligned-access)
[503.466088] Subtest unaligned-access: SKIP (0.000s)
[503.505468] [116/131] (530s left) i915_pm_rps (basic-api)
[503.542544] Starting subtest: basic-api
[503.544429] Subtest basic-api: SUCCESS (0.002s)
[503.627551] [117/131] (530s left) kms_color (ctm-negative)
[503.716267] Starting subtest: ctm-negative
[503.716979] Starting dynamic subtest: pipe-A-HDMI-A-1
[504.023178] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.307s)
[504.033381] Starting dynamic subtest: pipe-B-HDMI-A-1
[504.308094] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.283s)
[504.317013] Starting dynamic subtest: pipe-C-HDMI-A-1
[504.601064] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.293s)
[504.612138] Starting dynamic subtest: pipe-D-HDMI-A-1
[504.895501] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.293s)
[504.896295] Subtest ctm-negative: SUCCESS (1.180s)
[505.062232] [118/131] (528s left) kms_cursor_crc (cursor-offscreen-32x32)
[505.154491] Starting subtest: cursor-offscreen-32x32
[505.207547] Subtest cursor-offscreen-32x32: SKIP (0.051s)
[505.331378] [119/131] (528s left) kms_chamelium_frames (hdmi-frame-dump)
[505.472177] Subtest hdmi-frame-dump: SKIP (0.000s)
[505.574842] [120/131] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[505.667080] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[506.956360] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.290s)
[507.113494] [121/131] (527s left) gem_userptr_blits (sync-unmap)
[507.158188] Starting subtest: sync-unmap
[507.176960] Subtest sync-unmap: SUCCESS (0.020s)
[507.313379] [122/131] (526s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[507.409165] Starting subtest: y-tiled-16bpp-rotate-270
[508.497709] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.088s)
[508.628650] [123/131] (525s left) kms_addfb_basic (addfb25-modifier-no-flag)
[508.719226] Starting subtest: addfb25-modifier-no-flag
[508.719921] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[508.845617] [124/131] (525s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[508.931321] Starting subtest: cursor-vs-flip-toggle
[540.691437] Subtest cursor-vs-flip-toggle: SUCCESS (31.762s)
[540.840331] [125/131] (493s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[540.931215] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[540.931942] Starting dynamic subtest: pipe-A-HDMI-A-1
[540.949395] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[540.957729] Starting dynamic subtest: pipe-B-HDMI-A-1
[540.975735] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[540.984127] Starting dynamic subtest: pipe-C-HDMI-A-1
[541.002412] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[541.012043] Starting dynamic subtest: pipe-D-HDMI-A-1
[541.030047] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[541.031453] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[541.186398] [126/131] (493s left) gem_mmap_gtt (basic-small-bo-tiledy)
[541.219454] Starting subtest: basic-small-bo-tiledY
[541.439231] Subtest basic-small-bo-tiledY: SUCCESS (0.219s)
[541.569551] [127/131] (492s left) gem_mmap_wc (write-read-distinct)
[541.646388] Starting subtest: write-read-distinct
[541.647776] Subtest write-read-distinct: SUCCESS (0.002s)
[541.764255] [128/131] (492s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[541.853823] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[541.855995] Starting dynamic subtest: A-HDMI-A1
[542.542417] Dynamic subtest A-HDMI-A1: SUCCESS (0.685s)
[542.553208] Starting dynamic subtest: B-HDMI-A1
[543.155408] Dynamic subtest B-HDMI-A1: SUCCESS (0.613s)
[543.164989] Starting dynamic subtest: C-HDMI-A1
[543.775220] Dynamic subtest C-HDMI-A1: SUCCESS (0.618s)
[543.784877] Starting dynamic subtest: D-HDMI-A1
[544.398186] Dynamic subtest D-HDMI-A1: SUCCESS (0.621s)
[544.400346] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.547s)
[544.562894] [129/131] (489s left) kms_properties (crtc-properties-legacy)
[544.653163] Starting subtest: crtc-properties-legacy
[544.653884] Starting dynamic subtest: pipe-A-HDMI-A-1
[544.807956] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.154s)
[544.817692] Starting dynamic subtest: pipe-B-HDMI-A-1
[544.980843] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.171s)
[544.990443] Starting dynamic subtest: pipe-C-HDMI-A-1
[545.170063] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.187s)
[545.180943] Starting dynamic subtest: pipe-D-HDMI-A-1
[545.350539] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.177s)
[545.351194] Subtest crtc-properties-legacy: SUCCESS (0.698s)
[545.489396] [130/131] (489s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[545.582428] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[545.619791] [131/131] (488s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[545.721549] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[545.722922] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[545.833536] Closing watchdogs
results: parsing output: 0/ for test: template
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_getfb
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: i915_pm_rps
results: parsing output: 7/ for test: prime_mmap
results: parsing output: 8/ for test: sysfs_preempt_timeout
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: i915_hangman
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: gem_reg_read
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: device_reset
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: gem_wait
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_async_flips
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_exec
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_reg_read
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_sync
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: gem_softpin
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_pipe_b_c_ivb
results: parsing output: 83/ for test: kms_pipe_crc_basic
results: parsing output: 84/ for test: kms_cdclk
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_exec_whisper
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: gem_set_tiling_vs_blt
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: gem_fenced_exec_thrash
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: syncobj_eventfd
results: parsing output: 106/ for test: gem_partial_pwrite_pread
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_vm_create
results: parsing output: 112/ for test: gem_close_race
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_big_fb
Done.