[57.523602] Initializing watchdogs
[57.523653]   /dev/watchdog0
[57.537240] [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.541465] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.543775] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.547184] [001/133] (960s left) gem_softpin (noreloc-s3)
[57.629968] Starting subtest: noreloc-S3
[77.741710] Subtest noreloc-S3: SUCCESS (5.421s)
[77.864627] [002/133] (940s left) perf_pmu (gt-awake)
[77.931549] Starting subtest: gt-awake
[86.586849] Subtest gt-awake: SUCCESS (8.655s)
[86.697931] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[86.799953] Starting subtest: zero-hdisplay
[86.802384] Starting dynamic subtest: pipe-A-eDP-1
[87.082880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[87.091842] Starting dynamic subtest: pipe-B-eDP-1
[87.094065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.101559] Starting dynamic subtest: pipe-C-eDP-1
[87.103770] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[87.110829] Starting dynamic subtest: pipe-D-eDP-1
[87.112685] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[87.114970] Subtest zero-hdisplay: SUCCESS (0.290s)
[87.903757] [004/133] (930s left) kms_prop_blob (invalid-set-prop-any)
[87.966312] Starting subtest: invalid-set-prop-any
[87.968205] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[88.065402] [005/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[88.160545] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[95.721312] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.564s)
[95.851006] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[95.949933] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[95.954360] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[96.068627] [007/133] (922s left) kms_cursor_legacy (torture-move)
[96.190347] Starting subtest: torture-move
[96.192538] Starting dynamic subtest: pipe-A
[102.587719] Dynamic subtest pipe-A: SUCCESS (6.394s)
[102.600538] Starting dynamic subtest: pipe-B
[110.053184] Dynamic subtest pipe-B: SUCCESS (7.463s)
[110.061839] Starting dynamic subtest: pipe-C
[117.570520] Dynamic subtest pipe-C: SUCCESS (7.512s)
[117.580385] Starting dynamic subtest: pipe-D
[125.054981] Dynamic subtest pipe-D: SUCCESS (7.482s)
[125.063490] Starting dynamic subtest: all-pipes
[132.106293] Dynamic subtest all-pipes: SUCCESS (7.050s)
[132.109249] Subtest torture-move: SUCCESS (35.902s)
[132.276526] [008/133] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[132.372862] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[135.974691] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.606s)
[137.159595] [009/133] (881s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[137.258457] Starting subtest: fbc-rgb101010-draw-blt
[141.859582] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.603s)
[143.058799] [010/133] (875s left) gem_pxp (create-regular-context-2)
[143.179042] Starting subtest: create-regular-context-2
[143.181512] Subtest create-regular-context-2: SUCCESS (0.002s)
[143.291161] [011/133] (875s left) kms_flip (2x-flip-vs-panning-interruptible)
[143.386923] Starting subtest: 2x-flip-vs-panning-interruptible
[143.399666] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[143.488307] [012/133] (874s left) kms_plane_alpha_blend (constant-alpha-max)
[143.587659] Starting subtest: constant-alpha-max
[143.863518] Starting dynamic subtest: pipe-A-eDP-1
[144.886441] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.023s)
[144.896068] Starting dynamic subtest: pipe-D-eDP-1
[146.477239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.588s)
[146.479934] Subtest constant-alpha-max: SUCCESS (2.891s)
[147.313820] [013/133] (871s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[147.407000] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[147.431366] Starting dynamic subtest: pipe-A-plane-0
[147.720080] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[147.732391] Starting dynamic subtest: pipe-A-plane-3
[147.944102] Dynamic subtest pipe-A-plane-3: SUCCESS (0.222s)
[147.954900] Starting dynamic subtest: pipe-A-plane-5
[147.959558] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[149.021593] Starting dynamic subtest: pipe-B-plane-0
[149.313816] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[149.323379] Starting dynamic subtest: pipe-B-plane-3
[149.557962] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[149.566817] Starting dynamic subtest: pipe-B-plane-5
[149.571341] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[149.871235] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.466s)
[150.686150] [014/133] (867s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[150.742708] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[150.808430] [015/133] (867s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[150.870242] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[150.930392] [016/133] (867s left) gem_vm_create (invalid-destroy)
[150.995229] Starting subtest: invalid-destroy
[150.997537] Subtest invalid-destroy: SUCCESS (0.002s)
[151.109075] [017/133] (867s left) gem_lmem_swapping (heavy-verify-random-ccs)
[151.149961] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[151.195192] [018/133] (867s left) kms_feature_discovery (display-2x)
[151.287590] Starting subtest: display-2x
[151.292031] Subtest display-2x: SKIP (0.000s)
[151.356828] [019/133] (867s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[151.458575] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[151.460815] Starting dynamic subtest: pipe-A-eDP-1
[151.483488] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.495320] Starting dynamic subtest: pipe-B-eDP-1
[151.517073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.525618] Starting dynamic subtest: pipe-C-eDP-1
[151.547258] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.555550] Starting dynamic subtest: pipe-D-eDP-1
[151.577165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.581233] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[153.769833] [020/133] (865s left) gem_mmap_offset (blt-coherency)
[153.823586] Starting subtest: blt-coherency
[153.829251] Subtest blt-coherency: SUCCESS (0.008s)
[153.948707] [021/133] (864s left) gem_pxp (hw-rejects-pxp-context)
[153.998487] Starting subtest: hw-rejects-pxp-context
[154.002998] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[154.097872] [022/133] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[154.184532] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[160.767759] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.586s)
[160.877735] [023/133] (858s left) kms_psr (pr-sprite-mmap-gtt)
[160.978854] Starting subtest: pr-sprite-mmap-gtt
[160.982892] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[161.045669] [024/133] (857s left) gem_exec_reloc (basic-write-gtt-noreloc)
[161.100973] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[161.191370] [025/133] (857s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[161.287475] Starting subtest: plane-lut1d-ctm3x4
[161.467008] Starting dynamic subtest: pipe-A-plane-0
[161.611539] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[161.620804] Starting dynamic subtest: pipe-A-plane-1
[161.744058] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[161.752590] Starting dynamic subtest: pipe-A-plane-2
[161.878774] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[163.109197] Starting dynamic subtest: pipe-B-plane-0
[163.302795] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[163.313223] Starting dynamic subtest: pipe-B-plane-1
[163.436042] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[163.444581] Starting dynamic subtest: pipe-B-plane-2
[163.582860] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[164.745048] Starting dynamic subtest: pipe-C-plane-0
[164.871277] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[164.880306] Starting dynamic subtest: pipe-C-plane-1
[165.004387] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[165.013894] Starting dynamic subtest: pipe-C-plane-2
[165.171106] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[166.381561] Starting dynamic subtest: pipe-D-plane-0
[166.503634] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[166.511976] Starting dynamic subtest: pipe-D-plane-1
[166.648038] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[166.657962] Starting dynamic subtest: pipe-D-plane-2
[166.781487] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[167.069894] Subtest plane-lut1d-ctm3x4: SUCCESS (5.782s)
[167.860774] [026/133] (851s left) gem_exec_schedule (preempt-hang)
[168.052685] Starting subtest: preempt-hang
[168.054887] Starting dynamic subtest: rcs0
[168.289736] Dynamic subtest rcs0: SUCCESS (0.238s)
[168.299150] Starting dynamic subtest: bcs0
[168.524886] Dynamic subtest bcs0: SUCCESS (0.234s)
[168.534392] Starting dynamic subtest: vcs0
[168.747219] Dynamic subtest vcs0: SUCCESS (0.222s)
[168.756977] Starting dynamic subtest: vcs1
[168.969042] Dynamic subtest vcs1: SUCCESS (0.221s)
[168.979112] Starting dynamic subtest: vecs0
[169.207643] Dynamic subtest vecs0: SUCCESS (0.238s)
[169.216335] Starting dynamic subtest: ccs0
[169.438007] Dynamic subtest ccs0: SUCCESS (0.228s)
[169.440093] Subtest preempt-hang: SUCCESS (1.387s)
[169.690735] [027/133] (849s left) kms_psr (psr-cursor-mmap-cpu)
[169.790616] Starting subtest: psr-cursor-mmap-cpu
[169.792945] Starting dynamic subtest: eDP-1
[171.559112] Dynamic subtest eDP-1: SUCCESS (1.768s)
[171.561444] Subtest psr-cursor-mmap-cpu: SUCCESS (1.769s)
[172.411886] [028/133] (846s left) gem_exec_whisper (basic-contexts-priority-all)
[172.479559] Starting subtest: basic-contexts-priority-all
[195.344362] Subtest basic-contexts-priority-all: SUCCESS (22.809s)
[195.473354] [029/133] (823s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[195.528582] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[195.600139] [030/133] (823s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[195.720518] Starting subtest: cursorB-vs-flipA-atomic-transitions
[195.724772] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[195.860192] [031/133] (823s left) gem_exec_params (rel-constants-invalid)
[195.913532] Starting subtest: rel-constants-invalid
[195.915764] Subtest rel-constants-invalid: SUCCESS (0.000s)
[196.002183] [032/133] (823s left) kms_joiner (invalid-modeset-ultra-joiner)
[196.106503] Starting subtest: invalid-modeset-ultra-joiner
[196.110723] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[196.170451] [033/133] (823s left) syncobj_wait (invalid-signal-bad-pad)
[196.219026] Starting subtest: invalid-signal-bad-pad
[196.221147] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[196.319276] [034/133] (822s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[196.408948] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[196.420318] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[196.506381] [035/133] (822s left) gem_eio (in-flight-contexts-1us)
[196.709146] Starting subtest: in-flight-contexts-1us
[208.593015] Subtest in-flight-contexts-1us: SUCCESS (11.882s)
[208.771592] [036/133] (810s left) kms_pm_lpsp (kms-lpsp)
[209.881054] Starting subtest: kms-lpsp
[209.883399] Starting dynamic subtest: pipe-A-eDP-1
[210.058131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.178s)
[210.362924] Subtest kms-lpsp: SUCCESS (0.483s)
[211.151556] [037/133] (808s left) i915_drm_fdinfo (busy-check-all)
[211.191221] Starting subtest: busy-check-all
[211.193609] Starting dynamic subtest: rcs0
[211.198515] Dynamic subtest rcs0: SKIP (0.004s)
[211.208583] Starting dynamic subtest: bcs0
[211.212768] Dynamic subtest bcs0: SKIP (0.000s)
[211.224117] Starting dynamic subtest: vcs0
[211.228607] Dynamic subtest vcs0: SKIP (0.000s)
[211.237157] Starting dynamic subtest: vcs1
[211.241693] Dynamic subtest vcs1: SKIP (0.000s)
[211.250534] Starting dynamic subtest: vecs0
[211.254832] Dynamic subtest vecs0: SKIP (0.000s)
[211.263501] Starting dynamic subtest: ccs0
[211.268120] Dynamic subtest ccs0: SKIP (0.000s)
[211.272690] Subtest busy-check-all: SKIP (0.008s)
[211.311573] [038/133] (808s left) drm_read (fault-buffer)
[211.477508] Starting subtest: fault-buffer
[211.479889] Subtest fault-buffer: SUCCESS (0.000s)
[211.604150] [039/133] (807s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[211.715340] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[212.862832] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.149s)
[212.988311] [040/133] (806s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[213.072822] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[213.074571] Starting dynamic subtest: pipe-A-eDP-1
[213.912128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.827s)
[213.923133] Starting dynamic subtest: pipe-B-eDP-1
[215.475410] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.566s)
[215.485112] Starting dynamic subtest: pipe-C-eDP-1
[216.959682] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[216.969384] Starting dynamic subtest: pipe-D-eDP-1
[218.402846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.443s)
[218.405299] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.322s)
[219.582624] [041/133] (799s left) gem_ctx_shared (create-shared-gtt)
[219.647447] Starting subtest: create-shared-gtt
[221.862328] Subtest create-shared-gtt: SUCCESS (2.153s)
[222.431791] [042/133] (797s left) gem_sync (basic-store-each)
[222.524116] Starting subtest: basic-store-each
[225.143022] Subtest basic-store-each: SUCCESS (2.629s)
[225.323100] [043/133] (794s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[225.418536] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[225.420704] Starting dynamic subtest: A-eDP1
[234.331026] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[234.343535] Starting dynamic subtest: B-eDP1
[243.260533] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[243.272709] Starting dynamic subtest: C-eDP1
[252.235617] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[252.245648] Starting dynamic subtest: D-eDP1
[261.083098] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[261.085620] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.615s)
[262.269429] [044/133] (757s left) i915_pm_freq_api (freq-basic-api)
[262.332812] Starting subtest: freq-basic-api
[262.335072] Starting dynamic subtest: gt0
[262.337417] Dynamic subtest gt0: SUCCESS (0.002s)
[262.348251] Starting dynamic subtest: gt1
[262.350118] Dynamic subtest gt1: SUCCESS (0.002s)
[262.352388] Subtest freq-basic-api: SUCCESS (0.006s)
[262.406972] [045/133] (757s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[262.488652] Starting subtest: plane-use-after-nonblocking-unbind
[262.490964] Starting dynamic subtest: pipe-A-eDP-1
[262.547940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[262.865112] Starting dynamic subtest: pipe-B-eDP-1
[263.669554] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.812s)
[263.961953] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.473s)
[264.835981] [046/133] (754s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[264.933943] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[264.937922] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[265.035319] [047/133] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[265.135187] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[265.139284] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.231644] [048/133] (754s left) kms_getfb (getfb2-handle-closed)
[265.313828] Starting subtest: getfb2-handle-closed
[265.315692] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[265.407042] [049/133] (754s left) kms_psr (fbc-pr-no-drrs)
[265.499512] Starting subtest: fbc-pr-no-drrs
[265.503685] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[265.567243] [050/133] (754s left) drm_read (short-buffer-nonblock)
[265.707732] Starting subtest: short-buffer-nonblock
[265.710136] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[265.832262] [051/133] (754s left) gen9_exec_parse (bb-secure)
[265.889399] Subtest bb-secure: SKIP (0.000s)
[265.961017] [052/133] (754s left) kms_psr (fbc-pr-sprite-render)
[266.048894] Starting subtest: fbc-pr-sprite-render
[266.052380] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[266.121380] [053/133] (753s left) kms_big_fb (linear-64bpp-rotate-0)
[266.222978] Starting subtest: linear-64bpp-rotate-0
[267.846057] Subtest linear-64bpp-rotate-0: SUCCESS (1.623s)
[267.998191] [054/133] (752s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[268.099192] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[268.103565] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[268.171349] [055/133] (751s left) gem_exec_balancer (full)
[268.236584] Starting subtest: full
[272.553102] Subtest full: SUCCESS (4.318s)
[272.866529] [056/133] (747s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[272.959291] Starting subtest: plane-upscale-20x20-with-pixel-format
[272.961565] Starting dynamic subtest: pipe-A
[274.007519] Dynamic subtest pipe-A: SUCCESS (1.050s)
[274.017878] Starting dynamic subtest: pipe-B
[276.157632] Dynamic subtest pipe-B: SUCCESS (2.150s)
[276.166743] Starting dynamic subtest: pipe-C
[277.353151] Dynamic subtest pipe-C: SUCCESS (1.194s)
[277.364822] Starting dynamic subtest: pipe-D
[278.582019] Dynamic subtest pipe-D: SUCCESS (1.225s)
[278.584570] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.623s)
[279.773325] [057/133] (740s left) kms_flip (modeset-vs-vblank-race-interruptible)
[279.874858] Starting subtest: modeset-vs-vblank-race-interruptible
[279.877302] Starting dynamic subtest: A-eDP1
[284.598970] Dynamic subtest A-eDP1: SUCCESS (4.723s)
[284.617422] Starting dynamic subtest: B-eDP1
[289.262223] Dynamic subtest B-eDP1: SUCCESS (4.660s)
[289.274545] Starting dynamic subtest: C-eDP1
[293.880677] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[293.892355] Starting dynamic subtest: D-eDP1
[298.512556] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[298.518120] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.641s)
[299.674555] [058/133] (720s left) i915_pm_rps (engine-order)
[299.738811] Starting subtest: engine-order
[304.955363] Subtest engine-order: SUCCESS (5.213s)
[305.077000] [059/133] (715s left) kms_plane_cursor (overlay)
[305.167813] Starting subtest: overlay
[305.172149] Starting dynamic subtest: pipe-A-eDP-1-size-64
[307.667751] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.500s)
[307.730341] Starting dynamic subtest: pipe-A-eDP-1-size-128
[310.156928] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[310.216550] Starting dynamic subtest: pipe-A-eDP-1-size-256
[312.660443] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.451s)
[313.009261] Starting dynamic subtest: pipe-B-eDP-1-size-64
[316.128916] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.130s)
[316.189500] Starting dynamic subtest: pipe-B-eDP-1-size-128
[318.651623] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[318.712996] Starting dynamic subtest: pipe-B-eDP-1-size-256
[321.154710] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.451s)
[321.502940] Starting dynamic subtest: pipe-C-eDP-1-size-64
[324.274567] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.783s)
[324.312491] Starting dynamic subtest: pipe-C-eDP-1-size-128
[326.463930] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s)
[326.501950] Starting dynamic subtest: pipe-C-eDP-1-size-256
[328.563595] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.070s)
[328.898230] Starting dynamic subtest: pipe-D-eDP-1-size-64
[331.691218] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.805s)
[331.729967] Starting dynamic subtest: pipe-D-eDP-1-size-128
[333.769152] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.047s)
[333.807571] Starting dynamic subtest: pipe-D-eDP-1-size-256
[335.858494] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s)
[336.182866] Subtest overlay: SUCCESS (31.014s)
[336.980865] [060/133] (683s left) kms_sequence (queue-busy)
[337.080773] Starting subtest: queue-busy
[337.082994] Starting dynamic subtest: pipe-A-eDP-1
[339.023783] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[339.033619] Starting dynamic subtest: pipe-B-eDP-1
[341.589335] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.564s)
[341.600428] Starting dynamic subtest: pipe-C-eDP-1
[344.218939] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[344.230810] Starting dynamic subtest: pipe-D-eDP-1
[346.775299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[346.777564] Subtest queue-busy: SUCCESS (9.692s)
[347.571209] [061/133] (672s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[347.682594] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[347.684461] Starting dynamic subtest: A-eDP1
[351.310227] Dynamic subtest A-eDP1: SUCCESS (3.628s)
[351.321505] Starting dynamic subtest: B-eDP1
[354.505964] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[354.516123] Starting dynamic subtest: C-eDP1
[357.624854] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[357.634422] Starting dynamic subtest: D-eDP1
[360.755244] Dynamic subtest D-eDP1: SUCCESS (3.130s)
[360.757512] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.077s)
[361.549623] [062/133] (658s left) gem_flink_basic (double-flink)
[361.608429] Starting subtest: double-flink
[361.610849] Subtest double-flink: SUCCESS (0.000s)
[361.716173] [063/133] (658s left) gem_ctx_isolation (dirty-switch)
[361.772454] Starting subtest: dirty-switch
[361.774746] Starting dynamic subtest: rcs0
[361.972987] Dynamic subtest rcs0: SUCCESS (0.200s)
[361.983168] Starting dynamic subtest: bcs0
[362.174816] Dynamic subtest bcs0: SUCCESS (0.201s)
[362.186205] Starting dynamic subtest: vcs0
[362.402985] Dynamic subtest vcs0: SUCCESS (0.227s)
[362.413066] Starting dynamic subtest: vcs1
[363.749126] Dynamic subtest vcs1: SUCCESS (1.345s)
[363.759153] Starting dynamic subtest: vecs0
[365.750114] Dynamic subtest vecs0: SUCCESS (2.000s)
[365.761186] Starting dynamic subtest: ccs0
[367.874183] Dynamic subtest ccs0: SUCCESS (2.123s)
[367.876639] Subtest dirty-switch: SUCCESS (6.102s)
[368.106933] [064/133] (652s left) kms_cursor_edge_walk (64x64-top-edge)
[368.207193] Starting subtest: 64x64-top-edge
[368.209337] Starting dynamic subtest: pipe-A-eDP-1
[371.625408] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.417s)
[371.638375] Starting dynamic subtest: pipe-D-eDP-1
[374.762685] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[374.764980] Subtest 64x64-top-edge: SUCCESS (6.557s)
[375.564572] [065/133] (644s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[375.661247] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[375.663552] Starting dynamic subtest: pipe-A-eDP-1
[375.687176] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[375.698615] Starting dynamic subtest: pipe-B-eDP-1
[375.721657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[375.730905] Starting dynamic subtest: pipe-C-eDP-1
[375.755517] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[375.766455] Starting dynamic subtest: pipe-D-eDP-1
[375.790236] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[375.794300] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[377.972393] [066/133] (642s left) gem_eio (hibernate)
[378.207039] Starting subtest: hibernate
[392.934952] Subtest hibernate: SUCCESS (14.726s)
[401.114960] [067/133] (627s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[401.245068] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[401.256174] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[401.335371] [068/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[401.426304] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[401.430542] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.513909] [069/133] (627s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[401.612179] Starting subtest: extended-modeset-hang-newfb-with-reset
[401.614208] Starting dynamic subtest: pipe-A
[415.632578] Dynamic subtest pipe-A: SUCCESS (14.019s)
[415.643189] Starting dynamic subtest: pipe-D
[431.633529] Dynamic subtest pipe-D: SUCCESS (15.997s)
[431.635712] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.021s)
[432.433719] [070/133] (596s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[432.548679] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[432.553198] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[432.632647] [071/133] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[432.736361] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[436.479301] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.747s)
[437.638288] [072/133] (591s left) sysfs_preempt_timeout (invalid)
[437.696317] Starting subtest: invalid
[437.698748] Starting dynamic subtest: vecs0
[437.701194] Dynamic subtest vecs0: SUCCESS (0.000s)
[437.713144] Starting dynamic subtest: ccs0
[437.715039] Dynamic subtest ccs0: SUCCESS (0.000s)
[437.725031] Starting dynamic subtest: vcs0
[437.727530] Dynamic subtest vcs0: SUCCESS (0.000s)
[437.738945] Starting dynamic subtest: bcs0
[437.741262] Dynamic subtest bcs0: SUCCESS (0.000s)
[437.750319] Starting dynamic subtest: rcs0
[437.752713] Dynamic subtest rcs0: SUCCESS (0.000s)
[437.762220] Starting dynamic subtest: vcs1
[437.764646] Dynamic subtest vcs1: SUCCESS (0.000s)
[437.767015] Subtest invalid: SUCCESS (0.005s)
[437.805453] [073/133] (591s left) gem_exec_big (single)
[437.882010] Starting subtest: single
[442.675906] Subtest single: SUCCESS (4.795s)
[442.955946] [074/133] (586s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[443.097384] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[443.099604] Starting dynamic subtest: pipe-A-eDP-1
[443.156575] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[443.168543] Starting dynamic subtest: pipe-B-eDP-1
[443.225316] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[443.238052] Starting dynamic subtest: pipe-C-eDP-1
[443.296237] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[443.307020] Starting dynamic subtest: pipe-D-eDP-1
[443.363820] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[443.368057] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[445.382326] [075/133] (583s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[445.493736] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[446.561296] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s)
[446.676030] [076/133] (582s left) kms_chamelium_hpd (dp-hpd-storm)
[447.068087] Subtest dp-hpd-storm: SKIP (0.000s)
[447.893158] [077/133] (581s left) i915_query (query-topology-kernel-writes)
[447.953247] Starting subtest: query-topology-kernel-writes
[447.955691] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[448.038147] [078/133] (581s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[448.127656] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[448.131699] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[448.200292] [079/133] (581s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[448.258153] Starting subtest: invalid-bsd2-flag-on-blt
[448.260556] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[448.369541] [080/133] (580s left) sw_sync (sync_busy_fork)
[448.416751] Starting subtest: sync_busy_fork
[449.428762] Subtest sync_busy_fork: SUCCESS (1.010s)
[449.488674] [081/133] (579s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[449.537941] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[449.540231] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[449.634401] [082/133] (579s left) kms_chamelium_frames (hdmi-crc-fast)
[450.019253] Subtest hdmi-crc-fast: SKIP (0.000s)
[450.831105] [083/133] (578s left) gem_flink_basic (flink-lifetime)
[450.879203] Starting subtest: flink-lifetime
[450.881630] Subtest flink-lifetime: SUCCESS (0.002s)
[450.974136] [084/133] (578s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[451.062785] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[451.066774] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[451.155253] [085/133] (578s left) kms_prop_blob (basic)
[451.209953] Starting subtest: basic
[451.212224] Subtest basic: SUCCESS (0.000s)
[451.301375] [086/133] (578s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[451.350193] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[451.453700] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[451.529274] [087/133] (578s left) perf (blocking-parameterized)
[451.684443] Starting subtest: blocking-parameterized
[471.763505] Subtest blocking-parameterized: SUCCESS (20.021s)
[471.802508] [088/133] (557s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[471.873663] Starting subtest: etime-multi-wait-all-submitted-signaled
[471.981744] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[472.064454] [089/133] (557s left) gem_exec_fence (submit-chain)
[472.248676] Starting subtest: submit-chain
[472.280741] Subtest submit-chain: SUCCESS (0.032s)
[473.687645] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[473.690807] [090/133] (555s left) gem_exec_params (mmapped)
[473.750354] Starting subtest: mmapped
[473.755868] Subtest mmapped: SUCCESS (0.004s)
[473.883744] [091/133] (555s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[473.989095] Starting subtest: x-tiled-32bpp-rotate-180
[475.479286] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.490s)
[475.615546] [092/133] (554s left) sw_sync (sync_expired_merge)
[475.660478] Starting subtest: sync_expired_merge
[476.734041] Subtest sync_expired_merge: SUCCESS (1.074s)
[476.798180] [093/133] (553s left) prime_vgem (basic-fence-mmap)
[476.887105] Starting subtest: basic-fence-mmap
[476.892067] Subtest basic-fence-mmap: SKIP (0.000s)
[476.991677] [094/133] (552s left) gem_ctx_shared (disjoint-timelines)
[477.060056] Starting subtest: disjoint-timelines
[477.078583] Subtest disjoint-timelines: SUCCESS (0.018s)
[477.329255] [095/133] (552s left) kms_psr (psr-dpms)
[477.423098] Starting subtest: psr-dpms
[477.425431] Starting dynamic subtest: eDP-1
[480.384215] Dynamic subtest eDP-1: SUCCESS (2.963s)
[480.386644] Subtest psr-dpms: SUCCESS (2.964s)
[481.264031] [096/133] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[481.363279] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[488.652018] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.293s)
[488.789420] [097/133] (541s left) gem_softpin (allocator-nopin)
[488.844650] Starting subtest: allocator-nopin
[488.929724] Subtest allocator-nopin: SUCCESS (0.084s)
[489.040363] [098/133] (540s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[489.128711] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[489.131053] Starting dynamic subtest: pipe-A-default-mode
[490.320185] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[490.324980] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.191s)
[490.491219] [099/133] (539s left) gem_exec_flush (basic-wb-pro-default)
[490.556577] Starting subtest: basic-wb-pro-default
[496.054867] Subtest basic-wb-pro-default: SUCCESS (5.460s)
[496.217477] [100/133] (533s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[496.333341] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[496.335778] Starting dynamic subtest: pipe-A-eDP-1
[496.423575] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s)
[496.435619] Starting dynamic subtest: pipe-B-eDP-1
[497.569876] Dynamic subtest pipe-B-eDP-1: SKIP (1.144s)
[497.574350] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.237s)
[498.759374] [101/133] (531s left) syncobj_timeline (single-wait-available-submitted)
[498.820033] Starting subtest: single-wait-available-submitted
[498.822259] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[498.924942] [102/133] (531s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[498.978375] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[498.982526] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[499.156512] [103/133] (531s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[499.243652] Starting subtest: psr-rgb101010-draw-pwrite
[506.994722] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.755s)
[507.106181] [104/133] (523s left) perf (gen8-unprivileged-single-ctx-counters)
[507.195754] Starting subtest: gen8-unprivileged-single-ctx-counters
[507.200029] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[507.239706] [105/133] (523s left) api_intel_allocator (standalone)
[507.295784] Starting subtest: standalone
[507.312313] Subtest standalone: SUCCESS (0.019s)
[507.431287] [106/133] (522s left) kms_getfb (getfb-handle-closed)
[507.525572] Starting subtest: getfb-handle-closed
[507.527769] Subtest getfb-handle-closed: SUCCESS (0.000s)
[507.630407] [107/133] (522s left) perf (mi-rpc)
[507.712024] Starting subtest: mi-rpc
[507.716297] Subtest mi-rpc: SKIP (0.000s)
[507.759405] [108/133] (522s left) kms_async_flips (async-flip-dpms)
[507.860509] Starting subtest: async-flip-dpms
[508.250078] Starting dynamic subtest: pipe-A-eDP-1
[512.156239] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.904s)
[512.522536] Starting dynamic subtest: pipe-B-eDP-1
[515.317602] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s)
[515.708400] Starting dynamic subtest: pipe-C-eDP-1
[518.482520] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.781s)
[518.861963] Starting dynamic subtest: pipe-D-eDP-1
[521.648140] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[521.650561] Subtest async-flip-dpms: SUCCESS (13.787s)
[522.829235] [109/133] (507s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[522.924917] Starting subtest: y-tiled-64bpp-rotate-180
[522.929407] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[523.022008] [110/133] (507s left) gem_close_race (multigpu-basic-process)
[523.079065] Starting subtest: multigpu-basic-process
[523.083663] Subtest multigpu-basic-process: SKIP (0.000s)
[523.301359] [111/133] (507s left) kms_cursor_crc (cursor-offscreen-32x10)
[523.473688] Starting subtest: cursor-offscreen-32x10
[523.517198] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[523.778992] [112/133] (506s left) gem_exec_flush (basic-wb-rw-default)
[523.850142] Starting subtest: basic-wb-rw-default
[529.337100] Subtest basic-wb-rw-default: SUCCESS (5.473s)
[529.511266] [113/133] (501s left) dmabuf_sync_file (export-before-signal)
[529.550830] Starting subtest: export-before-signal
[529.552877] Subtest export-before-signal: SUCCESS (0.001s)
[529.607914] [114/133] (501s left) gem_exec_schedule (preempt-queue-contexts-chain)
[529.695801] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[529.986951] [115/133] (500s left) perf_pmu (semaphore-wait)
[530.026144] Starting subtest: semaphore-wait
[530.028432] Starting dynamic subtest: rcs0
[530.543281] Dynamic subtest rcs0: SUCCESS (0.516s)
[530.558541] Starting dynamic subtest: bcs0
[531.060251] Dynamic subtest bcs0: SUCCESS (0.514s)
[531.073738] Starting dynamic subtest: vcs0
[531.578107] Dynamic subtest vcs0: SUCCESS (0.513s)
[531.590974] Starting dynamic subtest: vcs1
[532.092730] Dynamic subtest vcs1: SUCCESS (0.514s)
[532.106024] Starting dynamic subtest: vecs0
[532.607216] Dynamic subtest vecs0: SUCCESS (0.511s)
[532.621162] Starting dynamic subtest: ccs0
[533.123967] Dynamic subtest ccs0: SUCCESS (0.514s)
[533.126710] Subtest semaphore-wait: SUCCESS (3.099s)
[534.596366] [116/133] (496s left) gem_basic (multigpu-create-close)
[534.647636] Starting subtest: multigpu-create-close
[534.652019] Subtest multigpu-create-close: SKIP (0.000s)
[534.734386] [117/133] (496s left) kms_vblank (query-idle)
[534.846520] Starting subtest: query-idle
[534.848323] Starting dynamic subtest: pipe-A-eDP-1
[536.601128] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[536.617910] Starting dynamic subtest: pipe-D-eDP-1
[539.069207] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.467s)
[539.071676] Subtest query-idle: SUCCESS (4.224s)
[539.912629] [118/133] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[540.020715] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[540.025336] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[540.124327] [119/133] (490s left) syncobj_timeline (reset-during-wait-for-submit)
[540.176340] Starting subtest: reset-during-wait-for-submit
[540.278417] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[540.357429] [120/133] (490s left) i915_suspend (basic-s3-without-i915)
[540.397817] Starting subtest: basic-s3-without-i915
[542.140856] Subtest basic-s3-without-i915: SKIP (1.738s)
[543.759592] [121/133] (487s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[543.863960] Starting subtest: plane-primary-toggle-with-vblank-wait
[543.866301] Starting dynamic subtest: pipe-A-eDP-1
[544.037331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[544.345524] Starting dynamic subtest: pipe-B-eDP-1
[545.241815] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.906s)
[545.538063] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.676s)
[546.400983] [122/133] (484s left) kms_psr (fbc-psr-primary-blt)
[546.495650] Starting subtest: fbc-psr-primary-blt
[546.497829] Starting dynamic subtest: eDP-1
[546.501697] Dynamic subtest eDP-1: SKIP (0.000s)
[546.505613] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[546.575054] [123/133] (484s left) gem_mmap (bad-offset)
[546.633403] Subtest bad-offset: SKIP (0.000s)
[546.690878] [124/133] (484s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[546.779864] Starting subtest: yf-tiled-8bpp-rotate-0
[546.784207] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[546.881659] [125/133] (484s left) gem_exec_flush (basic-batch-kernel-default-wb)
[546.944525] Starting subtest: basic-batch-kernel-default-wb
[554.415190] Subtest basic-batch-kernel-default-wb: SUCCESS (7.472s)
[554.617223] [126/133] (476s left) perf (invalid-oa-format-id)
[554.745273] Starting subtest: invalid-oa-format-id
[554.757105] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[554.804539] [127/133] (476s left) kms_async_flips (test-time-stamp)
[554.908983] Starting subtest: test-time-stamp
[555.280390] Starting dynamic subtest: pipe-A-eDP-1
[556.099831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[556.472310] Starting dynamic subtest: pipe-B-eDP-1
[557.233426] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[557.621820] Starting dynamic subtest: pipe-C-eDP-1
[558.377226] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[558.742455] Starting dynamic subtest: pipe-D-eDP-1
[559.504563] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[559.507051] Subtest test-time-stamp: SUCCESS (4.595s)
[560.666439] [128/133] (470s left) kms_content_protection (legacy-hdcp14)
[560.808691] Starting subtest: legacy-hdcp14
[560.813241] Subtest legacy-hdcp14: SKIP (0.000s)
[560.940836] [129/133] (470s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[561.035763] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[561.038076] Starting dynamic subtest: pipe-A-eDP-1
[576.947736] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s)
[576.958214] Starting dynamic subtest: pipe-B-eDP-1
[593.933130] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.449s)
[593.943380] Starting dynamic subtest: pipe-C-eDP-1
[610.906019] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[610.916808] Starting dynamic subtest: pipe-D-eDP-1
[627.875770] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.468s)
[627.877702] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.789s)
[629.121690] [130/133] (402s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[629.229340] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[635.900681] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.659s)
[636.013811] [131/133] (395s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[636.347920] Starting subtest: cursor-rapid-movement-max-size
[636.354446] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[636.482121] [132/133] (394s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[636.578361] Starting subtest: fbcpsr-suspend
[677.357042] Subtest fbcpsr-suspend: SUCCESS (9.999s)
[677.472043] [133/133] (353s left) api_intel_bb (reset-flags)
[677.541961] Starting subtest: reset-flags
[677.549963] Subtest reset-flags: SUCCESS (0.011s)
[677.657581] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_invalid_mode
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_pipe_b_c_ivb
results: parsing output: 15/ for test: gem_vm_create
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_feature_discovery
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_color_pipeline
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_joiner
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_pm_lpsp
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: drm_read
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_ctx_shared
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: i915_pm_freq_api
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_getfb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: drm_read
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: i915_pm_rps
results: parsing output: 58/ for test: kms_plane_cursor
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_flink_basic
results: parsing output: 62/ for test: gem_ctx_isolation
results: parsing output: 63/ for test: kms_cursor_edge_walk
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: sysfs_preempt_timeout
results: parsing output: 72/ for test: gem_exec_big
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gem_flink_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_prop_blob
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: sw_sync
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_exec_flush
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: i915_suspend
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_mmap
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_content_protection
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: api_intel_bb
Done.