[56.744319] Initializing watchdogs
[56.744366]   /dev/watchdog0
[56.757322] [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]
[56.761504] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.763832] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.767185] [001/134] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[56.889528] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[61.301941] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.455s)
[62.516913] [002/134] (954s left) gem_ccs (block-multicopy-inplace)
[62.578185] Starting subtest: block-multicopy-inplace
[62.582602] Subtest block-multicopy-inplace: SKIP (0.000s)
[62.699315] [003/134] (954s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[62.800038] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[62.804241] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[62.920299] [004/134] (954s left) gem_exec_schedule (preempt-other-chain)
[62.997635] Starting subtest: preempt-other-chain
[62.999564] Starting dynamic subtest: rcs0
[63.072974] Dynamic subtest rcs0: SUCCESS (0.083s)
[63.084170] Starting dynamic subtest: bcs0
[63.152666] Dynamic subtest bcs0: SUCCESS (0.080s)
[63.165890] Starting dynamic subtest: vcs0
[63.233967] Dynamic subtest vcs0: SUCCESS (0.082s)
[63.246348] Starting dynamic subtest: vcs1
[63.313619] Dynamic subtest vcs1: SUCCESS (0.079s)
[63.321088] Starting dynamic subtest: vecs0
[63.390164] Dynamic subtest vecs0: SUCCESS (0.075s)
[63.403485] Starting dynamic subtest: ccs0
[63.464514] Dynamic subtest ccs0: SUCCESS (0.075s)
[63.467189] Subtest preempt-other-chain: SUCCESS (0.476s)
[65.028586] [005/134] (952s left) kms_cursor_crc (cursor-random-128x128)
[65.225263] Starting subtest: cursor-random-128x128
[65.230209] Starting dynamic subtest: pipe-A-eDP-1
[68.743201] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.525s)
[68.773997] Starting dynamic subtest: pipe-D-eDP-1
[72.778905] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.017s)
[72.781399] Subtest cursor-random-128x128: SUCCESS (7.571s)
[73.635611] [006/134] (943s left) gem_userptr_blits (userfault)
[73.708824] Starting subtest: userfault
[73.710992] Subtest userfault: SUCCESS (0.006s)
[73.875121] [007/134] (943s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[73.934994] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[74.041259] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[74.124194] [008/134] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[74.236133] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[74.240657] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[74.373634] [009/134] (943s left) gem_exec_capture (userptr)
[74.435063] Starting subtest: userptr
[75.270184] Subtest userptr: SUCCESS (0.835s)
[75.424783] [010/134] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[75.526299] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[75.530334] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[75.668918] [011/134] (941s left) sysfs_timeslice_duration (timeout)
[75.720872] Starting subtest: timeout
[75.723179] Starting dynamic subtest: vecs0
[84.888380] Dynamic subtest vecs0: SUCCESS (9.164s)
[84.900709] Starting dynamic subtest: ccs0
[86.276677] Dynamic subtest ccs0: SUCCESS (1.388s)
[86.286816] Starting dynamic subtest: vcs0
[95.905101] Dynamic subtest vcs0: SUCCESS (9.624s)
[95.915717] Starting dynamic subtest: bcs0
[96.618843] Dynamic subtest bcs0: SUCCESS (0.712s)
[96.628890] Starting dynamic subtest: rcs0
[97.925698] Dynamic subtest rcs0: SUCCESS (1.306s)
[97.933825] Starting dynamic subtest: vcs1
[107.933047] Dynamic subtest vcs1: SUCCESS (10.003s)
[107.935824] Subtest timeout: SUCCESS (32.205s)
[108.018150] [012/134] (909s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[108.125953] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[108.128262] Starting dynamic subtest: pipe-A-eDP-1
[108.150870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.159200] Starting dynamic subtest: pipe-B-eDP-1
[108.180384] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.186934] Starting dynamic subtest: pipe-C-eDP-1
[108.208298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.215237] Starting dynamic subtest: pipe-D-eDP-1
[108.236154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.240386] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[110.397085] [013/134] (907s left) kms_chamelium_frames (hdmi-crc-multiple)
[110.789934] Subtest hdmi-crc-multiple: SKIP (0.000s)
[111.622653] [014/134] (906s left) gem_exec_fence (syncobj-timeline-wait)
[112.214138] Starting subtest: syncobj-timeline-wait
[113.936232] Subtest syncobj-timeline-wait: SUCCESS (1.722s)
[116.043800] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[116.046896] [015/134] (901s left) kms_psr (pr-primary-render)
[116.147917] Starting subtest: pr-primary-render
[116.152170] Subtest pr-primary-render: SKIP (0.000s)
[116.231926] [016/134] (901s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[116.339384] Starting subtest: y-tiled-64bpp-rotate-180
[116.343958] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[116.468763] [017/134] (901s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[116.572529] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[123.144029] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.573s)
[123.296723] [018/134] (894s left) kms_big_fb (4-tiled-addfb)
[123.407425] Starting subtest: 4-tiled-addfb
[123.409429] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[123.521797] [019/134] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[123.625962] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[123.630168] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.748127] [020/134] (894s left) kms_plane_cursor (primary)
[123.832243] Starting subtest: primary
[123.836883] Starting dynamic subtest: pipe-A-eDP-1-size-64
[126.409498] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.578s)
[126.434976] Starting dynamic subtest: pipe-A-eDP-1-size-128
[128.999675] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[129.031401] Starting dynamic subtest: pipe-A-eDP-1-size-256
[131.568046] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.550s)
[131.880691] Starting dynamic subtest: pipe-B-eDP-1-size-64
[135.125491] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.254s)
[135.151844] Starting dynamic subtest: pipe-B-eDP-1-size-128
[137.694126] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[137.716526] Starting dynamic subtest: pipe-B-eDP-1-size-256
[140.306773] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.594s)
[140.624197] Starting dynamic subtest: pipe-C-eDP-1-size-64
[143.524482] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.909s)
[143.553266] Starting dynamic subtest: pipe-C-eDP-1-size-128
[145.746148] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[145.771048] Starting dynamic subtest: pipe-C-eDP-1-size-256
[147.957498] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[148.292142] Starting dynamic subtest: pipe-D-eDP-1-size-64
[151.249283] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.964s)
[151.274964] Starting dynamic subtest: pipe-D-eDP-1-size-128
[153.449302] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[153.474853] Starting dynamic subtest: pipe-D-eDP-1-size-256
[155.640584] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[155.951418] Subtest primary: SUCCESS (32.116s)
[156.798619] [021/134] (861s left) sw_sync (sync_merge)
[156.831499] Starting subtest: sync_merge
[156.833730] Subtest sync_merge: SUCCESS (0.000s)
[156.911143] [022/134] (861s left) drm_read (invalid-buffer)
[157.052407] Starting subtest: invalid-buffer
[157.054731] Subtest invalid-buffer: SUCCESS (0.000s)
[157.235438] [023/134] (860s left) gem_exec_flush (basic-uc-prw-default)
[157.314675] Starting subtest: basic-uc-prw-default
[162.792201] Subtest basic-uc-prw-default: SUCCESS (5.478s)
[162.996062] [024/134] (855s left) gem_cs_tlb (engines)
[163.055777] Starting subtest: engines
[163.058295] Starting dynamic subtest: rcs0
[165.213763] Dynamic subtest rcs0: SUCCESS (2.154s)
[165.223551] Starting dynamic subtest: bcs0
[167.367971] Dynamic subtest bcs0: SUCCESS (2.152s)
[167.378297] Starting dynamic subtest: vcs0
[169.519957] Dynamic subtest vcs0: SUCCESS (2.152s)
[169.527220] Starting dynamic subtest: vcs1
[171.673440] Dynamic subtest vcs1: SUCCESS (2.152s)
[171.681362] Starting dynamic subtest: vecs0
[173.825377] Dynamic subtest vecs0: SUCCESS (2.152s)
[173.834440] Starting dynamic subtest: ccs0
[175.981325] Dynamic subtest ccs0: SUCCESS (2.153s)
[175.983672] Subtest engines: SUCCESS (12.921s)
[176.122639] [025/134] (842s left) kms_big_fb (linear-16bpp-rotate-270)
[176.222757] Starting subtest: linear-16bpp-rotate-270
[176.241821] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[176.391210] [026/134] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[176.484630] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[176.488649] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[176.592954] [027/134] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[176.685729] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[176.689745] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[176.806243] [028/134] (841s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[181.891366] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[181.893274] Starting dynamic subtest: pipe-A-eDP-1
[188.504251] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.613s)
[188.512368] Starting dynamic subtest: pipe-B-eDP-1
[195.054614] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.547s)
[195.056883] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.164s)
[195.947633] [029/134] (822s left) kms_chamelium_audio (hdmi-audio-edid)
[196.337563] Subtest hdmi-audio-edid: SKIP (0.000s)
[197.152581] [030/134] (821s left) gem_tiled_wb
[197.288144] [031/134] (821s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[197.369158] Starting subtest: plane-upscale-20x20-with-rotation
[197.371405] Starting dynamic subtest: pipe-A
[197.594745] Dynamic subtest pipe-A: SUCCESS (0.228s)
[197.607333] Starting dynamic subtest: pipe-B
[198.855823] Dynamic subtest pipe-B: SUCCESS (1.260s)
[198.863911] Starting dynamic subtest: pipe-C
[200.189581] Dynamic subtest pipe-C: SUCCESS (1.332s)
[200.201690] Starting dynamic subtest: pipe-D
[201.513520] Dynamic subtest pipe-D: SUCCESS (1.323s)
[201.515662] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.147s)
[202.715108] [032/134] (815s left) gem_ctx_persistence (engines-hostile-preempt)
[202.785919] Starting subtest: engines-hostile-preempt
[202.788528] Starting dynamic subtest: rcs0
[202.885904] Dynamic subtest rcs0: SUCCESS (0.099s)
[202.896550] Starting dynamic subtest: bcs0
[202.965197] Dynamic subtest bcs0: SUCCESS (0.077s)
[202.976176] Starting dynamic subtest: vcs0
[204.908143] Dynamic subtest vcs0: SUCCESS (1.940s)
[204.918871] Starting dynamic subtest: vcs1
[206.914752] Dynamic subtest vcs1: SUCCESS (2.003s)
[206.925053] Starting dynamic subtest: vecs0
[208.899468] Dynamic subtest vecs0: SUCCESS (1.983s)
[208.909765] Starting dynamic subtest: ccs0
[209.041217] Dynamic subtest ccs0: SUCCESS (0.140s)
[209.043882] Subtest engines-hostile-preempt: SUCCESS (6.256s)
[209.137059] [033/134] (809s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[209.242084] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[209.246037] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[209.356651] [034/134] (809s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[214.380261] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[214.384723] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[215.266995] [035/134] (803s left) vgem_basic (debugfs)
[215.320286] Starting subtest: debugfs
[215.322185] Subtest debugfs: SUCCESS (0.000s)
[215.401503] [036/134] (803s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[215.514636] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[219.704151] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.191s)
[220.871787] [037/134] (797s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[220.987482] Starting subtest: flip-vs-cursor-legacy
[228.004051] Subtest flip-vs-cursor-legacy: SUCCESS (7.016s)
[228.873548] [038/134] (789s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[228.994679] Starting subtest: cursorA-vs-flipB-toggle
[228.999279] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[229.153283] [039/134] (789s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[229.257128] Starting subtest: crc-primary-basic-yf-tiled-ccs
[229.259345] Starting dynamic subtest: pipe-A-eDP-1
[229.281711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[229.290964] Starting dynamic subtest: pipe-B-eDP-1
[229.312234] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[229.319387] Starting dynamic subtest: pipe-C-eDP-1
[229.340820] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[229.347912] Starting dynamic subtest: pipe-D-eDP-1
[229.369394] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[229.373774] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[231.533537] [040/134] (787s left) gem_lmem_swapping (parallel-random-engines)
[231.577642] Subtest parallel-random-engines: SKIP (0.000s)
[231.619157] [041/134] (787s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[231.685222] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[231.687108] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[231.810309] [042/134] (787s left) kms_flip (2x-flip-vs-fences-interruptible)
[231.913497] Starting subtest: 2x-flip-vs-fences-interruptible
[231.917756] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[232.028795] [043/134] (786s left) syncobj_basic (illegal-fd-to-handle)
[232.083564] Starting subtest: illegal-fd-to-handle
[232.086033] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[232.218928] [044/134] (786s left) kms_pm_rpm (dpms-lpsp)
[234.149962] Starting subtest: dpms-lpsp
[234.462062] Subtest dpms-lpsp: SUCCESS (0.316s)
[234.569494] [045/134] (784s left) perf_pmu (interrupts-sync)
[234.611327] Starting subtest: interrupts-sync
[235.706089] Subtest interrupts-sync: SUCCESS (1.096s)
[235.857216] [046/134] (783s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[235.946159] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[235.971640] Starting dynamic subtest: pipe-A-plane-0
[235.976220] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[235.985483] Starting dynamic subtest: pipe-A-plane-3
[235.990072] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[235.998039] Starting dynamic subtest: pipe-A-plane-5
[236.002641] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[237.107168] Starting dynamic subtest: pipe-B-plane-0
[237.111143] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[237.118760] Starting dynamic subtest: pipe-B-plane-3
[237.123087] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[237.130346] Starting dynamic subtest: pipe-B-plane-5
[237.134439] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[237.412419] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (1.464s)
[238.299194] [047/134] (780s left) kms_psr (fbc-psr2-primary-render)
[238.389401] Starting subtest: fbc-psr2-primary-render
[238.391653] Starting dynamic subtest: eDP-1
[238.395702] Dynamic subtest eDP-1: SKIP (0.000s)
[238.399739] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[238.473570] [048/134] (780s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[238.594178] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[269.766427] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.170s)
[270.620645] [049/134] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[270.717502] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[270.721810] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[270.823617] [050/134] (748s left) kms_pm_rpm (modeset-non-lpsp)
[273.043811] Starting subtest: modeset-non-lpsp
[274.190023] Subtest modeset-non-lpsp: SKIP (1.145s)
[274.574830] [051/134] (744s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[274.659621] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[274.662046] Starting dynamic subtest: pipe-A-eDP-1
[274.683294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[274.693924] Starting dynamic subtest: pipe-B-eDP-1
[274.714034] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[274.721830] Starting dynamic subtest: pipe-C-eDP-1
[274.741774] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[274.749225] Starting dynamic subtest: pipe-D-eDP-1
[274.768835] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[274.771335] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[276.839546] [052/134] (742s left) syncobj_wait (wait-all-delayed-signal)
[276.911608] Starting subtest: wait-all-delayed-signal
[277.012751] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[277.105396] [053/134] (742s left) perf_pmu (idle-no-semaphores)
[277.141216] Starting subtest: idle-no-semaphores
[277.143543] Starting dynamic subtest: rcs0
[277.699398] Dynamic subtest rcs0: SUCCESS (0.558s)
[277.710448] Starting dynamic subtest: bcs0
[278.222358] Dynamic subtest bcs0: SUCCESS (0.520s)
[278.233443] Starting dynamic subtest: vcs0
[278.753364] Dynamic subtest vcs0: SUCCESS (0.528s)
[278.764419] Starting dynamic subtest: vcs1
[279.285890] Dynamic subtest vcs1: SUCCESS (0.526s)
[279.295667] Starting dynamic subtest: vecs0
[279.808373] Dynamic subtest vecs0: SUCCESS (0.523s)
[279.819718] Starting dynamic subtest: ccs0
[280.333089] Dynamic subtest ccs0: SUCCESS (0.522s)
[280.336020] Subtest idle-no-semaphores: SUCCESS (3.194s)
[280.465340] [054/134] (738s left) i915_pm_rps (thresholds-idle)
[280.534699] Starting subtest: thresholds-idle
[280.539422] Subtest thresholds-idle: SKIP (0.001s)
[280.666924] [055/134] (738s left) kms_psr (psr-primary-blt)
[280.769067] Starting subtest: psr-primary-blt
[280.771471] Starting dynamic subtest: eDP-1
[282.521454] Dynamic subtest eDP-1: SUCCESS (1.752s)
[282.523697] Subtest psr-primary-blt: SUCCESS (1.753s)
[283.397449] [056/134] (736s left) gem_tiled_blits (interruptible)
[283.449340] Subtest interruptible: SKIP (0.000s)
[283.526559] [057/134] (736s left) i915_drm_fdinfo (busy-hang)
[283.566967] Starting subtest: busy-hang
[283.569246] Starting dynamic subtest: rcs0
[283.615364] Dynamic subtest rcs0: SKIP (0.047s)
[283.625800] Starting dynamic subtest: bcs0
[283.630094] Dynamic subtest bcs0: SKIP (0.001s)
[283.640256] Starting dynamic subtest: vcs0
[283.644630] Dynamic subtest vcs0: SKIP (0.001s)
[283.652806] Starting dynamic subtest: vcs1
[283.656965] Dynamic subtest vcs1: SKIP (0.000s)
[283.664597] Starting dynamic subtest: vecs0
[283.668853] Dynamic subtest vecs0: SKIP (0.000s)
[283.677337] Starting dynamic subtest: ccs0
[283.681349] Dynamic subtest ccs0: SKIP (0.000s)
[283.685374] Subtest busy-hang: SKIP (0.055s)
[283.719775] [058/134] (735s left) kms_color (ctm-0-50)
[283.819360] Starting subtest: ctm-0-50
[283.821314] Starting dynamic subtest: pipe-A-eDP-1
[287.311159] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.493s)
[287.319475] Starting dynamic subtest: pipe-B-eDP-1
[291.567654] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.256s)
[291.575989] Starting dynamic subtest: pipe-C-eDP-1
[295.661292] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.089s)
[295.669623] Starting dynamic subtest: pipe-D-eDP-1
[299.653506] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.991s)
[299.655702] Subtest ctm-0-50: SUCCESS (15.833s)
[300.483605] [059/134] (719s left) gem_render_copy (linear)
[300.546775] Starting subtest: linear
[300.549082] Starting dynamic subtest: smem
[300.589066] Dynamic subtest smem: SUCCESS (0.041s)
[300.591469] Subtest linear: SUCCESS (0.042s)
[300.777965] [060/134] (718s left) api_intel_allocator (two-level-inception-interruptible)
[300.838188] Starting subtest: two-level-inception-interruptible
[306.242929] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[306.404530] [061/134] (713s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[306.506584] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[306.508830] Starting dynamic subtest: pipe-A-default-mode
[307.633992] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[307.638487] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.130s)
[307.817515] [062/134] (711s left) gem_ctx_shared (exec-shared-gtt)
[307.898816] Starting subtest: exec-shared-gtt
[307.901058] Starting dynamic subtest: rcs0
[307.904394] Dynamic subtest rcs0: SUCCESS (0.009s)
[307.913761] Starting dynamic subtest: bcs0
[307.915658] Dynamic subtest bcs0: SUCCESS (0.005s)
[307.923377] Starting dynamic subtest: vcs0
[307.925574] Dynamic subtest vcs0: SUCCESS (0.008s)
[307.933590] Starting dynamic subtest: vcs1
[307.935514] Dynamic subtest vcs1: SUCCESS (0.006s)
[307.943179] Starting dynamic subtest: vecs0
[307.945518] Dynamic subtest vecs0: SUCCESS (0.005s)
[307.955149] Starting dynamic subtest: ccs0
[307.957240] Dynamic subtest ccs0: SUCCESS (0.006s)
[307.959308] Subtest exec-shared-gtt: SUCCESS (0.044s)
[308.140452] [063/134] (711s left) gem_pxp (regular-baseline-src-copy-readible)
[308.263719] Starting subtest: regular-baseline-src-copy-readible
[308.321697] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[308.475188] [064/134] (711s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[308.577677] Starting subtest: x-tiled-32bpp-rotate-270
[308.598221] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[308.758251] [065/134] (711s left) core_getstats (basic)
[308.812569] Starting subtest: basic
[308.814203] Subtest basic: SUCCESS (0.000s)
[308.937539] [066/134] (710s left) kms_joiner (invalid-modeset-big-joiner)
[309.036509] Starting subtest: invalid-modeset-big-joiner
[309.039824] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[309.116985] [067/134] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[309.218306] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[315.979450] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.762s)
[316.140635] [068/134] (703s left) gem_exec_schedule (u-semaphore-noskip)
[316.226445] Starting subtest: u-semaphore-noskip
[316.613064] Subtest u-semaphore-noskip: SUCCESS (0.394s)
[316.976165] [069/134] (703s left) gem_exec_flush (basic-uc-rw-default)
[317.036248] Starting subtest: basic-uc-rw-default
[322.507212] Subtest basic-uc-rw-default: SUCCESS (5.471s)
[322.708240] [070/134] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[322.810135] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[322.814382] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[322.933088] [071/134] (697s left) gem_mmap_gtt (basic-read)
[322.985504] Subtest basic-read: SKIP (0.000s)
[323.045080] [072/134] (697s left) kms_async_flips (invalid-async-flip-atomic)
[323.146375] Starting subtest: invalid-async-flip-atomic
[323.519128] Starting dynamic subtest: pipe-A-eDP-1
[324.343797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[324.706113] Starting dynamic subtest: pipe-B-eDP-1
[325.480221] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[325.848677] Starting dynamic subtest: pipe-C-eDP-1
[326.614407] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[326.967469] Starting dynamic subtest: pipe-D-eDP-1
[327.740770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[327.743166] Subtest invalid-async-flip-atomic: SUCCESS (4.597s)
[328.907301] [073/134] (691s left) gen7_exec_parse (basic-rejected)
[328.971889] Subtest basic-rejected: SKIP (0.000s)
[329.042608] [074/134] (691s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[329.092849] Starting subtest: multi-wait-all-for-submit-signaled
[329.094797] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[329.215010] [075/134] (691s left) kms_busy (basic-hang)
[329.309415] Starting subtest: basic-hang
[329.311388] Starting dynamic subtest: flip-pipe-A
[329.898824] Dynamic subtest flip-pipe-A: SUCCESS (0.588s)
[329.907613] Starting dynamic subtest: modeset-pipe-A
[333.329125] Dynamic subtest modeset-pipe-A: SUCCESS (3.428s)
[333.338913] Starting dynamic subtest: flip-pipe-D
[334.652735] Dynamic subtest flip-pipe-D: SUCCESS (1.322s)
[334.661150] Starting dynamic subtest: modeset-pipe-D
[338.051341] Dynamic subtest modeset-pipe-D: SUCCESS (3.397s)
[338.053718] Subtest basic-hang: SUCCESS (8.742s)
[338.860240] [076/134] (681s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[338.995687] Starting subtest: flip-vs-cursor-toggle
[347.540066] Subtest flip-vs-cursor-toggle: SUCCESS (8.545s)
[348.387623] [077/134] (671s left) kms_tiled_display (basic-test-pattern)
[348.506140] Subtest basic-test-pattern: SKIP (0.000s)
[348.550273] [078/134] (671s left) kms_plane (planar-pixel-format-settings)
[348.643295] Starting subtest: planar-pixel-format-settings
[348.711109] Subtest planar-pixel-format-settings: SUCCESS (0.070s)
[348.858911] [079/134] (671s left) gem_exec_create (basic)
[348.925136] Starting subtest: basic
[348.927430] Starting dynamic subtest: smem
[351.892638] Dynamic subtest smem: SUCCESS (2.965s)
[351.895560] Subtest basic: SUCCESS (2.967s)
[352.096693] [080/134] (668s left) gem_exec_fence (syncobj-channel)
[352.577370] Starting subtest: syncobj-channel
[353.601613] Subtest syncobj-channel: SUCCESS (1.020s)
[354.026477] [081/134] (666s left) gem_ctx_persistence (legacy-engines-persistence)
[354.093392] Starting subtest: legacy-engines-persistence
[354.095657] Starting dynamic subtest: render
[354.921848] Dynamic subtest render: SUCCESS (0.828s)
[354.935629] Starting dynamic subtest: bsd1
[355.745797] Dynamic subtest bsd1: SUCCESS (0.821s)
[355.759656] Starting dynamic subtest: bsd2
[356.496694] Dynamic subtest bsd2: SUCCESS (0.748s)
[356.507739] Starting dynamic subtest: blt
[357.277787] Dynamic subtest blt: SUCCESS (0.778s)
[357.289142] Starting dynamic subtest: vebox
[358.047034] Dynamic subtest vebox: SUCCESS (0.766s)
[358.049756] Subtest legacy-engines-persistence: SUCCESS (3.954s)
[358.138571] [082/134] (662s left) sw_sync (sync_merge_same)
[358.186581] Starting subtest: sync_merge_same
[358.188891] Subtest sync_merge_same: SUCCESS (0.000s)
[358.249370] [083/134] (662s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[358.376347] Starting subtest: cursorA-vs-flipA-atomic-transitions
[369.529507] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.152s)
[370.399176] [084/134] (650s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[370.477753] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[370.547711] [085/134] (650s left) kms_frontbuffer_tracking (psr-1p-rte)
[370.644053] Starting subtest: psr-1p-rte
[376.011993] Subtest psr-1p-rte: SUCCESS (5.371s)
[376.195657] [086/134] (644s left) syncobj_timeline (wait-all-complex)
[376.248796] Starting subtest: wait-all-complex
[376.462387] Subtest wait-all-complex: SUCCESS (0.214s)
[376.548305] [087/134] (644s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[376.610247] Starting subtest: y-tiled-to-vebox-yf-tiled
[376.614736] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[376.821496] [088/134] (643s left) gem_exec_params (dr1-dirt)
[376.880277] Starting subtest: DR1-dirt
[376.882698] Subtest DR1-dirt: SUCCESS (0.000s)
[377.019029] [089/134] (643s left) kms_addfb_basic (bad-pitch-1024)
[377.070807] Starting subtest: bad-pitch-1024
[377.073030] Subtest bad-pitch-1024: SUCCESS (0.000s)
[377.241882] [090/134] (643s left) prime_vgem (basic-fence-flip)
[377.315581] Starting subtest: basic-fence-flip
[377.602773] Subtest basic-fence-flip: SUCCESS (0.287s)
[377.717362] [091/134] (643s left) gem_ctx_param (non-root-set)
[377.774660] Starting subtest: non-root-set
[377.796328] Subtest non-root-set: SUCCESS (0.020s)
[377.920881] [092/134] (643s left) gem_mmap_gtt (ptrace)
[377.970181] Subtest ptrace: SKIP (0.000s)
[378.032605] [093/134] (642s left) gem_exec_capture (capture-invisible)
[378.092798] Starting subtest: capture-invisible
[378.095266] Starting dynamic subtest: smem0
[378.099876] Dynamic subtest smem0: SKIP (0.000s)
[378.104440] Subtest capture-invisible: SKIP (0.001s)
[378.220460] [094/134] (642s left) syncobj_timeline (etime-multi-wait-all-submitted)
[378.278439] Starting subtest: etime-multi-wait-all-submitted
[378.382984] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[378.471118] [095/134] (642s left) syncobj_wait (wait-any-snapshot)
[378.535488] Starting subtest: wait-any-snapshot
[378.614408] Subtest wait-any-snapshot: SUCCESS (0.081s)
[378.702815] [096/134] (642s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[378.760219] Starting subtest: multi-wait-for-submit-available-signaled
[378.762136] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[378.884622] [097/134] (642s left) kms_draw_crc (draw-method-mmap-wc)
[379.001658] Starting subtest: draw-method-mmap-wc
[379.003611] Starting dynamic subtest: xrgb8888-untiled
[379.276462] Dynamic subtest xrgb8888-untiled: SUCCESS (0.275s)
[379.284577] Starting dynamic subtest: rgb565-untiled
[379.498533] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[379.506285] Starting dynamic subtest: xrgb2101010-untiled
[379.698712] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[379.707054] Starting dynamic subtest: xbgr16161616f-untiled
[379.898845] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[379.907306] Starting dynamic subtest: xrgb8888-xtiled
[380.022505] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[380.030702] Starting dynamic subtest: rgb565-xtiled
[380.154963] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[380.163309] Starting dynamic subtest: xrgb2101010-xtiled
[380.276502] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[380.286637] Starting dynamic subtest: xbgr16161616f-xtiled
[380.409991] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[380.420275] Starting dynamic subtest: xrgb8888-4tiled
[380.565311] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[380.573877] Starting dynamic subtest: rgb565-4tiled
[380.698687] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[380.706672] Starting dynamic subtest: xrgb2101010-4tiled
[380.843233] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[380.851485] Starting dynamic subtest: xbgr16161616f-4tiled
[381.009847] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[381.011689] Subtest draw-method-mmap-wc: SUCCESS (2.010s)
[381.150242] [098/134] (640s left) kms_vrr (negative-basic)
[381.237505] Starting subtest: negative-basic
[381.242766] Starting dynamic subtest: pipe-A-eDP-1
[386.659143] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[386.954581] Subtest negative-basic: SUCCESS (5.715s)
[387.778987] [099/134] (633s left) kms_setmode (basic)
[387.851622] Starting subtest: basic
[388.185519] Starting dynamic subtest: pipe-A-eDP-1
[390.296305] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.106s)
[390.636797] Starting dynamic subtest: pipe-B-eDP-1
[392.732893] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.099s)
[393.044788] Subtest basic: SUCCESS (5.191s)
[393.881744] [100/134] (627s left) gem_madvise (dontneed-before-mmap)
[393.921295] Starting subtest: dontneed-before-mmap
[393.947415] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[394.080390] [101/134] (627s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[399.166463] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[399.168844] Starting dynamic subtest: pipe-A-eDP-1
[416.359239] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.191s)
[416.370446] Starting dynamic subtest: pipe-B-eDP-1
[433.501040] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.137s)
[433.503368] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.333s)
[434.304439] [102/134] (587s left) syncobj_wait (single-wait-for-submit-submitted)
[434.353418] Starting subtest: single-wait-for-submit-submitted
[434.457049] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[434.560216] [103/134] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[434.671417] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[441.482424] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.814s)
[441.596241] [104/134] (579s left) gem_mmap_offset (perf)
[441.659514] Starting subtest: perf
[441.661815] Starting dynamic subtest: smem0
[442.029091] Dynamic subtest smem0: SUCCESS (0.367s)
[442.031195] Subtest perf: SUCCESS (0.368s)
[442.179761] [105/134] (579s left) gem_lmem_swapping (massive-random)
[442.232327] Subtest massive-random: SKIP (0.000s)
[442.274652] [106/134] (579s left) kms_cursor_legacy (torture-move)
[442.393413] Starting subtest: torture-move
[442.395319] Starting dynamic subtest: pipe-A
[448.289213] Dynamic subtest pipe-A: SUCCESS (5.892s)
[448.298463] Starting dynamic subtest: pipe-B
[454.370575] Dynamic subtest pipe-B: SUCCESS (6.079s)
[454.383351] Starting dynamic subtest: pipe-C
[460.301725] Dynamic subtest pipe-C: SUCCESS (5.928s)
[460.311505] Starting dynamic subtest: pipe-D
[466.309864] Dynamic subtest pipe-D: SUCCESS (6.006s)
[466.320892] Starting dynamic subtest: all-pipes
[471.897021] Dynamic subtest all-pipes: SUCCESS (5.582s)
[471.899463] Subtest torture-move: SUCCESS (29.498s)
[472.092626] [107/134] (549s left) prime_busy (after)
[472.155829] Starting subtest: after
[472.158047] Starting dynamic subtest: rcs0
[472.208786] Dynamic subtest rcs0: SUCCESS (0.052s)
[472.219532] Starting dynamic subtest: bcs0
[472.270604] Dynamic subtest bcs0: SUCCESS (0.061s)
[472.280124] Starting dynamic subtest: vcs0
[472.310811] Dynamic subtest vcs0: SUCCESS (0.040s)
[472.319351] Starting dynamic subtest: vcs1
[472.350781] Dynamic subtest vcs1: SUCCESS (0.039s)
[472.359529] Starting dynamic subtest: vecs0
[472.391606] Dynamic subtest vecs0: SUCCESS (0.040s)
[472.400361] Starting dynamic subtest: ccs0
[472.433256] Dynamic subtest ccs0: SUCCESS (0.041s)
[472.539987] Subtest after: SUCCESS (0.385s)
[472.630270] [108/134] (549s left) kms_vrr (flip-basic)
[472.733101] Starting subtest: flip-basic
[472.739617] Subtest flip-basic: SKIP (0.000s)
[472.813122] [109/134] (548s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[472.915357] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[473.948708] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.033s)
[474.118602] [110/134] (547s left) prime_vgem (basic-write)
[474.215095] Starting subtest: basic-write
[474.223991] Subtest basic-write: SKIP (0.007s)
[474.358272] [111/134] (547s left) kms_cursor_crc (cursor-onscreen-512x512)
[474.632516] Starting subtest: cursor-onscreen-512x512
[474.636187] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[474.821732] [112/134] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[474.923952] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[474.927438] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[475.047898] [113/134] (546s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[475.138499] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[475.140319] Starting dynamic subtest: pipe-A-default-mode
[477.828269] Dynamic subtest pipe-A-default-mode: SUCCESS (2.687s)
[477.830553] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.689s)
[478.696445] [114/134] (543s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[479.083342] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[479.895541] [115/134] (542s left) kms_hdr (static-swap)
[480.003294] Starting subtest: static-swap
[480.009786] Subtest static-swap: SKIP (0.000s)
[480.091689] [116/134] (541s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[480.208364] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[484.454738] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.252s)
[485.624991] [117/134] (536s left) api_intel_bb (render)
[485.687104] Starting subtest: render
[485.689472] Starting dynamic subtest: render-none-512
[485.797880] Dynamic subtest render-none-512: SUCCESS (0.108s)
[485.808659] Starting dynamic subtest: render-none-1024
[486.168349] Dynamic subtest render-none-1024: SUCCESS (0.369s)
[486.176761] Starting dynamic subtest: render-x-512
[486.254452] Dynamic subtest render-x-512: SUCCESS (0.086s)
[486.263563] Starting dynamic subtest: render-x-1024
[486.589106] Dynamic subtest render-x-1024: SUCCESS (0.333s)
[486.597961] Starting dynamic subtest: render-y-512
[486.673717] Dynamic subtest render-y-512: SUCCESS (0.084s)
[486.683166] Starting dynamic subtest: render-y-1024
[487.121240] Dynamic subtest render-y-1024: SUCCESS (0.445s)
[487.123892] Subtest render: SUCCESS (1.433s)
[487.253982] [118/134] (534s left) kms_selftest (drm_damage_helper)
[487.287733] Starting subtest: drm_damage_helper
[487.297281] Starting dynamic subtest: drm_test_damage_iter_no_damage
[487.417188] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.117s)
[487.426633] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[487.533975] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.116s)
[487.542353] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[487.626868] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.093s)
[487.636510] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[487.760288] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.132s)
[487.769229] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[487.875852] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.115s)
[487.885601] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[488.019219] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.143s)
[488.029152] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[488.143872] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.125s)
[488.152583] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[488.281171] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.135s)
[488.288835] Starting dynamic subtest: drm_test_damage_iter_single_damage
[488.421381] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.140s)
[488.428882] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[488.568059] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.145s)
[488.577179] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[488.686641] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.119s)
[488.696896] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[488.810818] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.121s)
[488.820714] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[488.952884] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.142s)
[488.960521] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[489.103897] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.150s)
[489.111506] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[489.252943] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.148s)
[489.262722] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[489.370729] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.118s)
[489.378888] Starting dynamic subtest: drm_test_damage_iter_damage
[489.490174] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.119s)
[489.499698] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[489.626064] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.135s)
[489.634347] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[489.770945] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.144s)
[489.779068] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[489.908656] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.138s)
[489.917076] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[490.053718] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.143s)
[490.056074] Subtest drm_damage_helper: SUCCESS (2.767s)
[490.220394] [119/134] (531s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[490.323779] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[490.325951] Starting dynamic subtest: pipe-A-eDP-1
[523.297009] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.067s)
[523.306101] Starting dynamic subtest: pipe-B-eDP-1
[556.225785] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.769s)
[556.234888] Starting dynamic subtest: pipe-C-eDP-1
[589.223398] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.812s)
[589.232800] Starting dynamic subtest: pipe-D-eDP-1
[622.218019] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.682s)
[622.220289] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.335s)
[623.419508] [120/134] (398s left) kms_lease (empty-lease)
[623.527459] Starting subtest: empty-lease
[623.529926] Starting dynamic subtest: pipe-A-eDP-1
[623.532151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[623.541252] Starting dynamic subtest: pipe-B-eDP-1
[623.543009] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[623.551296] Starting dynamic subtest: pipe-C-eDP-1
[623.553041] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[623.561053] Starting dynamic subtest: pipe-D-eDP-1
[623.562874] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[623.564731] Subtest empty-lease: SUCCESS (0.009s)
[623.674034] [121/134] (398s left) kms_content_protection (atomic-dpms-hdcp14)
[623.820798] Starting subtest: atomic-dpms-hdcp14
[623.825278] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[623.959523] [122/134] (398s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[624.019565] Starting subtest: invalid-multi-wait-unsubmitted
[624.021421] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[624.130127] [123/134] (398s left) gem_exec_store (dword)
[624.205388] Starting subtest: dword
[624.207243] Starting dynamic subtest: rcs0
[624.327520] Dynamic subtest rcs0: SUCCESS (0.127s)
[624.341276] Starting dynamic subtest: bcs0
[624.371411] Dynamic subtest bcs0: SUCCESS (0.042s)
[624.383461] Starting dynamic subtest: vcs0
[624.417346] Dynamic subtest vcs0: SUCCESS (0.044s)
[624.429287] Starting dynamic subtest: vcs1
[624.461244] Dynamic subtest vcs1: SUCCESS (0.042s)
[624.473161] Starting dynamic subtest: vecs0
[624.504426] Dynamic subtest vecs0: SUCCESS (0.041s)
[624.514280] Starting dynamic subtest: ccs0
[624.546573] Dynamic subtest ccs0: SUCCESS (0.041s)
[624.548615] Subtest dword: SUCCESS (0.353s)
[624.742395] [124/134] (397s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[624.837294] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[624.867068] Starting dynamic subtest: pipe-A-plane-0
[624.871641] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[624.882917] Starting dynamic subtest: pipe-A-plane-3
[624.887739] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[624.903060] Starting dynamic subtest: pipe-A-plane-5
[624.906858] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[625.938266] Starting dynamic subtest: pipe-B-plane-0
[625.942891] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[625.951874] Starting dynamic subtest: pipe-B-plane-3
[625.956441] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[625.965573] Starting dynamic subtest: pipe-B-plane-5
[625.969643] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[626.250894] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (1.439s)
[627.102483] [125/134] (395s left) gem_exec_balancer (nop)
[627.163797] Starting subtest: nop
[673.630241] Subtest nop: SUCCESS (46.603s)
[673.962775] [126/134] (348s left) i915_drm_fdinfo (virtual-busy-idle)
[674.000089] Starting subtest: virtual-busy-idle
[674.004871] Subtest virtual-busy-idle: SKIP (0.000s)
[674.109100] [127/134] (348s left) i915_pm_rpm (gem-idle)
[676.062968] Starting subtest: gem-idle
[682.255213] Subtest gem-idle: SUCCESS (6.199s)
[682.602654] [128/134] (339s left) kms_fbcon_fbt (psr)
[683.923862] Starting subtest: psr
[691.321902] Subtest psr: SUCCESS (7.401s)
[691.420187] [129/134] (331s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[691.536506] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[699.209475] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.679s)
[699.382361] [130/134] (323s left) gem_softpin (full)
[699.441863] Starting subtest: full
[699.449475] Subtest full: SUCCESS (0.008s)
[699.580495] [131/134] (323s left) kms_psr (fbc-psr-basic)
[699.673540] Starting subtest: fbc-psr-basic
[699.675707] Starting dynamic subtest: eDP-1
[699.679934] Dynamic subtest eDP-1: SKIP (0.000s)
[699.684259] Subtest fbc-psr-basic: SKIP (0.001s)
[699.765431] [132/134] (322s left) kms_async_flips (alternate-sync-async-flip-atomic)
[699.854103] Starting subtest: alternate-sync-async-flip-atomic
[700.231496] Starting dynamic subtest: pipe-A-eDP-1
[703.057058] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.827s)
[703.437105] Starting dynamic subtest: pipe-B-eDP-1
[706.180668] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[706.579662] Starting dynamic subtest: pipe-C-eDP-1
[709.315196] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.747s)
[709.681834] Starting dynamic subtest: pipe-D-eDP-1
[712.446646] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[712.448652] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.602s)
[713.633482] [133/134] (309s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[713.745862] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[713.750037] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[713.879395] [134/134] (308s left) kms_cursor_crc (cursor-sliding-max-size)
[714.199842] Starting subtest: cursor-sliding-max-size
[714.206349] Subtest cursor-sliding-max-size: SKIP (0.000s)
[714.360984] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ccs
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_capture
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: sysfs_timeslice_duration
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_chamelium_frames
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane_cursor
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: gem_exec_flush
results: parsing output: 23/ for test: gem_cs_tlb
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_chamelium_audio
results: parsing output: 29/ for test: gem_tiled_wb
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: syncobj_basic
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: i915_pm_rps
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_tiled_blits
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: gem_ctx_shared
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: core_getstats
results: parsing output: 65/ for test: kms_joiner
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: gen7_exec_parse
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_busy
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_tiled_display
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_create
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: sw_sync
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_pipe_b_c_ivb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_exec_capture
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: kms_vrr
results: parsing output: 98/ for test: kms_setmode
results: parsing output: 99/ for test: gem_madvise
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_offset
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: prime_busy
results: parsing output: 107/ for test: kms_vrr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_selftest
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_store
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_fbcon_fbt
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_cursor_crc
Done.