[57.609727] Initializing watchdogs
[57.609775]   /dev/watchdog0
[57.627387] [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.632513] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.634882] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.638451] [001/133] (960s left) gem_softpin (noreloc-s3)
[57.730863] Starting subtest: noreloc-S3
[78.246095] Subtest noreloc-S3: SUCCESS (5.406s)
[78.372370] [002/133] (939s left) perf_pmu (gt-awake)
[78.426418] Starting subtest: gt-awake
[86.920163] Subtest gt-awake: SUCCESS (8.368s)
[86.993798] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[87.102418] Starting subtest: zero-hdisplay
[87.104722] Starting dynamic subtest: pipe-A-eDP-1
[87.388281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[87.398217] Starting dynamic subtest: pipe-B-eDP-1
[87.400378] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.407863] Starting dynamic subtest: pipe-C-eDP-1
[87.410365] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[87.418270] Starting dynamic subtest: pipe-D-eDP-1
[87.420630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[87.422986] Subtest zero-hdisplay: SUCCESS (0.291s)
[88.277195] [004/133] (929s left) kms_prop_blob (invalid-set-prop-any)
[88.336440] Starting subtest: invalid-set-prop-any
[88.338912] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[88.424374] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[88.515430] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[96.092099] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.552s)
[96.238301] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[96.339935] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[96.344449] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[96.428020] [007/133] (921s left) kms_cursor_legacy (torture-move)
[96.560809] Starting subtest: torture-move
[96.563171] Starting dynamic subtest: pipe-A
[102.275756] Dynamic subtest pipe-A: SUCCESS (5.702s)
[102.291369] Starting dynamic subtest: pipe-B
[108.245688] Dynamic subtest pipe-B: SUCCESS (5.965s)
[108.256147] Starting dynamic subtest: pipe-C
[114.424234] Dynamic subtest pipe-C: SUCCESS (6.178s)
[114.434966] Starting dynamic subtest: pipe-D
[121.686036] Dynamic subtest pipe-D: SUCCESS (7.260s)
[121.697288] Starting dynamic subtest: all-pipes
[127.862605] Dynamic subtest all-pipes: SUCCESS (6.176s)
[127.864907] Subtest torture-move: SUCCESS (31.285s)
[128.020521] [008/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[128.121944] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[131.739475] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.620s)
[132.948190] [009/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[133.058972] Starting subtest: fbc-rgb101010-draw-blt
[137.657796] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.600s)
[138.864824] [010/133] (879s left) gem_pxp (create-regular-context-2)
[138.986785] Starting subtest: create-regular-context-2
[138.989473] Subtest create-regular-context-2: SUCCESS (0.002s)
[139.090102] [011/133] (879s left) kms_flip (2x-flip-vs-panning-interruptible)
[139.189047] Starting subtest: 2x-flip-vs-panning-interruptible
[139.201764] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[139.274992] [012/133] (879s left) kms_plane_alpha_blend (constant-alpha-max)
[139.376912] Starting subtest: constant-alpha-max
[139.667238] Starting dynamic subtest: pipe-A-eDP-1
[140.743910] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.075s)
[140.757361] Starting dynamic subtest: pipe-D-eDP-1
[142.397770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.652s)
[142.400155] Subtest constant-alpha-max: SUCCESS (3.021s)
[143.218105] [013/133] (875s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[143.319205] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[143.345084] Starting dynamic subtest: pipe-A-plane-0
[143.633519] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[143.642006] Starting dynamic subtest: pipe-A-plane-3
[143.867134] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[143.875795] Starting dynamic subtest: pipe-A-plane-5
[143.879921] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[145.011665] Starting dynamic subtest: pipe-B-plane-0
[145.302122] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[145.313210] Starting dynamic subtest: pipe-B-plane-3
[145.536415] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[145.547133] Starting dynamic subtest: pipe-B-plane-5
[145.551713] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[145.861685] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.540s)
[146.709212] [014/133] (871s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[146.776618] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[146.839297] [015/133] (871s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[146.897533] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[146.959789] [016/133] (871s left) gem_vm_create (invalid-destroy)
[147.009013] Starting subtest: invalid-destroy
[147.011246] Subtest invalid-destroy: SUCCESS (0.002s)
[147.102945] [017/133] (871s left) gem_lmem_swapping (heavy-verify-random-ccs)
[147.144434] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[147.191060] [018/133] (871s left) kms_feature_discovery (display-2x)
[147.290816] Starting subtest: display-2x
[147.294859] Subtest display-2x: SKIP (0.000s)
[147.361511] [019/133] (871s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[147.457243] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[147.459520] Starting dynamic subtest: pipe-A-eDP-1
[147.482515] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.493309] Starting dynamic subtest: pipe-B-eDP-1
[147.514028] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.522316] Starting dynamic subtest: pipe-C-eDP-1
[147.543021] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.551496] Starting dynamic subtest: pipe-D-eDP-1
[147.572469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.576760] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[149.776425] [020/133] (869s left) gem_mmap_offset (blt-coherency)
[149.838059] Starting subtest: blt-coherency
[149.844447] Subtest blt-coherency: SUCCESS (0.007s)
[149.970748] [021/133] (868s left) gem_pxp (hw-rejects-pxp-context)
[150.038778] Starting subtest: hw-rejects-pxp-context
[150.043311] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[150.131586] [022/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[150.236592] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[156.864301] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.629s)
[156.975461] [023/133] (862s left) kms_psr (pr-sprite-mmap-gtt)
[157.082244] Starting subtest: pr-sprite-mmap-gtt
[157.086676] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[157.153445] [024/133] (861s left) gem_exec_reloc (basic-write-gtt-noreloc)
[157.206204] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[157.280288] [025/133] (861s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[157.373421] Starting subtest: plane-lut1d-ctm3x4
[157.522560] Starting dynamic subtest: pipe-A-plane-0
[157.688575] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[157.698043] Starting dynamic subtest: pipe-A-plane-1
[157.866037] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[157.875689] Starting dynamic subtest: pipe-A-plane-2
[158.066085] Dynamic subtest pipe-A-plane-2: SUCCESS (0.199s)
[159.253981] Starting dynamic subtest: pipe-B-plane-0
[159.412974] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[159.423803] Starting dynamic subtest: pipe-B-plane-1
[159.591140] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[159.600945] Starting dynamic subtest: pipe-B-plane-2
[159.758085] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[160.947017] Starting dynamic subtest: pipe-C-plane-0
[161.084194] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[161.093840] Starting dynamic subtest: pipe-C-plane-1
[161.228669] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[161.238352] Starting dynamic subtest: pipe-C-plane-2
[161.372862] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[162.576669] Starting dynamic subtest: pipe-D-plane-0
[162.713623] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[162.722397] Starting dynamic subtest: pipe-D-plane-1
[162.858045] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[162.867477] Starting dynamic subtest: pipe-D-plane-2
[163.002399] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[163.288383] Subtest plane-lut1d-ctm3x4: SUCCESS (5.912s)
[164.155656] [026/133] (854s left) gem_exec_schedule (preempt-hang)
[164.325715] Starting subtest: preempt-hang
[164.328803] Starting dynamic subtest: rcs0
[164.565379] Dynamic subtest rcs0: SUCCESS (0.239s)
[164.574699] Starting dynamic subtest: bcs0
[164.799893] Dynamic subtest bcs0: SUCCESS (0.234s)
[164.810829] Starting dynamic subtest: vcs0
[165.029153] Dynamic subtest vcs0: SUCCESS (0.229s)
[165.040420] Starting dynamic subtest: vcs1
[165.256777] Dynamic subtest vcs1: SUCCESS (0.226s)
[165.268811] Starting dynamic subtest: vecs0
[165.488074] Dynamic subtest vecs0: SUCCESS (0.231s)
[165.496521] Starting dynamic subtest: ccs0
[165.720356] Dynamic subtest ccs0: SUCCESS (0.232s)
[165.722738] Subtest preempt-hang: SUCCESS (1.395s)
[166.013730] [027/133] (853s left) kms_psr (psr-cursor-mmap-cpu)
[166.109457] Starting subtest: psr-cursor-mmap-cpu
[166.111782] Starting dynamic subtest: eDP-1
[167.844718] Dynamic subtest eDP-1: SUCCESS (1.735s)
[167.847131] Subtest psr-cursor-mmap-cpu: SUCCESS (1.736s)
[168.710739] [028/133] (850s left) gem_exec_whisper (basic-contexts-priority-all)
[168.779227] Starting subtest: basic-contexts-priority-all
[189.980733] Subtest basic-contexts-priority-all: SUCCESS (21.203s)
[190.162226] [029/133] (829s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[190.217071] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[190.288423] [030/133] (828s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[190.413747] Starting subtest: cursorB-vs-flipA-atomic-transitions
[190.418379] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[190.566488] [031/133] (828s left) gem_exec_params (rel-constants-invalid)
[190.625275] Starting subtest: rel-constants-invalid
[190.627560] Subtest rel-constants-invalid: SUCCESS (0.000s)
[190.750917] [032/133] (828s left) kms_joiner (invalid-modeset-ultra-joiner)
[190.836004] Starting subtest: invalid-modeset-ultra-joiner
[190.840432] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[190.910391] [033/133] (828s left) syncobj_wait (invalid-signal-bad-pad)
[190.969239] Starting subtest: invalid-signal-bad-pad
[190.971541] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[191.062503] [034/133] (828s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[191.154803] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[191.165844] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[191.239185] [035/133] (828s left) gem_eio (in-flight-contexts-1us)
[191.478850] Starting subtest: in-flight-contexts-1us
[202.957145] Subtest in-flight-contexts-1us: SUCCESS (11.479s)
[203.137807] [036/133] (816s left) kms_pm_lpsp (kms-lpsp)
[204.234574] Starting subtest: kms-lpsp
[204.236796] Starting dynamic subtest: pipe-A-eDP-1
[204.414003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[204.726916] Subtest kms-lpsp: SUCCESS (0.492s)
[205.540158] [037/133] (814s left) i915_drm_fdinfo (busy-check-all)
[205.581283] Starting subtest: busy-check-all
[205.583521] Starting dynamic subtest: rcs0
[205.588055] Dynamic subtest rcs0: SKIP (0.004s)
[205.598104] Starting dynamic subtest: bcs0
[205.602225] Dynamic subtest bcs0: SKIP (0.000s)
[205.611588] Starting dynamic subtest: vcs0
[205.615921] Dynamic subtest vcs0: SKIP (0.000s)
[205.625305] Starting dynamic subtest: vcs1
[205.629344] Dynamic subtest vcs1: SKIP (0.000s)
[205.638142] Starting dynamic subtest: vecs0
[205.642062] Dynamic subtest vecs0: SKIP (0.000s)
[205.651239] Starting dynamic subtest: ccs0
[205.655229] Dynamic subtest ccs0: SKIP (0.001s)
[205.659175] Subtest busy-check-all: SKIP (0.012s)
[205.719871] [038/133] (813s left) drm_read (fault-buffer)
[205.896282] Starting subtest: fault-buffer
[205.898682] Subtest fault-buffer: SUCCESS (0.000s)
[206.035907] [039/133] (813s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[206.142278] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[207.287533] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.146s)
[207.409806] [040/133] (812s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[207.503653] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[207.505520] Starting dynamic subtest: pipe-A-eDP-1
[208.383210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s)
[208.395608] Starting dynamic subtest: pipe-B-eDP-1
[210.033138] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s)
[210.043126] Starting dynamic subtest: pipe-C-eDP-1
[211.619631] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.584s)
[211.631544] Starting dynamic subtest: pipe-D-eDP-1
[213.106487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.482s)
[213.108467] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.591s)
[214.265501] [041/133] (805s left) gem_ctx_shared (create-shared-gtt)
[214.320734] Starting subtest: create-shared-gtt
[216.474233] Subtest create-shared-gtt: SUCCESS (2.152s)
[216.793902] [042/133] (803s left) gem_sync (basic-store-each)
[216.874316] Starting subtest: basic-store-each
[219.593702] Subtest basic-store-each: SUCCESS (2.730s)
[219.780411] [043/133] (800s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[219.894631] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[219.897024] Starting dynamic subtest: A-eDP1
[228.813662] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[228.828151] Starting dynamic subtest: B-eDP1
[237.739988] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[237.750377] Starting dynamic subtest: C-eDP1
[246.672425] Dynamic subtest C-eDP1: SUCCESS (8.929s)
[246.683844] Starting dynamic subtest: D-eDP1
[255.596093] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[255.598667] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.697s)
[256.829220] [044/133] (763s left) i915_pm_freq_api (freq-basic-api)
[256.899979] Starting subtest: freq-basic-api
[256.902360] Starting dynamic subtest: gt0
[256.904630] Dynamic subtest gt0: SUCCESS (0.003s)
[256.915220] Starting dynamic subtest: gt1
[256.917427] Dynamic subtest gt1: SUCCESS (0.002s)
[256.919602] Subtest freq-basic-api: SUCCESS (0.007s)
[257.018362] [045/133] (762s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[257.116195] Starting subtest: plane-use-after-nonblocking-unbind
[257.118506] Starting dynamic subtest: pipe-A-eDP-1
[257.178217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[257.486983] Starting dynamic subtest: pipe-B-eDP-1
[258.327771] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.850s)
[258.639624] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.525s)
[259.486234] [046/133] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[259.593072] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[259.597410] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[259.686166] [047/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[259.783721] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[259.787879] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.876494] [048/133] (760s left) kms_getfb (getfb2-handle-closed)
[259.972566] Starting subtest: getfb2-handle-closed
[259.974791] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[260.066414] [049/133] (760s left) kms_psr (fbc-pr-no-drrs)
[260.158337] Starting subtest: fbc-pr-no-drrs
[260.162787] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[260.229777] [050/133] (759s left) drm_read (short-buffer-nonblock)
[260.375105] Starting subtest: short-buffer-nonblock
[260.377354] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[260.501034] [051/133] (759s left) gen9_exec_parse (bb-secure)
[260.562672] Subtest bb-secure: SKIP (0.000s)
[260.620914] [052/133] (759s left) kms_psr (fbc-pr-sprite-render)
[260.706709] Starting subtest: fbc-pr-sprite-render
[260.710320] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[260.780965] [053/133] (759s left) kms_big_fb (linear-64bpp-rotate-0)
[260.885121] Starting subtest: linear-64bpp-rotate-0
[262.464156] Subtest linear-64bpp-rotate-0: SUCCESS (1.578s)
[262.650570] [054/133] (757s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[262.756380] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[262.760381] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[262.833436] [055/133] (757s left) gem_exec_balancer (full)
[262.893494] Starting subtest: full
[267.819869] Subtest full: SUCCESS (4.925s)
[268.145261] [056/133] (752s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[268.239504] Starting subtest: plane-upscale-20x20-with-pixel-format
[268.241911] Starting dynamic subtest: pipe-A
[269.289269] Dynamic subtest pipe-A: SUCCESS (1.049s)
[269.299284] Starting dynamic subtest: pipe-B
[271.386280] Dynamic subtest pipe-B: SUCCESS (2.095s)
[271.395834] Starting dynamic subtest: pipe-C
[272.583413] Dynamic subtest pipe-C: SUCCESS (1.195s)
[272.593665] Starting dynamic subtest: pipe-D
[273.806662] Dynamic subtest pipe-D: SUCCESS (1.221s)
[273.808865] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.567s)
[275.027433] [057/133] (745s left) kms_flip (modeset-vs-vblank-race-interruptible)
[275.121678] Starting subtest: modeset-vs-vblank-race-interruptible
[275.124009] Starting dynamic subtest: A-eDP1
[279.806246] Dynamic subtest A-eDP1: SUCCESS (4.680s)
[279.822519] Starting dynamic subtest: B-eDP1
[284.527846] Dynamic subtest B-eDP1: SUCCESS (4.717s)
[284.539272] Starting dynamic subtest: C-eDP1
[289.140011] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[289.153933] Starting dynamic subtest: D-eDP1
[293.674457] Dynamic subtest D-eDP1: SUCCESS (4.530s)
[293.680433] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.552s)
[294.845171] [058/133] (725s left) i915_pm_rps (engine-order)
[294.924207] Starting subtest: engine-order
[299.948929] Subtest engine-order: SUCCESS (5.021s)
[300.082251] [059/133] (720s left) kms_plane_cursor (overlay)
[300.187199] Starting subtest: overlay
[300.191689] Starting dynamic subtest: pipe-A-eDP-1-size-64
[302.704293] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.519s)
[302.765150] Starting dynamic subtest: pipe-A-eDP-1-size-128
[305.284210] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[305.344400] Starting dynamic subtest: pipe-A-eDP-1-size-256
[307.894842] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s)
[308.259699] Starting dynamic subtest: pipe-B-eDP-1-size-64
[311.654191] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.408s)
[311.715223] Starting dynamic subtest: pipe-B-eDP-1-size-128
[314.253324] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[314.313054] Starting dynamic subtest: pipe-B-eDP-1-size-256
[316.833171] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[317.180515] Starting dynamic subtest: pipe-C-eDP-1-size-64
[320.009413] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.841s)
[320.048321] Starting dynamic subtest: pipe-C-eDP-1-size-128
[322.198066] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.159s)
[322.237957] Starting dynamic subtest: pipe-C-eDP-1-size-256
[324.386379] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[324.718773] Starting dynamic subtest: pipe-D-eDP-1-size-64
[327.686613] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.982s)
[327.725107] Starting dynamic subtest: pipe-D-eDP-1-size-128
[329.875646] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.159s)
[329.914316] Starting dynamic subtest: pipe-D-eDP-1-size-256
[332.041164] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s)
[332.362494] Subtest overlay: SUCCESS (32.182s)
[333.159769] [060/133] (687s left) kms_sequence (queue-busy)
[333.261461] Starting subtest: queue-busy
[333.263456] Starting dynamic subtest: pipe-A-eDP-1
[335.202482] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[335.212991] Starting dynamic subtest: pipe-B-eDP-1
[337.767512] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.566s)
[337.780377] Starting dynamic subtest: pipe-C-eDP-1
[340.367419] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.595s)
[340.377643] Starting dynamic subtest: pipe-D-eDP-1
[342.997110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[342.999462] Subtest queue-busy: SUCCESS (9.739s)
[343.781090] [061/133] (676s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[343.868364] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[343.873246] Starting dynamic subtest: A-eDP1
[347.546565] Dynamic subtest A-eDP1: SUCCESS (3.674s)
[347.559862] Starting dynamic subtest: B-eDP1
[350.825478] Dynamic subtest B-eDP1: SUCCESS (3.277s)
[350.836091] Starting dynamic subtest: C-eDP1
[353.972377] Dynamic subtest C-eDP1: SUCCESS (3.137s)
[353.989879] Starting dynamic subtest: D-eDP1
[357.076227] Dynamic subtest D-eDP1: SUCCESS (3.112s)
[357.078567] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.208s)
[357.874753] [062/133] (662s left) gem_flink_basic (double-flink)
[357.933802] Starting subtest: double-flink
[357.936016] Subtest double-flink: SUCCESS (0.000s)
[358.048107] [063/133] (662s left) gem_ctx_isolation (dirty-switch)
[358.119848] Starting subtest: dirty-switch
[358.122160] Starting dynamic subtest: rcs0
[358.299257] Dynamic subtest rcs0: SUCCESS (0.179s)
[358.311214] Starting dynamic subtest: bcs0
[358.512244] Dynamic subtest bcs0: SUCCESS (0.212s)
[358.522764] Starting dynamic subtest: vcs0
[358.723789] Dynamic subtest vcs0: SUCCESS (0.210s)
[358.733607] Starting dynamic subtest: vcs1
[360.095888] Dynamic subtest vcs1: SUCCESS (1.371s)
[360.107382] Starting dynamic subtest: vecs0
[362.102313] Dynamic subtest vecs0: SUCCESS (2.005s)
[362.114322] Starting dynamic subtest: ccs0
[364.086032] Dynamic subtest ccs0: SUCCESS (1.983s)
[364.088560] Subtest dirty-switch: SUCCESS (5.966s)
[364.326039] [064/133] (656s left) kms_cursor_edge_walk (64x64-top-edge)
[364.424237] Starting subtest: 64x64-top-edge
[364.426556] Starting dynamic subtest: pipe-A-eDP-1
[367.882532] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s)
[367.895216] Starting dynamic subtest: pipe-D-eDP-1
[371.077351] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.193s)
[371.079765] Subtest 64x64-top-edge: SUCCESS (6.654s)
[371.883540] [065/133] (648s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[371.991062] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[371.993349] Starting dynamic subtest: pipe-A-eDP-1
[372.017056] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[372.027763] Starting dynamic subtest: pipe-B-eDP-1
[372.050730] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[372.060539] Starting dynamic subtest: pipe-C-eDP-1
[372.085472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[372.096983] Starting dynamic subtest: pipe-D-eDP-1
[372.122384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[372.126496] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[374.258004] [066/133] (646s left) gem_eio (hibernate)
[374.488095] Starting subtest: hibernate
[389.339638] Subtest hibernate: SUCCESS (14.848s)
[396.475388] [067/133] (631s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[396.605095] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[396.620862] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.014s)
[396.702175] [068/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[396.802209] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[396.806359] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[396.912381] [069/133] (630s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[397.030084] Starting subtest: extended-modeset-hang-newfb-with-reset
[397.032395] Starting dynamic subtest: pipe-A
[411.768342] Dynamic subtest pipe-A: SUCCESS (14.734s)
[411.779113] Starting dynamic subtest: pipe-D
[427.935261] Dynamic subtest pipe-D: SUCCESS (16.162s)
[427.937565] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.901s)
[428.735895] [070/133] (599s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[428.833559] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[428.837375] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[428.903611] [071/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[429.006935] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[432.722914] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.720s)
[433.974274] [072/133] (594s left) sysfs_preempt_timeout (invalid)
[434.039372] Starting subtest: invalid
[434.041701] Starting dynamic subtest: vecs0
[434.043844] Dynamic subtest vecs0: SUCCESS (0.000s)
[434.054419] Starting dynamic subtest: ccs0
[434.056544] Dynamic subtest ccs0: SUCCESS (0.000s)
[434.066518] Starting dynamic subtest: vcs0
[434.068750] Dynamic subtest vcs0: SUCCESS (0.000s)
[434.079034] Starting dynamic subtest: bcs0
[434.081292] Dynamic subtest bcs0: SUCCESS (0.000s)
[434.091353] Starting dynamic subtest: rcs0
[434.093206] Dynamic subtest rcs0: SUCCESS (0.000s)
[434.105152] Starting dynamic subtest: vcs1
[434.107243] Dynamic subtest vcs1: SUCCESS (0.000s)
[434.109347] Subtest invalid: SUCCESS (0.006s)
[434.145677] [073/133] (593s left) gem_exec_big (single)
[434.206942] Starting subtest: single
[439.094691] Subtest single: SUCCESS (4.884s)
[439.354615] [074/133] (588s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[439.488144] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[439.490504] Starting dynamic subtest: pipe-A-eDP-1
[439.549526] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[439.562761] Starting dynamic subtest: pipe-B-eDP-1
[439.619817] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[439.634043] Starting dynamic subtest: pipe-C-eDP-1
[439.692160] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[439.704854] Starting dynamic subtest: pipe-D-eDP-1
[439.762377] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[439.766669] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[441.781279] [075/133] (586s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[441.903028] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[442.992835] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s)
[443.113670] [076/133] (585s left) kms_chamelium_hpd (dp-hpd-storm)
[443.496786] Subtest dp-hpd-storm: SKIP (0.000s)
[444.291437] [077/133] (583s left) i915_query (query-topology-kernel-writes)
[444.357916] Starting subtest: query-topology-kernel-writes
[444.360232] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[444.472614] [078/133] (583s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[444.576016] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[444.580074] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[444.657608] [079/133] (583s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[444.715992] Starting subtest: invalid-bsd2-flag-on-blt
[444.718391] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[444.821573] [080/133] (583s left) sw_sync (sync_busy_fork)
[444.870581] Starting subtest: sync_busy_fork
[445.881162] Subtest sync_busy_fork: SUCCESS (1.011s)
[445.955485] [081/133] (582s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[446.004380] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[446.006661] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[446.092465] [082/133] (582s left) kms_chamelium_frames (hdmi-crc-fast)
[446.471251] Subtest hdmi-crc-fast: SKIP (0.000s)
[447.314385] [083/133] (581s left) gem_flink_basic (flink-lifetime)
[447.368720] Starting subtest: flink-lifetime
[447.371235] Subtest flink-lifetime: SUCCESS (0.004s)
[447.496666] [084/133] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[447.601407] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[447.605356] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[447.686299] [085/133] (580s left) kms_prop_blob (basic)
[447.749440] Starting subtest: basic
[447.751337] Subtest basic: SUCCESS (0.000s)
[447.846989] [086/133] (580s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[447.906216] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[448.010861] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[448.101629] [087/133] (580s left) perf (blocking-parameterized)
[448.241511] Starting subtest: blocking-parameterized
[468.265031] Subtest blocking-parameterized: SUCCESS (20.020s)
[468.315394] [088/133] (560s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[468.368130] Starting subtest: etime-multi-wait-all-submitted-signaled
[468.475535] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[468.570425] [089/133] (560s left) gem_exec_fence (submit-chain)
[468.750047] Starting subtest: submit-chain
[468.777807] Subtest submit-chain: SUCCESS (0.031s)
[470.953348] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[470.957046] [090/133] (557s left) gem_exec_params (mmapped)
[471.014859] Starting subtest: mmapped
[471.020586] Subtest mmapped: SUCCESS (0.004s)
[471.142870] [091/133] (557s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[471.251028] Starting subtest: x-tiled-32bpp-rotate-180
[472.630385] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.380s)
[472.779378] [092/133] (556s left) sw_sync (sync_expired_merge)
[472.814705] Starting subtest: sync_expired_merge
[473.890485] Subtest sync_expired_merge: SUCCESS (1.074s)
[473.960910] [093/133] (555s left) prime_vgem (basic-fence-mmap)
[474.045803] Starting subtest: basic-fence-mmap
[474.050506] Subtest basic-fence-mmap: SKIP (0.000s)
[474.155070] [094/133] (554s left) gem_ctx_shared (disjoint-timelines)
[474.217530] Starting subtest: disjoint-timelines
[474.236612] Subtest disjoint-timelines: SUCCESS (0.019s)
[474.475724] [095/133] (554s left) kms_psr (psr-dpms)
[474.574622] Starting subtest: psr-dpms
[474.576913] Starting dynamic subtest: eDP-1
[477.563531] Dynamic subtest eDP-1: SUCCESS (2.987s)
[477.565454] Subtest psr-dpms: SUCCESS (2.988s)
[478.424979] [096/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[478.529032] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[485.877484] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.350s)
[486.017045] [097/133] (543s left) gem_softpin (allocator-nopin)
[486.073784] Starting subtest: allocator-nopin
[486.160064] Subtest allocator-nopin: SUCCESS (0.085s)
[486.278477] [098/133] (542s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[486.374963] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[486.377243] Starting dynamic subtest: pipe-A-default-mode
[487.509137] Dynamic subtest pipe-A-default-mode: SKIP (1.130s)
[487.513614] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.132s)
[487.652908] [099/133] (541s left) gem_exec_flush (basic-wb-pro-default)
[487.724681] Starting subtest: basic-wb-pro-default
[493.186706] Subtest basic-wb-pro-default: SUCCESS (5.461s)
[493.379938] [100/133] (535s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[493.480507] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[493.482825] Starting dynamic subtest: pipe-A-eDP-1
[493.583464] Dynamic subtest pipe-A-eDP-1: SKIP (0.104s)
[493.594891] Starting dynamic subtest: pipe-B-eDP-1
[494.749473] Dynamic subtest pipe-B-eDP-1: SKIP (1.164s)
[494.753987] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.271s)
[495.942894] [101/133] (533s left) syncobj_timeline (single-wait-available-submitted)
[495.990858] Starting subtest: single-wait-available-submitted
[495.993121] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[496.084400] [102/133] (533s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[496.145326] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[496.149740] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[496.342993] [103/133] (533s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[496.445890] Starting subtest: psr-rgb101010-draw-pwrite
[504.135082] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.691s)
[504.238154] [104/133] (525s left) perf (gen8-unprivileged-single-ctx-counters)
[504.328636] Starting subtest: gen8-unprivileged-single-ctx-counters
[504.333383] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[504.374693] [105/133] (525s left) api_intel_allocator (standalone)
[504.444012] Starting subtest: standalone
[504.457442] Subtest standalone: SUCCESS (0.016s)
[504.568921] [106/133] (524s left) kms_getfb (getfb-handle-closed)
[504.663429] Starting subtest: getfb-handle-closed
[504.665775] Subtest getfb-handle-closed: SUCCESS (0.000s)
[504.775492] [107/133] (524s left) perf (mi-rpc)
[504.866472] Starting subtest: mi-rpc
[504.871162] Subtest mi-rpc: SKIP (0.000s)
[504.914074] [108/133] (524s left) kms_async_flips (async-flip-dpms)
[505.003445] Starting subtest: async-flip-dpms
[505.380927] Starting dynamic subtest: pipe-A-eDP-1
[509.178826] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.795s)
[509.583798] Starting dynamic subtest: pipe-B-eDP-1
[512.341018] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[512.753233] Starting dynamic subtest: pipe-C-eDP-1
[515.518817] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[515.915484] Starting dynamic subtest: pipe-D-eDP-1
[518.706599] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.802s)
[518.708861] Subtest async-flip-dpms: SUCCESS (13.702s)
[519.892199] [109/133] (509s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[520.001076] Starting subtest: y-tiled-64bpp-rotate-180
[520.005493] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[520.106932] [110/133] (509s left) gem_close_race (multigpu-basic-process)
[520.175475] Starting subtest: multigpu-basic-process
[520.179577] Subtest multigpu-basic-process: SKIP (0.000s)
[520.395465] [111/133] (509s left) kms_cursor_crc (cursor-offscreen-32x10)
[520.562646] Starting subtest: cursor-offscreen-32x10
[520.610509] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[520.894995] [112/133] (508s left) gem_exec_flush (basic-wb-rw-default)
[520.957692] Starting subtest: basic-wb-rw-default
[526.433875] Subtest basic-wb-rw-default: SUCCESS (5.475s)
[526.626103] [113/133] (503s left) dmabuf_sync_file (export-before-signal)
[526.673060] Starting subtest: export-before-signal
[526.675353] Subtest export-before-signal: SUCCESS (0.001s)
[526.733598] [114/133] (503s left) gem_exec_schedule (preempt-queue-contexts-chain)
[526.800056] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[527.092739] [115/133] (502s left) perf_pmu (semaphore-wait)
[527.135383] Starting subtest: semaphore-wait
[527.137470] Starting dynamic subtest: rcs0
[527.646687] Dynamic subtest rcs0: SUCCESS (0.513s)
[527.661621] Starting dynamic subtest: bcs0
[528.163751] Dynamic subtest bcs0: SUCCESS (0.512s)
[528.177782] Starting dynamic subtest: vcs0
[528.681250] Dynamic subtest vcs0: SUCCESS (0.514s)
[528.694035] Starting dynamic subtest: vcs1
[529.197646] Dynamic subtest vcs1: SUCCESS (0.512s)
[529.212105] Starting dynamic subtest: vecs0
[529.712850] Dynamic subtest vecs0: SUCCESS (0.513s)
[529.725673] Starting dynamic subtest: ccs0
[530.228852] Dynamic subtest ccs0: SUCCESS (0.513s)
[530.232015] Subtest semaphore-wait: SUCCESS (3.097s)
[530.348640] [116/133] (499s left) gem_basic (multigpu-create-close)
[530.418241] Starting subtest: multigpu-create-close
[530.422693] Subtest multigpu-create-close: SKIP (0.000s)
[530.519210] [117/133] (499s left) kms_vblank (query-idle)
[530.619041] Starting subtest: query-idle
[530.620918] Starting dynamic subtest: pipe-A-eDP-1
[532.375829] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[532.392853] Starting dynamic subtest: pipe-D-eDP-1
[534.840663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s)
[534.842843] Subtest query-idle: SUCCESS (4.221s)
[535.678866] [118/133] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[535.783839] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[535.787908] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[535.898669] [119/133] (494s left) syncobj_timeline (reset-during-wait-for-submit)
[535.951336] Starting subtest: reset-during-wait-for-submit
[536.054214] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[536.134539] [120/133] (493s left) i915_suspend (basic-s3-without-i915)
[536.176076] Starting subtest: basic-s3-without-i915
[540.666796] Subtest basic-s3-without-i915: SKIP (4.490s)
[542.303801] [121/133] (487s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[542.414259] Starting subtest: plane-primary-toggle-with-vblank-wait
[542.416528] Starting dynamic subtest: pipe-A-eDP-1
[542.589581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[542.898554] Starting dynamic subtest: pipe-B-eDP-1
[543.787243] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.898s)
[544.088806] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.674s)
[544.950536] [122/133] (485s left) kms_psr (fbc-psr-primary-blt)
[545.044073] Starting subtest: fbc-psr-primary-blt
[545.046361] Starting dynamic subtest: eDP-1
[545.050650] Dynamic subtest eDP-1: SKIP (0.000s)
[545.054914] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[545.117687] [123/133] (485s left) gem_mmap (bad-offset)
[545.176499] Subtest bad-offset: SKIP (0.000s)
[545.248706] [124/133] (485s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[545.348760] Starting subtest: yf-tiled-8bpp-rotate-0
[545.353061] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[545.458263] [125/133] (484s left) gem_exec_flush (basic-batch-kernel-default-wb)
[545.528372] Starting subtest: basic-batch-kernel-default-wb
[553.217812] Subtest basic-batch-kernel-default-wb: SUCCESS (7.688s)
[553.409267] [126/133] (476s left) perf (invalid-oa-format-id)
[553.538208] Starting subtest: invalid-oa-format-id
[553.551406] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[553.594229] [127/133] (476s left) kms_async_flips (test-time-stamp)
[553.701702] Starting subtest: test-time-stamp
[554.090248] Starting dynamic subtest: pipe-A-eDP-1
[554.840114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[555.222593] Starting dynamic subtest: pipe-B-eDP-1
[555.964051] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[556.341664] Starting dynamic subtest: pipe-C-eDP-1
[557.106331] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[557.480421] Starting dynamic subtest: pipe-D-eDP-1
[558.239277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[558.241615] Subtest test-time-stamp: SUCCESS (4.537s)
[559.399443] [128/133] (471s left) kms_content_protection (legacy-hdcp14)
[559.556119] Starting subtest: legacy-hdcp14
[559.560817] Subtest legacy-hdcp14: SKIP (0.000s)
[559.705152] [129/133] (470s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[559.789500] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[559.791649] Starting dynamic subtest: pipe-A-eDP-1
[576.321553] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.131s)
[576.332285] Starting dynamic subtest: pipe-B-eDP-1
[593.350611] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.360s)
[593.361504] Starting dynamic subtest: pipe-C-eDP-1
[610.307087] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.396s)
[610.321408] Starting dynamic subtest: pipe-D-eDP-1
[627.310149] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.349s)
[627.312868] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.241s)
[628.476026] [130/133] (402s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[628.586661] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[635.418625] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.710s)
[635.544032] [131/133] (395s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[635.856078] Starting subtest: cursor-rapid-movement-max-size
[635.863657] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[635.987459] [132/133] (394s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[636.083924] Starting subtest: fbcpsr-suspend
[676.792492] Subtest fbcpsr-suspend: SUCCESS (10.730s)
[676.954642] [133/133] (353s left) api_intel_bb (reset-flags)
[677.028104] Starting subtest: reset-flags
[677.035391] Subtest reset-flags: SUCCESS (0.010s)
[677.183921] 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.