[62.189191] Initializing watchdogs
[62.189238]   /dev/watchdog0
[62.202867] [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]
[62.207299] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.209494] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.212950] [001/133] (960s left) gem_softpin (noreloc-s3)
[62.296923] Starting subtest: noreloc-S3
[82.253643] Subtest noreloc-S3: SUCCESS (5.416s)
[82.496850] [002/133] (940s left) perf_pmu (gt-awake)
[82.562650] Starting subtest: gt-awake
[91.444679] Subtest gt-awake: SUCCESS (8.907s)
[91.540216] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[91.639432] Starting subtest: zero-hdisplay
[91.641989] Starting dynamic subtest: pipe-A-eDP-1
[91.924647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[91.935049] Starting dynamic subtest: pipe-B-eDP-1
[91.937528] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.945355] Starting dynamic subtest: pipe-C-eDP-1
[91.948239] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.956841] Starting dynamic subtest: pipe-D-eDP-1
[91.959860] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.962665] Subtest zero-hdisplay: SUCCESS (0.291s)
[92.779388] [004/133] (930s left) kms_prop_blob (invalid-set-prop-any)
[92.837591] Starting subtest: invalid-set-prop-any
[92.840508] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[92.926821] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[93.027671] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[100.511642] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.497s)
[100.666508] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[100.761473] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[100.766295] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[100.838459] [007/133] (922s left) kms_cursor_legacy (torture-move)
[100.945669] Starting subtest: torture-move
[100.948346] Starting dynamic subtest: pipe-A
[106.769643] Dynamic subtest pipe-A: SUCCESS (5.825s)
[106.780042] Starting dynamic subtest: pipe-B
[112.972711] Dynamic subtest pipe-B: SUCCESS (6.206s)
[112.982337] Starting dynamic subtest: pipe-C
[119.265187] Dynamic subtest pipe-C: SUCCESS (6.287s)
[119.275002] Starting dynamic subtest: pipe-D
[125.781413] Dynamic subtest pipe-D: SUCCESS (6.514s)
[125.791089] Starting dynamic subtest: all-pipes
[132.372157] Dynamic subtest all-pipes: SUCCESS (6.588s)
[132.374734] Subtest torture-move: SUCCESS (31.426s)
[132.525336] [008/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[132.635478] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[136.195666] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.566s)
[137.393765] [009/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[137.484423] Starting subtest: fbc-rgb101010-draw-blt
[142.110314] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.629s)
[143.288256] [010/133] (879s left) gem_pxp (create-regular-context-2)
[143.407685] Starting subtest: create-regular-context-2
[143.410648] Subtest create-regular-context-2: SUCCESS (0.002s)
[143.520728] [011/133] (879s left) kms_flip (2x-flip-vs-panning-interruptible)
[143.619464] Starting subtest: 2x-flip-vs-panning-interruptible
[143.629562] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[143.727803] [012/133] (879s left) kms_plane_alpha_blend (constant-alpha-max)
[143.828482] Starting subtest: constant-alpha-max
[144.118279] Starting dynamic subtest: pipe-A-eDP-1
[145.152904] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.038s)
[145.165944] Starting dynamic subtest: pipe-D-eDP-1
[146.798415] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.645s)
[146.801204] Subtest constant-alpha-max: SUCCESS (2.973s)
[147.637299] [013/133] (875s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[147.741560] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[147.766451] Starting dynamic subtest: pipe-A-plane-0
[148.066436] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[148.075385] Starting dynamic subtest: pipe-A-plane-3
[148.310451] Dynamic subtest pipe-A-plane-3: SUCCESS (0.243s)
[148.320380] Starting dynamic subtest: pipe-A-plane-5
[148.325210] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[149.427903] Starting dynamic subtest: pipe-B-plane-0
[149.720336] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[149.730487] Starting dynamic subtest: pipe-B-plane-3
[149.976167] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[149.985716] Starting dynamic subtest: pipe-B-plane-5
[149.991412] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[150.293367] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.553s)
[151.095338] [014/133] (872s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[151.160507] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[151.213481] [015/133] (872s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[151.278302] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[151.334782] [016/133] (871s left) gem_vm_create (invalid-destroy)
[151.389274] Starting subtest: invalid-destroy
[151.391950] Subtest invalid-destroy: SUCCESS (0.002s)
[151.485819] [017/133] (871s left) gem_lmem_swapping (heavy-verify-random-ccs)
[151.536807] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[151.582721] [018/133] (871s left) kms_feature_discovery (display-2x)
[151.678461] Starting subtest: display-2x
[151.683698] Subtest display-2x: SKIP (0.000s)
[151.760491] [019/133] (871s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[151.845526] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[151.848306] Starting dynamic subtest: pipe-A-eDP-1
[151.874530] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.884574] Starting dynamic subtest: pipe-B-eDP-1
[151.910153] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.919704] Starting dynamic subtest: pipe-C-eDP-1
[151.945260] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.953158] Starting dynamic subtest: pipe-D-eDP-1
[151.979058] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.984206] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[154.152273] [020/133] (869s left) gem_mmap_offset (blt-coherency)
[154.213784] Starting subtest: blt-coherency
[154.219646] Subtest blt-coherency: SUCCESS (0.009s)
[154.332599] [021/133] (869s left) gem_pxp (hw-rejects-pxp-context)
[154.402531] Starting subtest: hw-rejects-pxp-context
[154.407930] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[154.502361] [022/133] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[154.596556] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[161.131473] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.541s)
[161.240533] [023/133] (862s left) kms_psr (pr-sprite-mmap-gtt)
[161.334717] Starting subtest: pr-sprite-mmap-gtt
[161.340669] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[161.418018] [024/133] (862s left) gem_exec_reloc (basic-write-gtt-noreloc)
[161.493672] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[161.555454] [025/133] (862s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[161.654390] Starting subtest: plane-lut1d-ctm3x4
[161.782920] Starting dynamic subtest: pipe-A-plane-0
[161.935379] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[161.944588] Starting dynamic subtest: pipe-A-plane-1
[162.113010] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[162.121804] Starting dynamic subtest: pipe-A-plane-2
[162.246178] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[163.453271] Starting dynamic subtest: pipe-B-plane-0
[163.643596] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[163.654203] Starting dynamic subtest: pipe-B-plane-1
[163.799203] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[163.808728] Starting dynamic subtest: pipe-B-plane-2
[163.943599] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[165.110093] Starting dynamic subtest: pipe-C-plane-0
[165.254880] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[165.264458] Starting dynamic subtest: pipe-C-plane-1
[165.388380] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[165.398197] Starting dynamic subtest: pipe-C-plane-2
[165.532675] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[166.724927] Starting dynamic subtest: pipe-D-plane-0
[166.860988] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[166.870499] Starting dynamic subtest: pipe-D-plane-1
[166.994598] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[167.006162] Starting dynamic subtest: pipe-D-plane-2
[167.138281] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[167.425468] Subtest plane-lut1d-ctm3x4: SUCCESS (5.770s)
[168.304543] [026/133] (855s left) gem_exec_schedule (preempt-hang)
[168.482660] Starting subtest: preempt-hang
[168.485047] Starting dynamic subtest: rcs0
[168.722005] Dynamic subtest rcs0: SUCCESS (0.238s)
[168.733658] Starting dynamic subtest: bcs0
[168.955432] Dynamic subtest bcs0: SUCCESS (0.234s)
[168.968144] Starting dynamic subtest: vcs0
[169.174682] Dynamic subtest vcs0: SUCCESS (0.217s)
[169.183716] Starting dynamic subtest: vcs1
[169.391943] Dynamic subtest vcs1: SUCCESS (0.217s)
[169.402481] Starting dynamic subtest: vecs0
[169.616687] Dynamic subtest vecs0: SUCCESS (0.224s)
[169.627421] Starting dynamic subtest: ccs0
[169.842393] Dynamic subtest ccs0: SUCCESS (0.226s)
[169.844645] Subtest preempt-hang: SUCCESS (1.361s)
[170.518024] [027/133] (853s left) kms_psr (psr-cursor-mmap-cpu)
[170.615369] Starting subtest: psr-cursor-mmap-cpu
[170.617654] Starting dynamic subtest: eDP-1
[172.299660] Dynamic subtest eDP-1: SUCCESS (1.683s)
[172.302189] Subtest psr-cursor-mmap-cpu: SUCCESS (1.684s)
[173.163500] [028/133] (850s left) gem_exec_whisper (basic-contexts-priority-all)
[173.245465] Starting subtest: basic-contexts-priority-all
[197.310107] Subtest basic-contexts-priority-all: SUCCESS (24.009s)
[197.457393] [029/133] (826s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[197.509795] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[197.578973] [030/133] (826s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[197.695477] Starting subtest: cursorB-vs-flipA-atomic-transitions
[197.700665] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[197.847363] [031/133] (826s left) gem_exec_params (rel-constants-invalid)
[197.902976] Starting subtest: rel-constants-invalid
[197.905412] Subtest rel-constants-invalid: SUCCESS (0.000s)
[197.995690] [032/133] (826s left) kms_joiner (invalid-modeset-ultra-joiner)
[198.086458] Starting subtest: invalid-modeset-ultra-joiner
[198.091367] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[198.151970] [033/133] (825s left) syncobj_wait (invalid-signal-bad-pad)
[198.198652] Starting subtest: invalid-signal-bad-pad
[198.201138] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[198.293948] [034/133] (825s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[198.382988] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[198.393235] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[198.464934] [035/133] (825s left) gem_eio (in-flight-contexts-1us)
[198.676158] Starting subtest: in-flight-contexts-1us
[210.515826] Subtest in-flight-contexts-1us: SUCCESS (11.837s)
[210.675998] [036/133] (813s left) kms_pm_lpsp (kms-lpsp)
[211.789910] Starting subtest: kms-lpsp
[211.792412] Starting dynamic subtest: pipe-A-eDP-1
[211.954933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.169s)
[212.254642] Subtest kms-lpsp: SUCCESS (0.468s)
[213.096172] [037/133] (811s left) i915_drm_fdinfo (busy-check-all)
[213.142173] Starting subtest: busy-check-all
[213.144685] Starting dynamic subtest: rcs0
[213.150267] Dynamic subtest rcs0: SKIP (0.004s)
[213.159798] Starting dynamic subtest: bcs0
[213.165466] Dynamic subtest bcs0: SKIP (0.000s)
[213.175454] Starting dynamic subtest: vcs0
[213.180279] Dynamic subtest vcs0: SKIP (0.000s)
[213.189544] Starting dynamic subtest: vcs1
[213.194684] Dynamic subtest vcs1: SKIP (0.000s)
[213.203381] Starting dynamic subtest: vecs0
[213.208455] Dynamic subtest vecs0: SKIP (0.000s)
[213.217791] Starting dynamic subtest: ccs0
[213.223388] Dynamic subtest ccs0: SKIP (0.000s)
[213.228647] Subtest busy-check-all: SKIP (0.008s)
[213.266059] [038/133] (810s left) drm_read (fault-buffer)
[213.433276] Starting subtest: fault-buffer
[213.435888] Subtest fault-buffer: SUCCESS (0.001s)
[213.545943] [039/133] (810s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[213.640422] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[214.797426] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.157s)
[214.903865] [040/133] (809s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[214.997043] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[214.998943] Starting dynamic subtest: pipe-A-eDP-1
[215.820636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[215.829290] Starting dynamic subtest: pipe-B-eDP-1
[217.325218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.498s)
[217.335582] Starting dynamic subtest: pipe-C-eDP-1
[218.859056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.533s)
[218.869567] Starting dynamic subtest: pipe-D-eDP-1
[220.351875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[220.353954] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.346s)
[221.536692] [041/133] (802s left) gem_ctx_shared (create-shared-gtt)
[221.594518] Starting subtest: create-shared-gtt
[223.808484] Subtest create-shared-gtt: SUCCESS (2.152s)
[224.049463] [042/133] (800s left) gem_sync (basic-store-each)
[224.128513] Starting subtest: basic-store-each
[226.455991] Subtest basic-store-each: SUCCESS (2.341s)
[226.644918] [043/133] (797s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[226.756072] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[226.758719] Starting dynamic subtest: A-eDP1
[235.682914] Dynamic subtest A-eDP1: SUCCESS (8.927s)
[235.692239] Starting dynamic subtest: B-eDP1
[244.618036] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[244.639444] Starting dynamic subtest: C-eDP1
[253.576578] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[253.586525] Starting dynamic subtest: D-eDP1
[262.511530] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[262.514430] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.717s)
[263.691622] [044/133] (760s left) i915_pm_freq_api (freq-basic-api)
[263.754560] Starting subtest: freq-basic-api
[263.757313] Starting dynamic subtest: gt0
[263.759573] Dynamic subtest gt0: SUCCESS (0.003s)
[263.768818] Starting dynamic subtest: gt1
[263.771163] Dynamic subtest gt1: SUCCESS (0.003s)
[263.773416] Subtest freq-basic-api: SUCCESS (0.008s)
[263.860826] [045/133] (760s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[263.957107] Starting subtest: plane-use-after-nonblocking-unbind
[263.959488] Starting dynamic subtest: pipe-A-eDP-1
[264.019113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[264.329162] Starting dynamic subtest: pipe-B-eDP-1
[265.095372] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[265.392938] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.438s)
[266.234704] [046/133] (758s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[266.349651] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[266.354277] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[266.431604] [047/133] (758s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[266.527875] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[266.532934] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[266.639815] [048/133] (758s left) kms_getfb (getfb2-handle-closed)
[266.723766] Starting subtest: getfb2-handle-closed
[266.726334] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[266.807571] [049/133] (757s left) kms_psr (fbc-pr-no-drrs)
[266.903388] Starting subtest: fbc-pr-no-drrs
[266.908675] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[266.973986] [050/133] (757s left) drm_read (short-buffer-nonblock)
[267.123300] Starting subtest: short-buffer-nonblock
[267.125902] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[267.240483] [051/133] (757s left) gen9_exec_parse (bb-secure)
[267.303416] Subtest bb-secure: SKIP (0.000s)
[267.389524] [052/133] (757s left) kms_psr (fbc-pr-sprite-render)
[267.485509] Starting subtest: fbc-pr-sprite-render
[267.490386] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[267.559814] [053/133] (757s left) kms_big_fb (linear-64bpp-rotate-0)
[267.662708] Starting subtest: linear-64bpp-rotate-0
[269.285351] Subtest linear-64bpp-rotate-0: SUCCESS (1.622s)
[269.440456] [054/133] (755s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[269.554375] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[269.558998] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[269.628854] [055/133] (755s left) gem_exec_balancer (full)
[269.707968] Starting subtest: full
[274.314222] Subtest full: SUCCESS (4.607s)
[274.616760] [056/133] (750s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[274.725706] Starting subtest: plane-upscale-20x20-with-pixel-format
[274.728563] Starting dynamic subtest: pipe-A
[275.783418] Dynamic subtest pipe-A: SUCCESS (1.061s)
[275.793071] Starting dynamic subtest: pipe-B
[277.923122] Dynamic subtest pipe-B: SUCCESS (2.139s)
[277.932287] Starting dynamic subtest: pipe-C
[279.133688] Dynamic subtest pipe-C: SUCCESS (1.209s)
[279.144946] Starting dynamic subtest: pipe-D
[280.356992] Dynamic subtest pipe-D: SUCCESS (1.223s)
[280.359587] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.636s)
[281.545642] [057/133] (743s left) kms_flip (modeset-vs-vblank-race-interruptible)
[281.636899] Starting subtest: modeset-vs-vblank-race-interruptible
[281.639408] Starting dynamic subtest: A-eDP1
[286.275349] Dynamic subtest A-eDP1: SUCCESS (4.638s)
[286.285903] Starting dynamic subtest: B-eDP1
[290.993604] Dynamic subtest B-eDP1: SUCCESS (4.717s)
[291.006083] Starting dynamic subtest: C-eDP1
[295.530894] Dynamic subtest C-eDP1: SUCCESS (4.537s)
[295.540483] Starting dynamic subtest: D-eDP1
[300.149027] Dynamic subtest D-eDP1: SUCCESS (4.617s)
[300.155281] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.523s)
[301.317124] [058/133] (723s left) i915_pm_rps (engine-order)
[301.377361] Starting subtest: engine-order
[306.447204] Subtest engine-order: SUCCESS (5.068s)
[306.562764] [059/133] (718s left) kms_plane_cursor (overlay)
[306.663502] Starting subtest: overlay
[306.669651] Starting dynamic subtest: pipe-A-eDP-1-size-64
[309.175213] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.512s)
[309.234522] Starting dynamic subtest: pipe-A-eDP-1-size-128
[311.732577] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.505s)
[311.793124] Starting dynamic subtest: pipe-A-eDP-1-size-256
[314.345385] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s)
[314.696707] Starting dynamic subtest: pipe-B-eDP-1-size-64
[317.920962] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.234s)
[317.980054] Starting dynamic subtest: pipe-B-eDP-1-size-128
[320.522105] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.548s)
[320.581673] Starting dynamic subtest: pipe-B-eDP-1-size-256
[323.057196] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.483s)
[323.414322] Starting dynamic subtest: pipe-C-eDP-1-size-64
[326.199192] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.795s)
[326.236177] Starting dynamic subtest: pipe-C-eDP-1-size-128
[328.399171] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s)
[328.436653] Starting dynamic subtest: pipe-C-eDP-1-size-256
[330.556966] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[330.901915] Starting dynamic subtest: pipe-D-eDP-1-size-64
[333.704580] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.814s)
[333.741038] Starting dynamic subtest: pipe-D-eDP-1-size-128
[335.814100] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[335.851897] Starting dynamic subtest: pipe-D-eDP-1-size-256
[337.937391] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.092s)
[338.257308] Subtest overlay: SUCCESS (31.586s)
[339.058398] [060/133] (686s left) kms_sequence (queue-busy)
[339.158400] Starting subtest: queue-busy
[339.161036] Starting dynamic subtest: pipe-A-eDP-1
[341.089671] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[341.099878] Starting dynamic subtest: pipe-B-eDP-1
[343.661256] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.570s)
[343.671926] Starting dynamic subtest: pipe-C-eDP-1
[346.268667] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.604s)
[346.279021] Starting dynamic subtest: pipe-D-eDP-1
[348.820591] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[348.823436] Subtest queue-busy: SUCCESS (9.660s)
[349.600134] [061/133] (675s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[349.699659] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[349.702487] Starting dynamic subtest: A-eDP1
[353.329393] Dynamic subtest A-eDP1: SUCCESS (3.630s)
[353.340254] Starting dynamic subtest: B-eDP1
[356.523589] Dynamic subtest B-eDP1: SUCCESS (3.194s)
[356.534434] Starting dynamic subtest: C-eDP1
[359.643365] Dynamic subtest C-eDP1: SUCCESS (3.115s)
[359.656986] Starting dynamic subtest: D-eDP1
[362.757654] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[362.760448] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.061s)
[363.555480] [062/133] (661s left) gem_flink_basic (double-flink)
[363.612511] Starting subtest: double-flink
[363.615491] Subtest double-flink: SUCCESS (0.000s)
[363.705958] [063/133] (661s left) gem_ctx_isolation (dirty-switch)
[363.770497] Starting subtest: dirty-switch
[363.773258] Starting dynamic subtest: rcs0
[363.974672] Dynamic subtest rcs0: SUCCESS (0.204s)
[363.985808] Starting dynamic subtest: bcs0
[364.222117] Dynamic subtest bcs0: SUCCESS (0.246s)
[364.234673] Starting dynamic subtest: vcs0
[364.473361] Dynamic subtest vcs0: SUCCESS (0.249s)
[364.484514] Starting dynamic subtest: vcs1
[365.589655] Dynamic subtest vcs1: SUCCESS (1.115s)
[365.599555] Starting dynamic subtest: vecs0
[367.712336] Dynamic subtest vecs0: SUCCESS (2.122s)
[367.723602] Starting dynamic subtest: ccs0
[369.709197] Dynamic subtest ccs0: SUCCESS (1.996s)
[369.712223] Subtest dirty-switch: SUCCESS (5.939s)
[369.950013] [064/133] (655s left) kms_cursor_edge_walk (64x64-top-edge)
[370.046466] Starting subtest: 64x64-top-edge
[370.049138] Starting dynamic subtest: pipe-A-eDP-1
[373.516396] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[373.527651] Starting dynamic subtest: pipe-D-eDP-1
[376.644031] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[376.646296] Subtest 64x64-top-edge: SUCCESS (6.598s)
[377.448053] [065/133] (647s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[377.557312] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[377.559939] Starting dynamic subtest: pipe-A-eDP-1
[377.588322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.598248] Starting dynamic subtest: pipe-B-eDP-1
[377.625763] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.634941] Starting dynamic subtest: pipe-C-eDP-1
[377.662553] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.671641] Starting dynamic subtest: pipe-D-eDP-1
[377.700313] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.705347] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[379.802693] [066/133] (645s left) gem_eio (hibernate)
[380.028501] Starting subtest: hibernate
[394.725836] Subtest hibernate: SUCCESS (14.696s)
[403.910093] [067/133] (630s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[404.032488] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[404.043224] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[404.120233] [068/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[404.220426] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[404.225546] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[404.312486] [069/133] (630s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[404.409304] Starting subtest: extended-modeset-hang-newfb-with-reset
[404.412044] Starting dynamic subtest: pipe-A
[419.288346] Dynamic subtest pipe-A: SUCCESS (14.879s)
[419.299650] Starting dynamic subtest: pipe-D
[435.071942] Dynamic subtest pipe-D: SUCCESS (15.782s)
[435.074668] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.665s)
[435.871244] [070/133] (598s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[435.969428] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[435.974293] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[436.041978] [071/133] (598s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[436.143536] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[439.890579] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.753s)
[441.069208] [072/133] (593s left) sysfs_preempt_timeout (invalid)
[441.139488] Starting subtest: invalid
[441.142448] Starting dynamic subtest: vecs0
[441.145291] Dynamic subtest vecs0: SUCCESS (0.000s)
[441.155697] Starting dynamic subtest: ccs0
[441.158202] Dynamic subtest ccs0: SUCCESS (0.000s)
[441.167781] Starting dynamic subtest: vcs0
[441.170206] Dynamic subtest vcs0: SUCCESS (0.000s)
[441.179377] Starting dynamic subtest: bcs0
[441.181686] Dynamic subtest bcs0: SUCCESS (0.000s)
[441.191517] Starting dynamic subtest: rcs0
[441.193979] Dynamic subtest rcs0: SUCCESS (0.000s)
[441.203886] Starting dynamic subtest: vcs1
[441.206698] Dynamic subtest vcs1: SUCCESS (0.000s)
[441.209087] Subtest invalid: SUCCESS (0.005s)
[441.254163] [073/133] (593s left) gem_exec_big (single)
[441.313442] Starting subtest: single
[445.032539] Subtest single: FAIL (3.645s)
[445.075528] [074/133] (589s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[445.218360] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[445.220962] Starting dynamic subtest: pipe-A-eDP-1
[445.290746] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[445.301405] Starting dynamic subtest: pipe-B-eDP-1
[445.369892] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[445.380464] Starting dynamic subtest: pipe-C-eDP-1
[445.448388] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[445.459279] Starting dynamic subtest: pipe-D-eDP-1
[445.524255] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[445.528918] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[447.515952] [075/133] (587s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[447.613217] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[448.680146] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.068s)
[448.809008] [076/133] (586s left) kms_chamelium_hpd (dp-hpd-storm)
[449.195412] Subtest dp-hpd-storm: SKIP (0.000s)
[450.032047] [077/133] (584s left) i915_query (query-topology-kernel-writes)
[450.092927] Starting subtest: query-topology-kernel-writes
[450.095512] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[450.169340] [078/133] (584s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[450.255244] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[450.260309] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[450.327159] [079/133] (584s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[450.393126] Starting subtest: invalid-bsd2-flag-on-blt
[450.395707] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[450.498094] [080/133] (584s left) sw_sync (sync_busy_fork)
[450.546222] Starting subtest: sync_busy_fork
[451.564333] Subtest sync_busy_fork: SUCCESS (1.016s)
[451.642518] [081/133] (583s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[451.709215] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[451.711951] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[451.810835] [082/133] (583s left) kms_chamelium_frames (hdmi-crc-fast)
[452.197668] Subtest hdmi-crc-fast: SKIP (0.000s)
[452.983465] [083/133] (582s left) gem_flink_basic (flink-lifetime)
[453.043983] Starting subtest: flink-lifetime
[453.046210] Subtest flink-lifetime: SUCCESS (0.004s)
[453.144936] [084/133] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[453.244971] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[453.250147] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[453.341426] [085/133] (581s left) kms_prop_blob (basic)
[453.412210] Starting subtest: basic
[453.414500] Subtest basic: SUCCESS (0.000s)
[453.512130] [086/133] (581s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[453.574651] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[453.679877] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[453.759069] [087/133] (581s left) perf (blocking-parameterized)
[453.905904] Starting subtest: blocking-parameterized
[473.977718] Subtest blocking-parameterized: SUCCESS (20.024s)
[474.021480] [088/133] (561s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[474.086553] Starting subtest: etime-multi-wait-all-submitted-signaled
[474.191185] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[474.289524] [089/133] (561s left) gem_exec_fence (submit-chain)
[474.487210] Starting subtest: submit-chain
[474.518222] Subtest submit-chain: SUCCESS (0.035s)
[476.519096] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[476.522912] [090/133] (558s left) gem_exec_params (mmapped)
[476.596682] Starting subtest: mmapped
[476.599684] Subtest mmapped: SUCCESS (0.006s)
[476.714115] [091/133] (558s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[476.814519] Starting subtest: x-tiled-32bpp-rotate-180
[478.205390] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[478.332663] [092/133] (557s left) sw_sync (sync_expired_merge)
[478.370654] Starting subtest: sync_expired_merge
[479.444690] Subtest sync_expired_merge: SUCCESS (1.074s)
[479.517493] [093/133] (556s left) prime_vgem (basic-fence-mmap)
[479.591148] Starting subtest: basic-fence-mmap
[479.596462] Subtest basic-fence-mmap: SKIP (0.000s)
[479.697415] [094/133] (555s left) gem_ctx_shared (disjoint-timelines)
[479.758016] Starting subtest: disjoint-timelines
[479.778406] Subtest disjoint-timelines: SUCCESS (0.020s)
[480.004516] [095/133] (555s left) kms_psr (psr-dpms)
[480.094708] Starting subtest: psr-dpms
[480.097603] Starting dynamic subtest: eDP-1
[483.020300] Dynamic subtest eDP-1: SUCCESS (2.927s)
[483.022980] Subtest psr-dpms: SUCCESS (2.928s)
[483.884080] [096/133] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[483.979985] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[491.325341] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.349s)
[491.426308] [097/133] (544s left) gem_softpin (allocator-nopin)
[491.492233] Starting subtest: allocator-nopin
[491.598894] Subtest allocator-nopin: SUCCESS (0.106s)
[491.714872] [098/133] (544s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[491.807009] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[491.809588] Starting dynamic subtest: pipe-A-default-mode
[492.981665] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[492.986659] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.174s)
[493.129042] [099/133] (542s left) gem_exec_flush (basic-wb-pro-default)
[493.190110] Starting subtest: basic-wb-pro-default
[498.692364] Subtest basic-wb-pro-default: SUCCESS (5.462s)
[498.840518] [100/133] (537s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[498.944062] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[498.946668] Starting dynamic subtest: pipe-A-eDP-1
[499.045500] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[499.057405] Starting dynamic subtest: pipe-B-eDP-1
[500.216032] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[500.221192] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.276s)
[501.408010] [101/133] (534s left) syncobj_timeline (single-wait-available-submitted)
[501.469402] Starting subtest: single-wait-available-submitted
[501.472087] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[501.580030] [102/133] (534s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[501.646425] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[501.652240] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[501.828224] [103/133] (534s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[501.931570] Starting subtest: psr-rgb101010-draw-pwrite
[509.604503] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.678s)
[509.719986] [104/133] (526s left) perf (gen8-unprivileged-single-ctx-counters)
[509.837206] Starting subtest: gen8-unprivileged-single-ctx-counters
[509.842459] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[509.885297] [105/133] (526s left) api_intel_allocator (standalone)
[509.951510] Starting subtest: standalone
[509.969008] Subtest standalone: SUCCESS (0.021s)
[510.083858] [106/133] (526s left) kms_getfb (getfb-handle-closed)
[510.206342] Starting subtest: getfb-handle-closed
[510.209198] Subtest getfb-handle-closed: SUCCESS (0.000s)
[510.302263] [107/133] (525s left) perf (mi-rpc)
[510.387445] Starting subtest: mi-rpc
[510.393039] Subtest mi-rpc: SKIP (0.000s)
[510.438287] [108/133] (525s left) kms_async_flips (async-flip-dpms)
[510.521654] Starting subtest: async-flip-dpms
[510.902142] Starting dynamic subtest: pipe-A-eDP-1
[514.687363] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.783s)
[515.068250] Starting dynamic subtest: pipe-B-eDP-1
[517.862244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.801s)
[518.243875] Starting dynamic subtest: pipe-C-eDP-1
[521.009932] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s)
[521.383764] Starting dynamic subtest: pipe-D-eDP-1
[524.162349] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.785s)
[524.164674] Subtest async-flip-dpms: SUCCESS (13.642s)
[525.343714] [109/133] (510s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[525.441219] Starting subtest: y-tiled-64bpp-rotate-180
[525.446496] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[525.541316] [110/133] (510s left) gem_close_race (multigpu-basic-process)
[525.610760] Starting subtest: multigpu-basic-process
[525.616191] Subtest multigpu-basic-process: SKIP (0.000s)
[525.835253] [111/133] (510s left) kms_cursor_crc (cursor-offscreen-32x10)
[525.998459] Starting subtest: cursor-offscreen-32x10
[526.042529] Subtest cursor-offscreen-32x10: SKIP (0.040s)
[526.300968] [112/133] (510s left) gem_exec_flush (basic-wb-rw-default)
[526.361664] Starting subtest: basic-wb-rw-default
[531.860711] Subtest basic-wb-rw-default: SUCCESS (5.463s)
[532.017520] [113/133] (504s left) dmabuf_sync_file (export-before-signal)
[532.063508] Starting subtest: export-before-signal
[532.066028] Subtest export-before-signal: SUCCESS (0.001s)
[532.125254] [114/133] (504s left) gem_exec_schedule (preempt-queue-contexts-chain)
[532.205525] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[532.495522] [115/133] (504s left) perf_pmu (semaphore-wait)
[532.541026] Starting subtest: semaphore-wait
[532.543687] Starting dynamic subtest: rcs0
[533.051301] Dynamic subtest rcs0: SUCCESS (0.513s)
[533.064429] Starting dynamic subtest: bcs0
[533.568146] Dynamic subtest bcs0: SUCCESS (0.514s)
[533.580671] Starting dynamic subtest: vcs0
[534.081580] Dynamic subtest vcs0: SUCCESS (0.511s)
[534.111646] Starting dynamic subtest: vcs1
[534.596640] Dynamic subtest vcs1: SUCCESS (0.513s)
[534.612770] Starting dynamic subtest: vecs0
[535.113821] Dynamic subtest vecs0: SUCCESS (0.512s)
[535.126503] Starting dynamic subtest: ccs0
[535.628230] Dynamic subtest ccs0: SUCCESS (0.513s)
[535.631426] Subtest semaphore-wait: SUCCESS (3.094s)
[535.750443] [116/133] (500s left) gem_basic (multigpu-create-close)
[535.811782] Starting subtest: multigpu-create-close
[535.816493] Subtest multigpu-create-close: SKIP (0.000s)
[535.915360] [117/133] (500s left) kms_vblank (query-idle)
[536.016046] Starting subtest: query-idle
[536.018318] Starting dynamic subtest: pipe-A-eDP-1
[537.756368] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[537.776290] Starting dynamic subtest: pipe-D-eDP-1
[540.176505] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s)
[540.179652] Subtest query-idle: SUCCESS (4.164s)
[540.996752] [118/133] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[541.089945] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[541.094572] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[541.186658] [119/133] (495s left) syncobj_timeline (reset-during-wait-for-submit)
[541.236804] Starting subtest: reset-during-wait-for-submit
[541.339042] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[541.421438] [120/133] (495s left) i915_suspend (basic-s3-without-i915)
[541.458985] Starting subtest: basic-s3-without-i915
[543.189531] Subtest basic-s3-without-i915: SKIP (1.727s)
[545.641871] [121/133] (491s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[545.757647] Starting subtest: plane-primary-toggle-with-vblank-wait
[545.760472] Starting dynamic subtest: pipe-A-eDP-1
[545.928586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.172s)
[546.236464] Starting dynamic subtest: pipe-B-eDP-1
[547.156539] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.930s)
[547.453559] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.698s)
[548.315363] [122/133] (488s left) kms_psr (fbc-psr-primary-blt)
[548.416460] Starting subtest: fbc-psr-primary-blt
[548.418843] Starting dynamic subtest: eDP-1
[548.423569] Dynamic subtest eDP-1: SKIP (0.000s)
[548.428462] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[548.491299] [123/133] (488s left) gem_mmap (bad-offset)
[548.555494] Subtest bad-offset: SKIP (0.000s)
[548.620310] [124/133] (488s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[548.715441] Starting subtest: yf-tiled-8bpp-rotate-0
[548.720521] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[548.806926] [125/133] (488s left) gem_exec_flush (basic-batch-kernel-default-wb)
[548.879291] Starting subtest: basic-batch-kernel-default-wb
[554.929455] Subtest basic-batch-kernel-default-wb: SUCCESS (6.054s)
[555.124698] [126/133] (481s left) perf (invalid-oa-format-id)
[555.244565] Starting subtest: invalid-oa-format-id
[555.257730] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[555.299346] [127/133] (481s left) kms_async_flips (test-time-stamp)
[555.393220] Starting subtest: test-time-stamp
[555.785563] Starting dynamic subtest: pipe-A-eDP-1
[556.622966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[556.993643] Starting dynamic subtest: pipe-B-eDP-1
[557.758712] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[558.123445] Starting dynamic subtest: pipe-C-eDP-1
[558.884640] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[559.249353] Starting dynamic subtest: pipe-D-eDP-1
[560.010490] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[560.013656] Subtest test-time-stamp: SUCCESS (4.615s)
[561.182857] [128/133] (475s left) kms_content_protection (legacy-hdcp14)
[561.324151] Starting subtest: legacy-hdcp14
[561.329473] Subtest legacy-hdcp14: SKIP (0.000s)
[561.450052] [129/133] (475s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[561.535301] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[561.537757] Starting dynamic subtest: pipe-A-eDP-1
[578.284828] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.454s)
[578.298381] Starting dynamic subtest: pipe-B-eDP-1
[595.273255] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.471s)
[595.285253] Starting dynamic subtest: pipe-C-eDP-1
[612.203573] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.395s)
[612.214016] Starting dynamic subtest: pipe-D-eDP-1
[629.215365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.397s)
[629.218321] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.722s)
[630.432158] [130/133] (406s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[630.536129] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[637.183334] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.674s)
[637.304630] [131/133] (399s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[637.630929] Starting subtest: cursor-rapid-movement-max-size
[637.639039] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[637.765745] [132/133] (399s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[637.855678] Starting subtest: fbcpsr-suspend
[678.667018] Subtest fbcpsr-suspend: SUCCESS (10.126s)
[678.791039] [133/133] (358s left) api_intel_bb (reset-flags)
[678.860508] Starting subtest: reset-flags
[678.866988] Subtest reset-flags: SUCCESS (0.007s)
[678.984366] 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.