[57.656096] Initializing watchdogs
[57.656145]   /dev/watchdog0
[57.670340] [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]
[57.675016] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.677299] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.680732] [001/132] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[57.816620] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[61.766469] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.957s)
[62.876673] [002/132] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[62.968826] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[62.973335] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[63.085864] [003/132] (955s left) gem_softpin (noreloc-s3)
[63.157893] Starting subtest: noreloc-S3
[83.261796] Subtest noreloc-S3: SUCCESS (5.402s)
[83.369800] [004/132] (934s left) api_intel_bb (simple-bb-ctx)
[83.446862] Starting subtest: simple-bb-ctx
[83.458940] Subtest simple-bb-ctx: SUCCESS (0.017s)
[83.571986] [005/132] (934s left) i915_selftest (perf)
[86.820652] Starting subtest: perf
[86.822978] Starting dynamic subtest: engine_cs
[91.104516] Dynamic subtest engine_cs: SUCCESS (4.289s)
[91.113528] Starting dynamic subtest: request
[98.420572] Dynamic subtest request: SUCCESS (7.318s)
[98.429638] Starting dynamic subtest: migrate
[102.712236] Dynamic subtest migrate: SUCCESS (4.292s)
[102.720775] Starting dynamic subtest: region
[108.366788] Dynamic subtest region: SUCCESS (5.655s)
[108.369384] Subtest perf: SUCCESS (21.557s)
[108.395991] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[108.398846] [006/132] (909s left) kms_atomic (crtc-invalid-params-fence)
[109.917264] Starting subtest: crtc-invalid-params-fence
[109.919133] Starting dynamic subtest: pipe-A-eDP-1
[110.402552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s)
[110.404930] Subtest crtc-invalid-params-fence: SUCCESS (0.485s)
[111.258287] [FACT kms_atomic (crtc-invalid-params-fence)] new: kernel.kmod_is_loaded.i915: true
[111.262685] [007/132] (907s left) gem_exec_params (larger-than-life-batch)
[111.325457] Starting subtest: larger-than-life-batch
[113.635821] Subtest larger-than-life-batch: SUCCESS (2.309s)
[114.679971] [008/132] (903s left) gem_exec_whisper (basic-normal-all)
[114.778371] Starting subtest: basic-normal-all
[117.951364] Subtest basic-normal-all: SUCCESS (3.171s)
[118.132518] [009/132] (900s left) kms_cursor_crc (cursor-onscreen-64x64)
[118.324415] Starting subtest: cursor-onscreen-64x64
[118.329311] Starting dynamic subtest: pipe-A-eDP-1
[120.446709] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[120.483453] Starting dynamic subtest: pipe-D-eDP-1
[123.263675] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s)
[123.265961] Subtest cursor-onscreen-64x64: SUCCESS (4.938s)
[124.081037] [010/132] (894s left) prime_vgem (fence-read-hang)
[124.241545] Subtest fence-read-hang: SKIP (0.000s)
[124.323236] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[124.326448] [011/132] (894s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[124.413910] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[124.439954] Starting dynamic subtest: pipe-A-plane-0
[124.872775] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[124.884145] Starting dynamic subtest: pipe-A-plane-3
[125.127940] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[126.260975] Starting dynamic subtest: pipe-B-plane-0
[126.685940] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[126.697679] Starting dynamic subtest: pipe-B-plane-3
[126.941385] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[127.262625] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.850s)
[128.144693] [012/132] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[128.246334] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[128.250728] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[128.343086] [013/132] (890s left) i915_pm_rpm (system-suspend)
[129.871511] Starting subtest: system-suspend
[148.051584] Subtest system-suspend: SUCCESS (2.879s)
[148.424407] [014/132] (870s left) perf (invalid-oa-format-id)
[148.614482] Starting subtest: invalid-oa-format-id
[148.624034] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[148.673130] [015/132] (870s left) kms_flip (2x-flip-vs-fences-interruptible)
[148.773439] Starting subtest: 2x-flip-vs-fences-interruptible
[148.777935] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[148.882018] [016/132] (869s left) intel_hwmon (hwmon-read)
[148.951676] Subtest hwmon-read: SKIP (0.000s)
[149.021195] [017/132] (869s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[149.117162] Starting subtest: fbc-rgb101010-draw-blt
[153.706756] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.595s)
[154.814987] [018/132] (864s left) kms_cursor_crc (cursor-random-64x21)
[155.023845] Starting subtest: cursor-random-64x21
[155.071934] Subtest cursor-random-64x21: SKIP (0.042s)
[155.312023] [019/132] (863s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[155.406286] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[155.410575] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[155.471214] [020/132] (863s left) dmabuf_sync_file (export-multiwait)
[155.514040] Starting subtest: export-multiwait
[155.516374] Subtest export-multiwait: SUCCESS (0.001s)
[155.576785] [021/132] (863s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[155.676183] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[156.664294] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.990s)
[156.787077] [022/132] (862s left) kms_universal_plane (disable-primary-vs-flip)
[156.876876] Starting subtest: disable-primary-vs-flip
[156.878706] Starting dynamic subtest: pipe-A-eDP-1
[158.372115] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.495s)
[158.382681] Starting dynamic subtest: pipe-B-eDP-1
[160.576186] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.205s)
[160.589328] Starting dynamic subtest: pipe-C-eDP-1
[162.819388] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[162.830305] Starting dynamic subtest: pipe-D-eDP-1
[164.980240] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s)
[164.982478] Subtest disable-primary-vs-flip: SUCCESS (8.108s)
[165.809178] [023/132] (853s left) kms_joiner (invalid-modeset-big-joiner)
[165.914162] Starting subtest: invalid-modeset-big-joiner
[165.918472] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[165.994890] [024/132] (853s left) gem_exec_schedule (preempt-user)
[166.066986] Starting subtest: preempt-user
[166.069352] Starting dynamic subtest: rcs0
[166.085683] Dynamic subtest rcs0: SUCCESS (0.026s)
[166.098259] Starting dynamic subtest: bcs0
[166.115361] Dynamic subtest bcs0: SUCCESS (0.029s)
[166.127856] Starting dynamic subtest: vcs0
[166.156893] Dynamic subtest vcs0: SUCCESS (0.040s)
[166.167054] Starting dynamic subtest: vcs1
[166.175193] Dynamic subtest vcs1: SUCCESS (0.018s)
[166.184158] Starting dynamic subtest: vecs0
[166.199200] Dynamic subtest vecs0: SUCCESS (0.023s)
[166.210824] Starting dynamic subtest: ccs0
[166.218941] Dynamic subtest ccs0: SUCCESS (0.020s)
[166.221251] Subtest preempt-user: SUCCESS (0.160s)
[167.963144] [025/132] (851s left) gem_softpin (safe-alignment)
[168.029611] Starting subtest: safe-alignment
[168.051712] Subtest safe-alignment: SUCCESS (0.022s)
[169.988849] [026/132] (849s left) kms_cursor_edge_walk (256x256-top-bottom)
[170.078917] Starting subtest: 256x256-top-bottom
[170.081055] Starting dynamic subtest: pipe-A-eDP-1
[173.525865] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[173.535361] Starting dynamic subtest: pipe-D-eDP-1
[176.662057] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[176.664350] Subtest 256x256-top-bottom: SUCCESS (6.585s)
[177.456314] [027/132] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[177.558636] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[186.254655] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.699s)
[186.378255] [028/132] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[186.473927] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[193.229051] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.756s)
[193.362484] [029/132] (825s left) kms_vblank (ts-continuation-modeset-rpm)
[193.450971] Starting subtest: ts-continuation-modeset-rpm
[193.452930] Starting dynamic subtest: pipe-A-eDP-1
[195.962065] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.510s)
[195.976717] Starting dynamic subtest: pipe-D-eDP-1
[198.207038] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[198.209252] Subtest ts-continuation-modeset-rpm: SUCCESS (4.756s)
[199.000590] [030/132] (820s left) prime_self_import (reimport-vs-gem_close-race)
[199.046948] Starting subtest: reimport-vs-gem_close-race
[204.110115] Subtest reimport-vs-gem_close-race: SUCCESS (5.065s)
[204.195888] [031/132] (815s left) kms_psr (pr-primary-page-flip)
[204.294336] Starting subtest: pr-primary-page-flip
[204.298504] Subtest pr-primary-page-flip: SKIP (0.000s)
[204.368980] [032/132] (815s left) gem_exec_reloc (basic-write-read-active)
[204.424724] Subtest basic-write-read-active: SKIP (0.000s)
[204.491718] [033/132] (814s left) gem_mmap_gtt (cpuset-big-copy-odd)
[204.552551] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[204.611783] [034/132] (814s left) gem_ctx_persistence (engines-mixed-process)
[204.662991] Starting subtest: engines-mixed-process
[204.665493] Starting dynamic subtest: rcs0
[205.902318] Dynamic subtest rcs0: SUCCESS (1.239s)
[205.913565] Starting dynamic subtest: bcs0
[207.947180] Dynamic subtest bcs0: SUCCESS (2.044s)
[207.960413] Starting dynamic subtest: vcs0
[209.917302] Dynamic subtest vcs0: SUCCESS (1.965s)
[209.928062] Starting dynamic subtest: vcs1
[211.856323] Dynamic subtest vcs1: SUCCESS (1.942s)
[211.866963] Starting dynamic subtest: vecs0
[213.896065] Dynamic subtest vecs0: SUCCESS (2.039s)
[213.906225] Starting dynamic subtest: ccs0
[215.892309] Dynamic subtest ccs0: SUCCESS (1.996s)
[215.894847] Subtest engines-mixed-process: SUCCESS (11.231s)
[215.997931] [035/132] (803s left) gem_mmap_wc (bad-object)
[216.064892] Subtest bad-object: SKIP (0.000s)
[216.124670] [036/132] (803s left) kms_color (degamma)
[216.247370] Starting subtest: degamma
[216.249235] Starting dynamic subtest: pipe-A-eDP-1
[216.953991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[216.964598] Starting dynamic subtest: pipe-B-eDP-1
[218.418704] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[218.428997] Starting dynamic subtest: pipe-C-eDP-1
[219.783493] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[219.793508] Starting dynamic subtest: pipe-D-eDP-1
[221.113752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[221.116145] Subtest degamma: SUCCESS (4.870s)
[221.924151] [037/132] (797s left) gem_create (create-ext-placement-sanity-check)
[222.095285] Starting subtest: create-ext-placement-sanity-check
[222.097878] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[222.191853] [038/132] (797s left) gem_userptr_blits (mmap-offset-banned)
[222.254881] Starting subtest: mmap-offset-banned
[222.257110] Starting dynamic subtest: wb
[222.259435] Dynamic subtest wb: SUCCESS (0.000s)
[222.268992] Starting dynamic subtest: wc
[222.270888] Dynamic subtest wc: SUCCESS (0.000s)
[222.279545] Starting dynamic subtest: uc
[222.281679] Dynamic subtest uc: SUCCESS (0.000s)
[222.283892] Subtest mmap-offset-banned: SUCCESS (0.002s)
[222.369391] [039/132] (797s left) kms_getfb (getfb2-handle-closed)
[222.465683] Starting subtest: getfb2-handle-closed
[222.467948] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[222.565682] [040/132] (797s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[222.656844] Starting subtest: sprite-rotation-90-pos-100-0
[222.661433] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[222.736785] [041/132] (797s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[222.821305] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[222.823436] Starting dynamic subtest: pipe-A-eDP-1
[222.847680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.859512] Starting dynamic subtest: pipe-B-eDP-1
[222.881945] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.891364] Starting dynamic subtest: pipe-C-eDP-1
[222.914377] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.923296] Starting dynamic subtest: pipe-D-eDP-1
[222.946749] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.951041] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[225.081685] [042/132] (794s left) kms_atomic_interruptible (universal-setplane-primary)
[225.187189] Starting subtest: universal-setplane-primary
[225.189448] Starting dynamic subtest: pipe-A-eDP-1
[232.617143] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.431s)
[232.619508] Subtest universal-setplane-primary: SUCCESS (7.433s)
[233.433252] [043/132] (786s left) kms_pm_dc (dc6-psr)
[234.542449] Starting subtest: dc6-psr
[237.426259] Subtest dc6-psr: SUCCESS (2.885s)
[238.272770] [044/132] (781s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[238.655609] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[239.475159] [045/132] (780s left) prime_vgem (basic-fence-blt)
[239.553144] Starting subtest: basic-fence-blt
[239.639181] Subtest basic-fence-blt: SUCCESS (0.088s)
[239.761742] [046/132] (780s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[239.854298] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[239.856736] Starting dynamic subtest: pipe-A
[240.192731] Dynamic subtest pipe-A: SUCCESS (0.339s)
[240.202990] Starting dynamic subtest: pipe-B
[241.591697] Dynamic subtest pipe-B: SUCCESS (1.398s)
[241.605133] Starting dynamic subtest: pipe-C
[243.017552] Dynamic subtest pipe-C: SUCCESS (1.425s)
[243.027832] Starting dynamic subtest: pipe-D
[244.451387] Dynamic subtest pipe-D: SUCCESS (1.433s)
[244.453780] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.600s)
[245.618054] [047/132] (774s left) gem_mmap_wc (coherency)
[245.669065] Subtest coherency: SKIP (0.000s)
[245.727818] [048/132] (774s left) gem_tiled_fence_blits (basic)
[245.783695] Subtest basic: SKIP (0.000s)
[245.845593] [049/132] (774s left) syncobj_eventfd (invalid-illegal-handle)
[245.899173] Starting subtest: invalid-illegal-handle
[245.901369] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[246.018547] [050/132] (774s left) kms_psr (fbc-pr-cursor-render)
[246.097306] Starting subtest: fbc-pr-cursor-render
[246.101721] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[246.193456] [051/132] (774s left) kms_legacy_colorkey (basic)
[246.272570] Starting subtest: basic
[246.274852] Starting dynamic subtest: pipe-A
[246.316313] Dynamic subtest pipe-A: SUCCESS (0.045s)
[246.331483] Starting dynamic subtest: pipe-B
[246.333408] Dynamic subtest pipe-B: SUCCESS (0.001s)
[246.342300] Starting dynamic subtest: pipe-C
[246.344557] Dynamic subtest pipe-C: SUCCESS (0.000s)
[246.353330] Starting dynamic subtest: pipe-D
[246.355554] Dynamic subtest pipe-D: SUCCESS (0.000s)
[246.357779] Subtest basic: SUCCESS (0.051s)
[246.408955] [052/132] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[246.496360] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[246.500722] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.607706] [053/132] (773s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[246.663189] Starting subtest: invalid-multi-wait-unsubmitted
[246.665232] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[246.754228] [054/132] (773s left) gem_mmap_offset (partial-remap)
[246.816486] Starting subtest: partial-remap
[246.818033] Starting dynamic subtest: smem0
[246.825258] Dynamic subtest smem0: SUCCESS (0.003s)
[246.826885] Subtest partial-remap: SUCCESS (0.004s)
[246.933200] [055/132] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[247.028064] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[247.031349] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[247.126097] [056/132] (773s left) syncobj_basic (bad-destroy)
[247.176707] Starting subtest: bad-destroy
[247.178330] Subtest bad-destroy: SUCCESS (0.000s)
[247.265667] [057/132] (773s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[247.358715] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[247.360609] Starting dynamic subtest: pipe-A-eDP-1
[247.406553] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[247.416965] Starting dynamic subtest: pipe-B-eDP-1
[247.461566] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[247.470745] Starting dynamic subtest: pipe-C-eDP-1
[247.517096] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[247.526337] Starting dynamic subtest: pipe-D-eDP-1
[247.572862] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[247.576366] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[249.611128] [058/132] (770s left) kms_properties (plane-properties-atomic)
[249.709528] Starting subtest: plane-properties-atomic
[249.711640] Starting dynamic subtest: pipe-A-eDP-1
[250.269588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[250.283150] Starting dynamic subtest: pipe-B-eDP-1
[251.592630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s)
[251.602954] Starting dynamic subtest: pipe-C-eDP-1
[252.830698] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[252.841191] Starting dynamic subtest: pipe-D-eDP-1
[254.077707] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[254.079676] Subtest plane-properties-atomic: SUCCESS (4.368s)
[254.887127] [059/132] (765s left) kms_debugfs (display-on-read-all)
[254.986572] Starting subtest: display-on-read-all
[255.152333] Subtest display-on-read-all: SUCCESS (0.166s)
[255.274799] [060/132] (765s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[255.388339] Starting subtest: flip-vs-cursor-busy-crc-legacy
[256.200895] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.812s)
[257.022860] [061/132] (763s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[257.120924] Starting subtest: y-tiled-16bpp-rotate-180
[257.124980] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[257.203853] [062/132] (763s left) syncobj_timeline (invalid-transfer-illegal-handle)
[257.251211] Starting subtest: invalid-transfer-illegal-handle
[257.253472] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[257.344853] [063/132] (763s left) kms_flip (flip-vs-suspend-interruptible)
[257.432066] Starting subtest: flip-vs-suspend-interruptible
[257.434442] Starting dynamic subtest: A-eDP1
[290.269579] Dynamic subtest A-eDP1: SUCCESS (4.184s)
[290.287228] Starting dynamic subtest: B-eDP1
[339.267980] Dynamic subtest B-eDP1: SUCCESS (4.530s)
[339.278336] Starting dynamic subtest: C-eDP1
[388.267113] Dynamic subtest C-eDP1: SUCCESS (4.527s)
[388.277094] Starting dynamic subtest: D-eDP1
[437.258992] Dynamic subtest D-eDP1: SUCCESS (4.459s)
[437.261706] Subtest flip-vs-suspend-interruptible: SUCCESS (17.711s)
[438.444208] [064/132] (582s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[438.504550] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[438.605715] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[438.690312] [065/132] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[438.792494] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[438.796954] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[438.902606] [066/132] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[438.992520] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[438.998425] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[439.083694] [067/132] (581s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[439.148504] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[439.153718] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[439.344084] [068/132] (581s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[439.443194] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[446.760680] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.324s)
[446.886517] [069/132] (574s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[449.230588] Starting subtest: modeset-lpsp-stress-no-wait
[459.083137] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.859s)
[459.159203] [070/132] (561s left) gem_exec_params (dr1-dirt)
[459.223828] Starting subtest: DR1-dirt
[459.226494] Subtest DR1-dirt: SUCCESS (0.000s)
[459.329894] [071/132] (561s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[459.437233] Starting subtest: 4-tiled-64bpp-rotate-180
[460.904921] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.468s)
[461.073990] [072/132] (560s left) gem_exec_nop (basic-sequential)
[461.144676] Starting subtest: basic-sequential
[475.517848] Subtest basic-sequential: SUCCESS (14.385s)
[475.743980] [073/132] (545s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[475.846043] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[475.853772] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[475.933061] [074/132] (545s left) kms_psr (fbc-psr-sprite-render)
[476.025729] Starting subtest: fbc-psr-sprite-render
[476.028074] Starting dynamic subtest: eDP-1
[476.032773] Dynamic subtest eDP-1: SKIP (0.000s)
[476.037543] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[476.098235] [075/132] (545s left) kms_properties (plane-properties-legacy)
[476.199356] Starting subtest: plane-properties-legacy
[476.201704] Starting dynamic subtest: pipe-A-eDP-1
[476.772950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[476.783707] Starting dynamic subtest: pipe-B-eDP-1
[478.010212] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.235s)
[478.022670] Starting dynamic subtest: pipe-C-eDP-1
[479.250564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[479.261729] Starting dynamic subtest: pipe-D-eDP-1
[480.478573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[480.481594] Subtest plane-properties-legacy: SUCCESS (4.281s)
[481.328640] [076/132] (540s left) syncobj_timeline (wait-all-snapshot)
[481.390535] Starting subtest: wait-all-snapshot
[481.470859] Subtest wait-all-snapshot: SUCCESS (0.082s)
[481.548737] [077/132] (539s left) gem_exec_balancer (bonded-false-hang)
[481.799016] Starting subtest: bonded-false-hang
[481.805101] Subtest bonded-false-hang: SKIP (0.000s)
[481.907104] [078/132] (539s left) gem_exec_endless (dispatch)
[481.974740] Starting subtest: dispatch
[481.977082] Starting dynamic subtest: rcs0
[481.984613] Dynamic subtest rcs0: SUCCESS (0.006s)
[481.998936] Starting dynamic subtest: bcs0
[482.004847] Dynamic subtest bcs0: SUCCESS (0.006s)
[482.015371] Starting dynamic subtest: vcs0
[482.020589] Dynamic subtest vcs0: SUCCESS (0.005s)
[482.030363] Starting dynamic subtest: vcs1
[482.035160] Dynamic subtest vcs1: SUCCESS (0.006s)
[482.044246] Starting dynamic subtest: vecs0
[482.048850] Dynamic subtest vecs0: SUCCESS (0.005s)
[482.057944] Starting dynamic subtest: ccs0
[482.062555] Dynamic subtest ccs0: SUCCESS (0.004s)
[482.064932] Subtest dispatch: SUCCESS (0.037s)
[484.085065] [079/132] (537s left) i915_pm_freq_api (freq-suspend)
[484.165225] Starting subtest: freq-suspend
[484.167871] Starting dynamic subtest: gt0
[500.252508] Dynamic subtest gt0: SUCCESS (1.260s)
[500.264202] Starting dynamic subtest: gt1
[516.258521] Dynamic subtest gt1: SUCCESS (1.205s)
[516.260766] Subtest freq-suspend: SUCCESS (2.469s)
[516.331421] [080/132] (505s left) gem_exec_schedule (pi-userfault)
[516.502275] Starting subtest: pi-userfault
[516.504494] Starting dynamic subtest: rcs0
[516.511646] Dynamic subtest rcs0: SUCCESS (0.013s)
[516.521052] Starting dynamic subtest: bcs0
[516.523261] Dynamic subtest bcs0: SUCCESS (0.008s)
[516.539730] Starting dynamic subtest: vcs0
[516.542054] Dynamic subtest vcs0: SUCCESS (0.006s)
[516.551688] Starting dynamic subtest: vcs1
[516.553947] Dynamic subtest vcs1: SUCCESS (0.011s)
[516.564515] Starting dynamic subtest: vecs0
[516.566481] Dynamic subtest vecs0: SUCCESS (0.009s)
[516.575208] Starting dynamic subtest: ccs0
[516.577160] Dynamic subtest ccs0: SUCCESS (0.008s)
[516.579086] Subtest pi-userfault: SUCCESS (0.060s)
[516.756367] [081/132] (504s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[516.848656] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[516.850962] Starting dynamic subtest: pipe-A-eDP-1
[516.872659] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[516.884078] Starting dynamic subtest: pipe-B-eDP-1
[516.904541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[516.914434] Starting dynamic subtest: pipe-C-eDP-1
[516.935192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[516.944268] Starting dynamic subtest: pipe-D-eDP-1
[516.966011] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[516.969989] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[519.094905] [082/132] (502s left) gem_ctx_bad_destroy (invalid-pad)
[519.157743] Starting subtest: invalid-pad
[519.160202] Subtest invalid-pad: SUCCESS (0.000s)
[519.244661] [083/132] (502s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[519.635748] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[520.405696] [084/132] (501s left) syncobj_wait (wait-all-delayed-signal)
[520.463565] Starting subtest: wait-all-delayed-signal
[520.565790] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[520.646241] [085/132] (501s left) syncobj_timeline (signal)
[520.705206] Starting subtest: signal
[520.707095] Subtest signal: SUCCESS (0.000s)
[520.791977] [086/132] (501s left) gem_userptr_blits (readonly-pwrite-unsync)
[520.863149] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[520.994181] [087/132] (500s left) gem_caching (reads)
[521.062228] Subtest reads: SKIP (0.000s)
[521.160655] [088/132] (500s left) vgem_slow (nohang)
[521.218543] Starting subtest: nohang
[531.601604] Subtest nohang: SUCCESS (10.390s)
[531.668312] [089/132] (490s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[531.776066] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[531.780106] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.878749] [090/132] (490s left) kms_addfb_basic (addfb25-bad-modifier)
[531.959190] Starting subtest: addfb25-bad-modifier
[531.961358] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[532.061560] [091/132] (489s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[532.154213] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[532.169128] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.014s)
[532.259663] [092/132] (489s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[532.345028] Starting subtest: crc-primary-suspend-y-tiled-ccs
[532.347298] Starting dynamic subtest: pipe-A-eDP-1
[532.356418] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[532.367459] Starting dynamic subtest: pipe-B-eDP-1
[532.376417] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[532.385933] Starting dynamic subtest: pipe-C-eDP-1
[532.395326] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[532.406924] Starting dynamic subtest: pipe-D-eDP-1
[532.415936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[532.420497] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[534.594309] [093/132] (487s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[534.692487] Starting subtest: psr-shrfb-scaledprimary
[540.548437] Subtest psr-shrfb-scaledprimary: SUCCESS (5.862s)
[540.677223] [094/132] (481s left) perf_pmu (multi-client)
[540.732583] Starting subtest: multi-client
[540.734779] Starting dynamic subtest: rcs0
[541.795874] Dynamic subtest rcs0: SUCCESS (1.064s)
[541.806641] Starting dynamic subtest: bcs0
[542.844486] Dynamic subtest bcs0: SUCCESS (1.046s)
[542.854960] Starting dynamic subtest: vcs0
[543.893488] Dynamic subtest vcs0: SUCCESS (1.046s)
[543.904036] Starting dynamic subtest: vcs1
[545.645467] Dynamic subtest vcs1: SUCCESS (1.748s)
[545.656159] Starting dynamic subtest: vecs0
[547.627618] Dynamic subtest vecs0: SUCCESS (1.980s)
[547.639304] Starting dynamic subtest: ccs0
[549.676544] Dynamic subtest ccs0: SUCCESS (2.044s)
[549.679809] Subtest multi-client: SUCCESS (8.946s)
[549.796224] [095/132] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[549.900028] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[549.904320] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[549.996231] [096/132] (472s left) i915_drm_fdinfo (busy-idle-check-all)
[550.037658] Starting subtest: busy-idle-check-all
[550.039503] Starting dynamic subtest: rcs0
[550.044065] Dynamic subtest rcs0: SKIP (0.004s)
[550.053523] Starting dynamic subtest: bcs0
[550.057774] Dynamic subtest bcs0: SKIP (0.000s)
[550.066885] Starting dynamic subtest: vcs0
[550.071105] Dynamic subtest vcs0: SKIP (0.000s)
[550.079978] Starting dynamic subtest: vcs1
[550.084359] Dynamic subtest vcs1: SKIP (0.000s)
[550.093028] Starting dynamic subtest: vecs0
[550.097015] Dynamic subtest vecs0: SKIP (0.000s)
[550.105681] Starting dynamic subtest: ccs0
[550.109776] Dynamic subtest ccs0: SKIP (0.000s)
[550.113877] Subtest busy-idle-check-all: SKIP (0.009s)
[550.152042] [097/132] (472s left) gem_mmap_gtt (basic-short)
[550.213151] Subtest basic-short: SKIP (0.000s)
[550.294736] [098/132] (472s left) kms_flip (dpms-vs-vblank-race-interruptible)
[550.394689] Starting subtest: dpms-vs-vblank-race-interruptible
[550.396961] Starting dynamic subtest: A-eDP1
[555.402522] Dynamic subtest A-eDP1: SUCCESS (5.003s)
[555.415862] Starting dynamic subtest: B-eDP1
[558.912857] Dynamic subtest B-eDP1: SUCCESS (3.510s)
[558.926496] Starting dynamic subtest: C-eDP1
[563.537776] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[563.551053] Starting dynamic subtest: D-eDP1
[568.178458] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[568.180886] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.782s)
[569.054190] [099/132] (453s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[569.152362] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[573.425675] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.276s)
[574.566155] [100/132] (447s left) gem_ctx_bad_destroy (double-destroy)
[574.621028] Starting subtest: double-destroy
[574.623390] Subtest double-destroy: SUCCESS (0.000s)
[574.697038] [101/132] (447s left) gem_unfence_active_buffers
[574.848684] [102/132] (447s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[574.941462] Starting subtest: psr2-cursor-plane-update-sf
[574.943622] Starting dynamic subtest: pipe-A-eDP-1
[575.517809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.580s)
[575.531037] Starting dynamic subtest: pipe-B-eDP-1
[576.836821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.318s)
[576.839108] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.901s)
[577.701265] [103/132] (444s left) kms_plane_multiple (2x-tiling-x)
[577.799992] Starting subtest: 2x-tiling-x
[577.804396] Subtest 2x-tiling-x: SKIP (0.000s)
[577.873570] [104/132] (444s left) gem_userptr_blits (invalid-null-pointer)
[577.927301] Starting subtest: invalid-null-pointer
[577.929258] Subtest invalid-null-pointer: SUCCESS (0.001s)
[578.059483] [105/132] (444s left) gen7_exec_parse (load-register-reg)
[578.124173] Subtest load-register-reg: SKIP (0.000s)
[578.191431] [106/132] (444s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[578.276465] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[584.885459] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.613s)
[585.020887] [107/132] (437s left) gem_ctx_persistence (heartbeat-hang)
[585.088433] Starting subtest: heartbeat-hang
[585.092753] Subtest heartbeat-hang: SKIP (0.000s)
[585.207602] [108/132] (437s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[585.319532] Starting subtest: yf-tiled-64bpp-rotate-180
[585.323866] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[585.425443] [109/132] (437s left) kms_plane_alpha_blend (alpha-opaque-fb)
[585.520184] Starting subtest: alpha-opaque-fb
[585.793508] Starting dynamic subtest: pipe-A-eDP-1
[586.516345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[586.529465] Starting dynamic subtest: pipe-D-eDP-1
[587.973428] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.452s)
[587.975752] Subtest alpha-opaque-fb: SUCCESS (2.456s)
[588.809080] [110/132] (434s left) syncobj_wait (reset-multiple-signaled)
[588.872421] Starting subtest: reset-multiple-signaled
[588.874394] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[588.991030] [111/132] (433s left) gem_exec_fence (syncobj-timeline-repeat)
[589.552539] Starting subtest: syncobj-timeline-repeat
[589.792456] Subtest syncobj-timeline-repeat: SUCCESS (0.240s)
[590.732416] [112/132] (432s left) dumb_buffer (map-valid)
[590.790569] Starting subtest: map-valid
[590.792939] Subtest map-valid: SUCCESS (0.000s)
[590.891794] [113/132] (432s left) kms_plane (plane-position-hole-dpms)
[590.974040] Starting subtest: plane-position-hole-dpms
[591.474297] Starting dynamic subtest: pipe-A-plane-1
[593.886447] Dynamic subtest pipe-A-plane-1: SUCCESS (2.413s)
[593.897432] Starting dynamic subtest: pipe-A-plane-2
[596.245705] Dynamic subtest pipe-A-plane-2: SUCCESS (2.358s)
[596.256201] Starting dynamic subtest: pipe-A-plane-3
[598.614181] Dynamic subtest pipe-A-plane-3: SUCCESS (2.367s)
[598.624547] Starting dynamic subtest: pipe-A-plane-4
[600.953528] Dynamic subtest pipe-A-plane-4: SUCCESS (2.341s)
[600.964551] Starting dynamic subtest: pipe-A-plane-5
[600.986432] Dynamic subtest pipe-A-plane-5: SUCCESS (0.030s)
[602.137650] Starting dynamic subtest: pipe-B-plane-1
[604.601381] Dynamic subtest pipe-B-plane-1: SUCCESS (2.470s)
[604.612591] Starting dynamic subtest: pipe-B-plane-2
[607.037681] Dynamic subtest pipe-B-plane-2: SUCCESS (2.439s)
[607.048647] Starting dynamic subtest: pipe-B-plane-3
[609.430374] Dynamic subtest pipe-B-plane-3: SUCCESS (2.392s)
[609.441067] Starting dynamic subtest: pipe-B-plane-4
[611.857059] Dynamic subtest pipe-B-plane-4: SUCCESS (2.424s)
[611.870132] Starting dynamic subtest: pipe-B-plane-5
[611.881004] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[611.883265] Subtest plane-position-hole-dpms: SUCCESS (20.912s)
[612.667137] [114/132] (410s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[612.768351] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[612.779428] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[612.861062] [115/132] (410s left) gem_partial_pwrite_pread (write-uncached)
[612.914327] Subtest write-uncached: SKIP (0.000s)
[612.988097] [116/132] (410s left) perf (gen12-unprivileged-single-ctx-counters)
[613.084276] Starting subtest: gen12-unprivileged-single-ctx-counters
[613.086599] Starting dynamic subtest: rcs0
[613.182040] Dynamic subtest rcs0: SUCCESS (0.097s)
[613.184645] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.099s)
[613.235482] [117/132] (409s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[613.365625] Starting subtest: pipe-fbc-rte
[613.372465] Starting dynamic subtest: pipe-B-eDP-1
[618.865452] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.503s)
[618.872578] Subtest pipe-fbc-rte: SUCCESS (5.506s)
[621.231491] [118/132] (401s left) gem_lmem_swapping (heavy-multi)
[621.275785] Subtest heavy-multi: SKIP (0.000s)
[621.324874] [119/132] (401s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[621.425618] Starting subtest: psr-2p-primscrn-spr-indfb-move
[621.430054] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[621.531418] [120/132] (401s left) vgem_basic (create)
[621.582256] Starting subtest: create
[621.584232] Subtest create: SUCCESS (0.000s)
[621.641243] [121/132] (401s left) kms_psr (fbc-pr-primary-render)
[621.730236] Starting subtest: fbc-pr-primary-render
[621.734238] Subtest fbc-pr-primary-render: SKIP (0.000s)
[621.815280] [122/132] (401s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[621.918898] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[621.923353] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[622.019274] [123/132] (401s left) kms_psr (psr-primary-render)
[622.125146] Starting subtest: psr-primary-render
[622.127413] Starting dynamic subtest: eDP-1
[623.899009] Dynamic subtest eDP-1: SUCCESS (1.772s)
[623.900922] Subtest psr-primary-render: SUCCESS (1.773s)
[624.767277] [124/132] (398s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[624.870463] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[625.972584] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.102s)
[626.082018] [125/132] (397s left) kms_big_fb (linear-64bpp-rotate-180)
[626.188531] Starting subtest: linear-64bpp-rotate-180
[627.712189] Subtest linear-64bpp-rotate-180: SUCCESS (1.524s)
[627.889164] [126/132] (395s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[628.044229] Starting subtest: dp-mst-lic-type-0-hdcp14
[628.048610] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[628.154935] [127/132] (395s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[628.264439] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[628.266046] Starting dynamic subtest: pipe-A-eDP-1
[628.289967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[628.305590] Starting dynamic subtest: pipe-B-eDP-1
[628.322289] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[628.339535] Starting dynamic subtest: pipe-C-eDP-1
[628.356307] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[628.366354] Starting dynamic subtest: pipe-D-eDP-1
[628.383156] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[628.385081] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[630.552896] [128/132] (393s left) kms_psr (psr2-primary-blt)
[630.636954] Starting subtest: psr2-primary-blt
[630.639146] Starting dynamic subtest: eDP-1
[632.343403] Dynamic subtest eDP-1: SUCCESS (1.708s)
[632.345636] Subtest psr2-primary-blt: SUCCESS (1.709s)
[633.216612] [129/132] (390s left) sysfs_preempt_timeout (timeout)
[633.282897] Starting subtest: timeout
[633.285293] Starting dynamic subtest: vecs0
[642.609029] Dynamic subtest vecs0: SUCCESS (9.322s)
[642.627498] Starting dynamic subtest: ccs0
[643.937156] Dynamic subtest ccs0: SUCCESS (1.326s)
[643.947478] Starting dynamic subtest: vcs0
[653.616866] Dynamic subtest vcs0: SUCCESS (9.678s)
[653.629472] Starting dynamic subtest: bcs0
[654.842446] Dynamic subtest bcs0: SUCCESS (1.227s)
[654.852353] Starting dynamic subtest: rcs0
[656.070927] Dynamic subtest rcs0: SUCCESS (1.225s)
[656.082152] Starting dynamic subtest: vcs1
[665.651780] Dynamic subtest vcs1: SUCCESS (9.581s)
[665.654380] Subtest timeout: SUCCESS (32.371s)
[665.733772] [130/132] (357s left) kms_feature_discovery (psr1)
[665.840886] Starting subtest: psr1
[665.843112] Subtest psr1: SUCCESS (0.000s)
[665.918399] [131/132] (357s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[666.019184] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[666.021460] Starting dynamic subtest: pipe-A-default-mode
[668.716609] Dynamic subtest pipe-A-default-mode: SUCCESS (2.698s)
[668.719069] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.700s)
[669.590224] [132/132] (354s left) gem_ringfill (engines-basic)
[675.639632] Starting subtest: engines-basic
[675.642165] Starting dynamic subtest: rcs0
[675.698778] Dynamic subtest rcs0: SUCCESS (0.059s)
[675.710900] Starting dynamic subtest: bcs0
[675.742848] Dynamic subtest bcs0: SUCCESS (0.042s)
[675.753473] Starting dynamic subtest: vcs0
[675.784937] Dynamic subtest vcs0: SUCCESS (0.040s)
[675.795259] Starting dynamic subtest: vcs1
[675.826881] Dynamic subtest vcs1: SUCCESS (0.040s)
[675.837279] Starting dynamic subtest: vecs0
[675.869896] Dynamic subtest vecs0: SUCCESS (0.041s)
[675.880305] Starting dynamic subtest: ccs0
[675.914861] Dynamic subtest ccs0: SUCCESS (0.043s)
[675.917283] Subtest engines-basic: SUCCESS (0.277s)
[676.004474] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: i915_selftest
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: i915_pm_rpm
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: intel_hwmon
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: dmabuf_sync_file
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_universal_plane
results: parsing output: 22/ for test: kms_joiner
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_cursor_edge_walk
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: prime_self_import
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: kms_rotation_crc
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_atomic_interruptible
results: parsing output: 42/ for test: kms_pm_dc
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_tiled_fence_blits
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_legacy_colorkey
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_mmap_offset
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_basic
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_properties
results: parsing output: 58/ for test: kms_debugfs
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_exec_nop
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: gem_exec_endless
results: parsing output: 78/ for test: i915_pm_freq_api
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_ctx_bad_destroy
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: gem_caching
results: parsing output: 87/ for test: vgem_slow
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ctx_bad_destroy
results: parsing output: 100/ for test: gem_unfence_active_buffers
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_plane_multiple
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: gen7_exec_parse
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_plane_alpha_blend
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: dumb_buffer
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_partial_pwrite_pread
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_content_protection
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: sysfs_preempt_timeout
results: parsing output: 129/ for test: kms_feature_discovery
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: gem_ringfill
Done.