[57.823137] Initializing watchdogs
[57.823186]   /dev/watchdog0
[57.840262] [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.844933] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.847926] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.849868] [001/133] (960s left) gem_softpin (noreloc-s3)
[57.923196] Starting subtest: noreloc-S3
[78.528648] Subtest noreloc-S3: SUCCESS (5.389s)
[82.681574] [002/133] (939s left) perf_pmu (gt-awake)
[82.742884] Starting subtest: gt-awake
[91.145056] Subtest gt-awake: SUCCESS (8.396s)
[91.237711] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[91.326319] Starting subtest: zero-hdisplay
[91.327313] Starting dynamic subtest: pipe-A-eDP-1
[91.614738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[91.622474] Starting dynamic subtest: pipe-B-eDP-1
[91.623470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.629875] Starting dynamic subtest: pipe-C-eDP-1
[91.630905] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.637784] Starting dynamic subtest: pipe-D-eDP-1
[91.638899] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.639769] Subtest zero-hdisplay: SUCCESS (0.293s)
[92.404187] [004/133] (930s left) kms_prop_blob (invalid-set-prop-any)
[92.446913] Starting subtest: invalid-set-prop-any
[92.447760] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[92.543443] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[92.639942] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[100.214555] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.576s)
[100.342481] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[100.438331] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[100.440166] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[100.530097] [007/133] (922s left) kms_cursor_legacy (torture-move)
[100.632098] Starting subtest: torture-move
[100.632962] Starting dynamic subtest: pipe-A
[106.517091] Dynamic subtest pipe-A: SUCCESS (5.839s)
[106.526042] Starting dynamic subtest: pipe-B
[112.949975] Dynamic subtest pipe-B: SUCCESS (6.478s)
[112.958652] Starting dynamic subtest: pipe-C
[118.703909] Dynamic subtest pipe-C: SUCCESS (5.755s)
[118.712771] Starting dynamic subtest: pipe-D
[125.865074] Dynamic subtest pipe-D: SUCCESS (7.153s)
[125.875376] Starting dynamic subtest: all-pipes
[132.274335] Dynamic subtest all-pipes: SUCCESS (6.409s)
[132.275336] Subtest torture-move: SUCCESS (31.637s)
[132.435208] [008/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[132.532077] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[136.178034] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.647s)
[137.360946] [009/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[137.464268] Starting subtest: fbc-rgb101010-draw-blt
[142.055824] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.594s)
[143.245507] [010/133] (879s left) gem_pxp (create-regular-context-2)
[143.361366] Starting subtest: create-regular-context-2
[143.362445] Subtest create-regular-context-2: SUCCESS (0.002s)
[143.470169] [011/133] (879s left) kms_flip (2x-flip-vs-panning-interruptible)
[143.567880] Starting subtest: 2x-flip-vs-panning-interruptible
[143.579350] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[143.662442] [012/133] (879s left) kms_plane_alpha_blend (constant-alpha-max)
[143.756713] Starting subtest: constant-alpha-max
[144.033791] Starting dynamic subtest: pipe-A-eDP-1
[145.142161] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.108s)
[145.150069] Starting dynamic subtest: pipe-D-eDP-1
[146.817347] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.674s)
[146.818241] Subtest constant-alpha-max: SUCCESS (3.061s)
[147.631023] [013/133] (875s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[147.733635] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[147.763363] Starting dynamic subtest: pipe-A-plane-0
[148.052073] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[148.061278] Starting dynamic subtest: pipe-A-plane-3
[148.285292] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[148.294620] Starting dynamic subtest: pipe-A-plane-5
[148.296255] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[149.415568] Starting dynamic subtest: pipe-B-plane-0
[149.704192] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[149.711609] Starting dynamic subtest: pipe-B-plane-3
[149.937830] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[149.950483] Starting dynamic subtest: pipe-B-plane-5
[149.952183] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[150.265117] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.531s)
[151.086867] [014/133] (871s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[151.138854] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[151.195607] [015/133] (871s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[151.244644] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[151.301783] [016/133] (871s left) gem_vm_create (invalid-destroy)
[151.361221] Starting subtest: invalid-destroy
[151.363220] Subtest invalid-destroy: SUCCESS (0.002s)
[151.452145] [017/133] (871s left) gem_lmem_swapping (heavy-verify-random-ccs)
[151.488987] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[151.526330] [018/133] (871s left) kms_feature_discovery (display-2x)
[151.617712] Starting subtest: display-2x
[151.619658] Subtest display-2x: SKIP (0.000s)
[151.697370] [019/133] (871s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[151.779653] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[151.780518] Starting dynamic subtest: pipe-A-eDP-1
[151.789388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.797364] Starting dynamic subtest: pipe-B-eDP-1
[151.805838] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.813478] Starting dynamic subtest: pipe-C-eDP-1
[151.821455] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.830524] Starting dynamic subtest: pipe-D-eDP-1
[151.838615] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.840092] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[154.071673] [020/133] (868s left) gem_mmap_offset (blt-coherency)
[154.125283] Starting subtest: blt-coherency
[154.134824] Subtest blt-coherency: SUCCESS (0.010s)
[154.262824] [021/133] (868s left) gem_pxp (hw-rejects-pxp-context)
[154.316203] Starting subtest: hw-rejects-pxp-context
[154.317808] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[154.396935] [022/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[154.482336] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[161.083660] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.603s)
[161.224600] [023/133] (861s left) kms_psr (pr-sprite-mmap-gtt)
[161.315121] Starting subtest: pr-sprite-mmap-gtt
[161.317144] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[161.393105] [024/133] (861s left) gem_exec_reloc (basic-write-gtt-noreloc)
[161.451969] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[161.510253] [025/133] (861s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[161.590336] Starting subtest: plane-lut1d-ctm3x4
[161.741386] Starting dynamic subtest: pipe-A-plane-0
[161.908083] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[161.916136] Starting dynamic subtest: pipe-A-plane-1
[162.063420] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[162.071206] Starting dynamic subtest: pipe-A-plane-2
[162.219185] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[163.410028] Starting dynamic subtest: pipe-B-plane-0
[163.580632] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[163.588063] Starting dynamic subtest: pipe-B-plane-1
[163.735968] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[163.743505] Starting dynamic subtest: pipe-B-plane-2
[163.902529] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[165.135713] Starting dynamic subtest: pipe-C-plane-0
[165.283658] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[165.292066] Starting dynamic subtest: pipe-C-plane-1
[165.428146] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[165.435658] Starting dynamic subtest: pipe-C-plane-2
[165.572488] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[166.739219] Starting dynamic subtest: pipe-D-plane-0
[166.898871] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[166.906791] Starting dynamic subtest: pipe-D-plane-1
[167.054415] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[167.062510] Starting dynamic subtest: pipe-D-plane-2
[167.198770] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[167.485067] Subtest plane-lut1d-ctm3x4: SUCCESS (5.895s)
[168.309402] [026/133] (854s left) gem_exec_schedule (preempt-hang)
[168.475047] Starting subtest: preempt-hang
[168.476668] Starting dynamic subtest: rcs0
[168.736197] Dynamic subtest rcs0: SUCCESS (0.261s)
[168.747264] Starting dynamic subtest: bcs0
[168.970783] Dynamic subtest bcs0: SUCCESS (0.233s)
[168.983198] Starting dynamic subtest: vcs0
[169.200725] Dynamic subtest vcs0: SUCCESS (0.229s)
[169.209367] Starting dynamic subtest: vcs1
[169.422478] Dynamic subtest vcs1: SUCCESS (0.221s)
[169.430277] Starting dynamic subtest: vecs0
[169.646575] Dynamic subtest vecs0: SUCCESS (0.223s)
[169.656048] Starting dynamic subtest: ccs0
[169.876574] Dynamic subtest ccs0: SUCCESS (0.229s)
[169.877453] Subtest preempt-hang: SUCCESS (1.401s)
[170.213302] [027/133] (853s left) kms_psr (psr-cursor-mmap-cpu)
[170.297584] Starting subtest: psr-cursor-mmap-cpu
[170.298546] Starting dynamic subtest: eDP-1
[172.015252] Dynamic subtest eDP-1: SUCCESS (1.717s)
[172.016152] Subtest psr-cursor-mmap-cpu: SUCCESS (1.718s)
[172.882968] [028/133] (850s left) gem_exec_whisper (basic-contexts-priority-all)
[172.944860] Starting subtest: basic-contexts-priority-all
[194.976632] Subtest basic-contexts-priority-all: SUCCESS (21.985s)
[195.107722] [029/133] (828s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[195.164013] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[195.228044] [030/133] (828s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[195.333621] Starting subtest: cursorB-vs-flipA-atomic-transitions
[195.336220] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[195.470534] [031/133] (827s left) gem_exec_params (rel-constants-invalid)
[195.523435] Starting subtest: rel-constants-invalid
[195.524219] Subtest rel-constants-invalid: SUCCESS (0.000s)
[195.614241] [032/133] (827s left) kms_joiner (invalid-modeset-ultra-joiner)
[195.706676] Starting subtest: invalid-modeset-ultra-joiner
[195.708370] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[195.777797] [033/133] (827s left) syncobj_wait (invalid-signal-bad-pad)
[195.821413] Starting subtest: invalid-signal-bad-pad
[195.822481] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[195.908074] [034/133] (827s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[195.985001] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[195.996888] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[196.066278] [035/133] (827s left) gem_eio (in-flight-contexts-1us)
[196.269206] Starting subtest: in-flight-contexts-1us
[208.137484] Subtest in-flight-contexts-1us: SUCCESS (11.871s)
[208.314873] [036/133] (815s left) kms_pm_lpsp (kms-lpsp)
[209.410472] Starting subtest: kms-lpsp
[209.411772] Starting dynamic subtest: pipe-A-eDP-1
[209.585570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[209.880947] Subtest kms-lpsp: SUCCESS (0.471s)
[210.714837] [037/133] (812s left) i915_drm_fdinfo (busy-check-all)
[210.750040] Starting subtest: busy-check-all
[210.750893] Starting dynamic subtest: rcs0
[210.753630] Dynamic subtest rcs0: SKIP (0.003s)
[210.764537] Starting dynamic subtest: bcs0
[210.766181] Dynamic subtest bcs0: SKIP (0.000s)
[210.775109] Starting dynamic subtest: vcs0
[210.777130] Dynamic subtest vcs0: SKIP (0.000s)
[210.784561] Starting dynamic subtest: vcs1
[210.786477] Dynamic subtest vcs1: SKIP (0.000s)
[210.794215] Starting dynamic subtest: vecs0
[210.796270] Dynamic subtest vecs0: SKIP (0.000s)
[210.803881] Starting dynamic subtest: ccs0
[210.805684] Dynamic subtest ccs0: SKIP (0.000s)
[210.807367] Subtest busy-check-all: SKIP (0.008s)
[210.834348] [038/133] (812s left) drm_read (fault-buffer)
[211.010122] Starting subtest: fault-buffer
[211.011213] Subtest fault-buffer: SUCCESS (0.000s)
[211.116741] [039/133] (812s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[211.215631] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[212.305983] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[212.422117] [040/133] (811s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[212.514513] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[212.515440] Starting dynamic subtest: pipe-A-eDP-1
[213.413027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.897s)
[213.421376] Starting dynamic subtest: pipe-B-eDP-1
[215.007748] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s)
[215.016237] Starting dynamic subtest: pipe-C-eDP-1
[216.532403] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.524s)
[216.540674] Starting dynamic subtest: pipe-D-eDP-1
[218.045850] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.513s)
[218.046881] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.531s)
[219.222616] [041/133] (804s left) gem_ctx_shared (create-shared-gtt)
[219.294775] Starting subtest: create-shared-gtt
[221.491508] Subtest create-shared-gtt: SUCCESS (2.151s)
[221.911057] [042/133] (801s left) gem_sync (basic-store-each)
[221.983333] Starting subtest: basic-store-each
[224.629293] Subtest basic-store-each: SUCCESS (2.646s)
[224.824780] [043/133] (798s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[224.926420] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[224.928804] Starting dynamic subtest: A-eDP1
[233.870545] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[233.881665] Starting dynamic subtest: B-eDP1
[242.802767] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[242.819242] Starting dynamic subtest: C-eDP1
[251.769560] Dynamic subtest C-eDP1: SUCCESS (8.928s)
[251.780335] Starting dynamic subtest: D-eDP1
[260.702199] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[260.703149] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.747s)
[261.877037] [044/133] (761s left) i915_pm_freq_api (freq-basic-api)
[261.929168] Starting subtest: freq-basic-api
[261.930343] Starting dynamic subtest: gt0
[261.933278] Dynamic subtest gt0: SUCCESS (0.003s)
[261.942087] Starting dynamic subtest: gt1
[261.942967] Dynamic subtest gt1: SUCCESS (0.002s)
[261.943836] Subtest freq-basic-api: SUCCESS (0.007s)
[262.017967] [045/133] (761s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[262.101578] Starting subtest: plane-use-after-nonblocking-unbind
[262.102479] Starting dynamic subtest: pipe-A-eDP-1
[262.163101] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[262.483470] Starting dynamic subtest: pipe-B-eDP-1
[263.298384] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.828s)
[263.608768] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.508s)
[264.470555] [046/133] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[264.559714] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[264.561563] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[264.670071] [047/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[264.766869] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[264.768831] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.866960] [048/133] (759s left) kms_getfb (getfb2-handle-closed)
[264.947673] Starting subtest: getfb2-handle-closed
[264.948558] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[265.042029] [049/133] (758s left) kms_psr (fbc-pr-no-drrs)
[265.134809] Starting subtest: fbc-pr-no-drrs
[265.136638] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[265.226533] [050/133] (758s left) drm_read (short-buffer-nonblock)
[265.379507] Starting subtest: short-buffer-nonblock
[265.380327] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[265.511912] [051/133] (758s left) gen9_exec_parse (bb-secure)
[265.561938] Subtest bb-secure: SKIP (0.000s)
[265.613866] [052/133] (758s left) kms_psr (fbc-pr-sprite-render)
[265.706846] Starting subtest: fbc-pr-sprite-render
[265.708689] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[265.772947] [053/133] (758s left) kms_big_fb (linear-64bpp-rotate-0)
[265.864654] Starting subtest: linear-64bpp-rotate-0
[267.637161] Subtest linear-64bpp-rotate-0: SUCCESS (1.773s)
[267.808254] [054/133] (756s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[267.896641] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[267.898493] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[267.961767] [055/133] (756s left) gem_exec_balancer (full)
[268.011215] Starting subtest: full
[273.016998] Subtest full: SUCCESS (5.006s)
[273.344831] [056/133] (750s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[273.446242] Starting subtest: plane-upscale-20x20-with-pixel-format
[273.447136] Starting dynamic subtest: pipe-A
[274.495406] Dynamic subtest pipe-A: SUCCESS (1.050s)
[274.509798] Starting dynamic subtest: pipe-B
[276.573289] Dynamic subtest pipe-B: SUCCESS (2.077s)
[276.582822] Starting dynamic subtest: pipe-C
[277.776279] Dynamic subtest pipe-C: SUCCESS (1.202s)
[277.786039] Starting dynamic subtest: pipe-D
[278.920559] Dynamic subtest pipe-D: SUCCESS (1.143s)
[278.922548] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.477s)
[280.107952] [057/133] (744s left) kms_flip (modeset-vs-vblank-race-interruptible)
[280.203706] Starting subtest: modeset-vs-vblank-race-interruptible
[280.206102] Starting dynamic subtest: A-eDP1
[284.854123] Dynamic subtest A-eDP1: SUCCESS (4.648s)
[284.866248] Starting dynamic subtest: B-eDP1
[289.578671] Dynamic subtest B-eDP1: SUCCESS (4.722s)
[289.590640] Starting dynamic subtest: C-eDP1
[294.181182] Dynamic subtest C-eDP1: SUCCESS (4.601s)
[294.190599] Starting dynamic subtest: D-eDP1
[298.716849] Dynamic subtest D-eDP1: SUCCESS (4.534s)
[298.721633] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.519s)
[299.873250] [058/133] (724s left) i915_pm_rps (engine-order)
[299.923622] Starting subtest: engine-order
[306.349360] Subtest engine-order: SUCCESS (6.417s)
[306.452881] [059/133] (717s left) kms_plane_cursor (overlay)
[306.535689] Starting subtest: overlay
[306.537709] Starting dynamic subtest: pipe-A-eDP-1-size-64
[309.044081] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.507s)
[309.105986] Starting dynamic subtest: pipe-A-eDP-1-size-128
[311.657543] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s)
[311.718022] Starting dynamic subtest: pipe-A-eDP-1-size-256
[314.247504] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[314.605531] Starting dynamic subtest: pipe-B-eDP-1-size-64
[317.880655] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.283s)
[317.943499] Starting dynamic subtest: pipe-B-eDP-1-size-128
[320.526348] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.593s)
[320.589179] Starting dynamic subtest: pipe-B-eDP-1-size-256
[323.139620] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[323.487542] Starting dynamic subtest: pipe-C-eDP-1-size-64
[326.411650] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.932s)
[326.450401] Starting dynamic subtest: pipe-C-eDP-1-size-128
[328.611939] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[328.649862] Starting dynamic subtest: pipe-C-eDP-1-size-256
[330.790016] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[331.123109] Starting dynamic subtest: pipe-D-eDP-1-size-64
[334.038090] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.923s)
[334.078595] Starting dynamic subtest: pipe-D-eDP-1-size-128
[336.338342] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.270s)
[336.376972] Starting dynamic subtest: pipe-D-eDP-1-size-256
[338.616504] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.248s)
[338.934772] Subtest overlay: SUCCESS (32.392s)
[339.804551] [060/133] (684s left) kms_sequence (queue-busy)
[339.894012] Starting subtest: queue-busy
[339.895115] Starting dynamic subtest: pipe-A-eDP-1
[341.833499] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[341.846565] Starting dynamic subtest: pipe-B-eDP-1
[344.408413] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[344.416859] Starting dynamic subtest: pipe-C-eDP-1
[347.023400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[347.031747] Starting dynamic subtest: pipe-D-eDP-1
[349.552865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s)
[349.553746] Subtest queue-busy: SUCCESS (9.658s)
[350.344412] [061/133] (674s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[350.431018] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[350.433321] Starting dynamic subtest: A-eDP1
[354.095972] Dynamic subtest A-eDP1: SUCCESS (3.662s)
[354.104116] Starting dynamic subtest: B-eDP1
[357.280169] Dynamic subtest B-eDP1: SUCCESS (3.183s)
[357.288388] Starting dynamic subtest: C-eDP1
[360.397691] Dynamic subtest C-eDP1: SUCCESS (3.116s)
[360.405867] Starting dynamic subtest: D-eDP1
[363.519136] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[363.520323] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.086s)
[364.302933] [062/133] (660s left) gem_flink_basic (double-flink)
[364.349973] Starting subtest: double-flink
[364.350970] Subtest double-flink: SUCCESS (0.000s)
[364.454582] [063/133] (659s left) gem_ctx_isolation (dirty-switch)
[364.508658] Starting subtest: dirty-switch
[364.509744] Starting dynamic subtest: rcs0
[364.700746] Dynamic subtest rcs0: SUCCESS (0.192s)
[364.713335] Starting dynamic subtest: bcs0
[364.897920] Dynamic subtest bcs0: SUCCESS (0.196s)
[364.913237] Starting dynamic subtest: vcs0
[365.108951] Dynamic subtest vcs0: SUCCESS (0.210s)
[365.119429] Starting dynamic subtest: vcs1
[366.337495] Dynamic subtest vcs1: SUCCESS (1.228s)
[366.347140] Starting dynamic subtest: vecs0
[368.327339] Dynamic subtest vecs0: SUCCESS (1.989s)
[368.337490] Starting dynamic subtest: ccs0
[370.328851] Dynamic subtest ccs0: SUCCESS (2.001s)
[370.329836] Subtest dirty-switch: SUCCESS (5.821s)
[370.592073] [064/133] (653s left) kms_cursor_edge_walk (64x64-top-edge)
[370.696317] Starting subtest: 64x64-top-edge
[370.697249] Starting dynamic subtest: pipe-A-eDP-1
[374.158362] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[374.167517] Starting dynamic subtest: pipe-D-eDP-1
[377.294947] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[377.295802] Subtest 64x64-top-edge: SUCCESS (6.599s)
[378.097701] [065/133] (646s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[378.182655] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[378.183579] Starting dynamic subtest: pipe-A-eDP-1
[378.192713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[378.201574] Starting dynamic subtest: pipe-B-eDP-1
[378.210130] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[378.218230] Starting dynamic subtest: pipe-C-eDP-1
[378.226901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[378.234924] Starting dynamic subtest: pipe-D-eDP-1
[378.243873] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[378.245501] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[380.470024] [066/133] (644s left) gem_eio (hibernate)
[380.700638] Starting subtest: hibernate
[395.596252] Subtest hibernate: SUCCESS (14.894s)
[401.759469] [067/133] (628s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[401.860814] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[401.872650] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[401.942084] [068/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[402.027841] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[402.029710] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[402.109862] [069/133] (628s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[402.218213] Starting subtest: extended-modeset-hang-newfb-with-reset
[402.219514] Starting dynamic subtest: pipe-A
[415.760493] Dynamic subtest pipe-A: SUCCESS (13.542s)
[415.770651] Starting dynamic subtest: pipe-D
[431.122469] Dynamic subtest pipe-D: SUCCESS (15.359s)
[431.123430] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.906s)
[431.910771] [070/133] (598s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[431.996570] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[431.998623] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[432.066543] [071/133] (598s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[432.162643] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[435.833983] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.671s)
[437.014601] [072/133] (593s left) sysfs_preempt_timeout (invalid)
[437.068798] Starting subtest: invalid
[437.069994] Starting dynamic subtest: vecs0
[437.071142] Dynamic subtest vecs0: SUCCESS (0.000s)
[437.081497] Starting dynamic subtest: ccs0
[437.082322] Dynamic subtest ccs0: SUCCESS (0.000s)
[437.090609] Starting dynamic subtest: vcs0
[437.091476] Dynamic subtest vcs0: SUCCESS (0.000s)
[437.099861] Starting dynamic subtest: bcs0
[437.100845] Dynamic subtest bcs0: SUCCESS (0.000s)
[437.109142] Starting dynamic subtest: rcs0
[437.110265] Dynamic subtest rcs0: SUCCESS (0.000s)
[437.118523] Starting dynamic subtest: vcs1
[437.119438] Dynamic subtest vcs1: SUCCESS (0.000s)
[437.120282] Subtest invalid: SUCCESS (0.006s)
[437.150924] [073/133] (593s left) gem_exec_big (single)
[437.205063] Starting subtest: single
[442.173882] Subtest single: SUCCESS (4.921s)
[442.377790] [074/133] (588s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[442.532346] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[442.533140] Starting dynamic subtest: pipe-A-eDP-1
[442.553360] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[442.564742] Starting dynamic subtest: pipe-B-eDP-1
[442.585836] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[442.600093] Starting dynamic subtest: pipe-C-eDP-1
[442.633979] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[442.654627] Starting dynamic subtest: pipe-D-eDP-1
[442.678786] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[442.680545] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[444.872928] [075/133] (585s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[444.973962] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[446.041711] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.068s)
[446.170907] [076/133] (584s left) kms_chamelium_hpd (dp-hpd-storm)
[446.543708] Subtest dp-hpd-storm: SKIP (0.000s)
[447.375885] [077/133] (583s left) i915_query (query-topology-kernel-writes)
[447.430757] Starting subtest: query-topology-kernel-writes
[447.431747] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[447.536637] [078/133] (583s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[447.616053] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[447.618722] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[447.682861] [079/133] (583s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[447.734894] Starting subtest: invalid-bsd2-flag-on-blt
[447.735957] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[447.830898] [080/133] (583s left) sw_sync (sync_busy_fork)
[447.875233] Starting subtest: sync_busy_fork
[448.896378] Subtest sync_busy_fork: SUCCESS (1.012s)
[448.948464] [081/133] (582s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[448.998676] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[448.999637] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[449.122081] [082/133] (581s left) kms_chamelium_frames (hdmi-crc-fast)
[449.499143] Subtest hdmi-crc-fast: SKIP (0.000s)
[450.310012] [083/133] (580s left) gem_flink_basic (flink-lifetime)
[450.354590] Starting subtest: flink-lifetime
[450.355707] Subtest flink-lifetime: SUCCESS (0.002s)
[450.457143] [084/133] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[450.560133] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[450.561833] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[450.663714] [085/133] (580s left) kms_prop_blob (basic)
[450.719876] Starting subtest: basic
[450.721344] Subtest basic: SUCCESS (0.000s)
[450.829551] [086/133] (580s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[450.870208] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[450.972092] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[451.048314] [087/133] (580s left) perf (blocking-parameterized)
[451.188416] Starting subtest: blocking-parameterized
[471.222693] Subtest blocking-parameterized: SUCCESS (20.024s)
[471.257554] [088/133] (560s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[471.312019] Starting subtest: etime-multi-wait-all-submitted-signaled
[471.419929] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[471.520781] [089/133] (559s left) gem_exec_fence (submit-chain)
[471.705293] Starting subtest: submit-chain
[471.734559] Subtest submit-chain: SUCCESS (0.031s)
[473.136005] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[473.138356] [090/133] (558s left) gem_exec_params (mmapped)
[473.199379] Starting subtest: mmapped
[473.203203] Subtest mmapped: SUCCESS (0.004s)
[473.314970] [091/133] (558s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[473.416583] Starting subtest: x-tiled-32bpp-rotate-180
[474.862636] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.446s)
[475.010198] [092/133] (556s left) sw_sync (sync_expired_merge)
[475.046690] Starting subtest: sync_expired_merge
[476.129579] Subtest sync_expired_merge: SUCCESS (1.074s)
[476.179232] [093/133] (555s left) prime_vgem (basic-fence-mmap)
[476.244099] Starting subtest: basic-fence-mmap
[476.246113] Subtest basic-fence-mmap: SKIP (0.000s)
[476.336390] [094/133] (555s left) gem_ctx_shared (disjoint-timelines)
[476.391630] Starting subtest: disjoint-timelines
[476.411322] Subtest disjoint-timelines: SUCCESS (0.020s)
[476.637499] [095/133] (554s left) kms_psr (psr-dpms)
[476.723320] Starting subtest: psr-dpms
[476.724482] Starting dynamic subtest: eDP-1
[479.686474] Dynamic subtest eDP-1: SUCCESS (2.963s)
[479.687348] Subtest psr-dpms: SUCCESS (2.964s)
[480.537612] [096/133] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[480.616685] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[488.110102] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.495s)
[488.231248] [097/133] (543s left) gem_softpin (allocator-nopin)
[488.276684] Starting subtest: allocator-nopin
[488.359596] Subtest allocator-nopin: SUCCESS (0.082s)
[488.483750] [098/133] (543s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[488.573870] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[488.574806] Starting dynamic subtest: pipe-A-default-mode
[489.734251] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[489.736141] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.161s)
[489.881514] [099/133] (541s left) gem_exec_flush (basic-wb-pro-default)
[489.939824] Starting subtest: basic-wb-pro-default
[495.400646] Subtest basic-wb-pro-default: SUCCESS (5.461s)
[495.598719] [100/133] (536s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[495.696855] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[495.697780] Starting dynamic subtest: pipe-A-eDP-1
[495.801785] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[495.812481] Starting dynamic subtest: pipe-B-eDP-1
[496.973897] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[496.975908] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.276s)
[498.155931] [101/133] (533s left) syncobj_timeline (single-wait-available-submitted)
[498.211589] Starting subtest: single-wait-available-submitted
[498.212540] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[498.341799] [102/133] (533s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[498.411253] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[498.413245] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[498.605248] [103/133] (533s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[498.699410] Starting subtest: psr-rgb101010-draw-pwrite
[506.377026] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.678s)
[506.488841] [104/133] (525s left) perf (gen8-unprivileged-single-ctx-counters)
[506.589001] Starting subtest: gen8-unprivileged-single-ctx-counters
[506.590862] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[506.628464] [105/133] (525s left) api_intel_allocator (standalone)
[506.683708] Starting subtest: standalone
[506.704412] Subtest standalone: SUCCESS (0.021s)
[506.826245] [106/133] (525s left) kms_getfb (getfb-handle-closed)
[506.916103] Starting subtest: getfb-handle-closed
[506.916992] Subtest getfb-handle-closed: SUCCESS (0.000s)
[507.024720] [107/133] (524s left) perf (mi-rpc)
[507.114718] Starting subtest: mi-rpc
[507.116545] Subtest mi-rpc: SKIP (0.000s)
[507.153956] [108/133] (524s left) kms_async_flips (async-flip-dpms)
[507.243690] Starting subtest: async-flip-dpms
[507.624888] Starting dynamic subtest: pipe-A-eDP-1
[511.435317] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.810s)
[511.816866] Starting dynamic subtest: pipe-B-eDP-1
[514.590237] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.780s)
[514.991904] Starting dynamic subtest: pipe-C-eDP-1
[517.765876] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[518.159045] Starting dynamic subtest: pipe-D-eDP-1
[520.925863] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[520.926805] Subtest async-flip-dpms: SUCCESS (13.684s)
[522.102954] [109/133] (509s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[522.217429] Starting subtest: y-tiled-64bpp-rotate-180
[522.219059] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[522.308567] [110/133] (509s left) gem_close_race (multigpu-basic-process)
[522.369202] Starting subtest: multigpu-basic-process
[522.371076] Subtest multigpu-basic-process: SKIP (0.000s)
[522.604961] [111/133] (509s left) kms_cursor_crc (cursor-offscreen-32x10)
[522.756603] Starting subtest: cursor-offscreen-32x10
[522.803745] Subtest cursor-offscreen-32x10: SKIP (0.045s)
[523.071548] [112/133] (509s left) gem_exec_flush (basic-wb-rw-default)
[523.135022] Starting subtest: basic-wb-rw-default
[528.597146] Subtest basic-wb-rw-default: SUCCESS (5.462s)
[528.784269] [113/133] (503s left) dmabuf_sync_file (export-before-signal)
[528.823174] Starting subtest: export-before-signal
[528.824016] Subtest export-before-signal: SUCCESS (0.001s)
[528.877483] [114/133] (503s left) gem_exec_schedule (preempt-queue-contexts-chain)
[528.930760] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[529.240450] [115/133] (503s left) perf_pmu (semaphore-wait)
[529.277054] Starting subtest: semaphore-wait
[529.278010] Starting dynamic subtest: rcs0
[529.799624] Dynamic subtest rcs0: SUCCESS (0.512s)
[529.809514] Starting dynamic subtest: bcs0
[530.314379] Dynamic subtest bcs0: SUCCESS (0.512s)
[530.323855] Starting dynamic subtest: vcs0
[530.829366] Dynamic subtest vcs0: SUCCESS (0.512s)
[530.838888] Starting dynamic subtest: vcs1
[531.344106] Dynamic subtest vcs1: SUCCESS (0.512s)
[531.353779] Starting dynamic subtest: vecs0
[531.859712] Dynamic subtest vecs0: SUCCESS (0.512s)
[531.868835] Starting dynamic subtest: ccs0
[532.376175] Dynamic subtest ccs0: SUCCESS (0.513s)
[532.377204] Subtest semaphore-wait: SUCCESS (3.092s)
[532.481499] [116/133] (499s left) gem_basic (multigpu-create-close)
[532.535324] Starting subtest: multigpu-create-close
[532.537508] Subtest multigpu-create-close: SKIP (0.000s)
[532.618419] [117/133] (499s left) kms_vblank (query-idle)
[532.704720] Starting subtest: query-idle
[532.705677] Starting dynamic subtest: pipe-A-eDP-1
[534.455956] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.750s)
[534.466990] Starting dynamic subtest: pipe-D-eDP-1
[536.874176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[536.875189] Subtest query-idle: SUCCESS (4.169s)
[537.691402] [118/133] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[537.784612] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[537.786095] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[537.874986] [119/133] (494s left) syncobj_timeline (reset-during-wait-for-submit)
[537.926043] Starting subtest: reset-during-wait-for-submit
[538.029256] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[538.102558] [120/133] (494s left) i915_suspend (basic-s3-without-i915)
[538.137694] Starting subtest: basic-s3-without-i915
[541.423164] Subtest basic-s3-without-i915: SKIP (3.276s)
[543.055790] [121/133] (489s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[543.148704] Starting subtest: plane-primary-toggle-with-vblank-wait
[543.149633] Starting dynamic subtest: pipe-A-eDP-1
[543.323115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[543.641571] Starting dynamic subtest: pipe-B-eDP-1
[544.542534] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.909s)
[544.837898] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.689s)
[545.705377] [122/133] (486s left) kms_psr (fbc-psr-primary-blt)
[545.794441] Starting subtest: fbc-psr-primary-blt
[545.795461] Starting dynamic subtest: eDP-1
[545.797243] Dynamic subtest eDP-1: SKIP (0.000s)
[545.799171] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[545.863221] [123/133] (486s left) gem_mmap (bad-offset)
[545.906408] Subtest bad-offset: SKIP (0.000s)
[545.964023] [124/133] (486s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[546.053528] Starting subtest: yf-tiled-8bpp-rotate-0
[546.055373] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[546.140711] [125/133] (486s left) gem_exec_flush (basic-batch-kernel-default-wb)
[546.192576] Starting subtest: basic-batch-kernel-default-wb
[553.521292] Subtest basic-batch-kernel-default-wb: SUCCESS (7.328s)
[553.718626] [126/133] (478s left) perf (invalid-oa-format-id)
[553.837039] Starting subtest: invalid-oa-format-id
[553.847646] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[553.889463] [127/133] (478s left) kms_async_flips (test-time-stamp)
[553.979214] Starting subtest: test-time-stamp
[554.362042] Starting dynamic subtest: pipe-A-eDP-1
[555.120917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[555.514172] Starting dynamic subtest: pipe-B-eDP-1
[556.269017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[556.648050] Starting dynamic subtest: pipe-C-eDP-1
[557.402492] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[557.767779] Starting dynamic subtest: pipe-D-eDP-1
[558.535770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[558.536776] Subtest test-time-stamp: SUCCESS (4.557s)
[559.685148] [128/133] (473s left) kms_content_protection (legacy-hdcp14)
[559.822201] Starting subtest: legacy-hdcp14
[559.824023] Subtest legacy-hdcp14: SKIP (0.000s)
[559.946325] [129/133] (472s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[560.023201] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[560.024385] Starting dynamic subtest: pipe-A-eDP-1
[577.159850] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[577.168891] Starting dynamic subtest: pipe-B-eDP-1
[595.134268] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.837s)
[595.143138] Starting dynamic subtest: pipe-C-eDP-1
[613.079593] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.710s)
[613.087817] Starting dynamic subtest: pipe-D-eDP-1
[631.088752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.755s)
[631.089736] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.110s)
[638.259230] [130/133] (400s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[638.359362] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[645.046663] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.690s)
[645.180261] [131/133] (393s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[645.488258] Starting subtest: cursor-rapid-movement-max-size
[645.490999] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[645.611377] [132/133] (393s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[645.702449] Starting subtest: fbcpsr-suspend
[686.572414] Subtest fbcpsr-suspend: SUCCESS (10.735s)
[690.762754] [133/133] (352s left) api_intel_bb (reset-flags)
[690.833438] Starting subtest: reset-flags
[690.841112] Subtest reset-flags: SUCCESS (0.008s)
[690.950814] 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.