[57.954924] Initializing watchdogs
[57.954970]   /dev/watchdog0
[57.970429] [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.974663] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.976846] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.980361] [001/132] (960s left) gem_exec_schedule (fifo)
[58.075201] Starting subtest: fifo
[58.077374] Starting dynamic subtest: rcs0
[58.242013] Dynamic subtest rcs0: SUCCESS (0.172s)
[58.249564] Starting dynamic subtest: vcs0
[58.346325] Dynamic subtest vcs0: SUCCESS (0.105s)
[58.354310] Starting dynamic subtest: vcs1
[58.455679] Dynamic subtest vcs1: SUCCESS (0.112s)
[58.465712] Starting dynamic subtest: vecs0
[58.563698] Dynamic subtest vecs0: SUCCESS (0.109s)
[58.573662] Starting dynamic subtest: ccs0
[58.683702] Dynamic subtest ccs0: SUCCESS (0.121s)
[58.686500] Subtest fifo: SUCCESS (0.620s)
[60.049951] [002/132] (958s left) gem_pread (exhaustion)
[60.115718] Subtest exhaustion: SKIP (0.000s)
[60.208391] [003/132] (958s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[60.307261] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[60.311533] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[60.452558] [004/132] (958s left) syncobj_eventfd (invalid-illegal-eventfd)
[60.504625] Starting subtest: invalid-illegal-eventfd
[60.506570] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[60.626858] [005/132] (958s left) kms_addfb_basic (invalid-get-prop)
[60.686811] Starting subtest: invalid-get-prop
[60.688774] Subtest invalid-get-prop: SUCCESS (0.000s)
[60.824058] [006/132] (957s left) gem_mmap_gtt (basic-small-copy)
[60.881804] Subtest basic-small-copy: SKIP (0.000s)
[60.933192] [007/132] (957s left) sw_sync (sync_busy_fork_unixsocket)
[60.968691] Starting subtest: sync_busy_fork_unixsocket
[60.974909] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[61.022974] [008/132] (957s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[61.071232] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[61.177314] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[61.247204] [009/132] (957s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[61.295922] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[61.298233] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[61.386379] [010/132] (957s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[61.765837] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[62.601328] [011/132] (956s left) kms_psr (psr2-cursor-mmap-cpu)
[62.688258] Starting subtest: psr2-cursor-mmap-cpu
[62.690644] Starting dynamic subtest: eDP-1
[64.387308] Dynamic subtest eDP-1: SUCCESS (1.708s)
[64.389654] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.709s)
[65.177477] [012/132] (953s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[65.228832] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[65.233105] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[65.420751] [013/132] (953s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[65.503066] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[65.505399] Starting dynamic subtest: pipe-A-eDP-1
[66.024584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[66.032674] Starting dynamic subtest: pipe-B-eDP-1
[67.576310] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.554s)
[67.585642] Starting dynamic subtest: pipe-C-eDP-1
[69.032426] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.460s)
[69.045077] Starting dynamic subtest: pipe-D-eDP-1
[70.447310] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.417s)
[70.449666] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.931s)
[71.605658] [014/132] (947s left) gem_exec_capture (pi)
[71.682105] Starting subtest: pi
[71.684501] Starting dynamic subtest: rcs0
[75.897828] Dynamic subtest rcs0: SUCCESS (4.223s)
[75.905581] Starting dynamic subtest: bcs0
[79.863784] Dynamic subtest bcs0: SUCCESS (3.967s)
[79.871505] Starting dynamic subtest: vcs0
[83.851779] Dynamic subtest vcs0: SUCCESS (3.986s)
[83.859466] Starting dynamic subtest: vcs1
[87.850231] Dynamic subtest vcs1: SUCCESS (3.996s)
[87.857880] Starting dynamic subtest: vecs0
[91.835783] Dynamic subtest vecs0: SUCCESS (3.984s)
[91.844530] Starting dynamic subtest: ccs0
[95.850319] Dynamic subtest ccs0: SUCCESS (4.013s)
[95.853878] Subtest pi: SUCCESS (24.175s)
[95.931255] [015/132] (923s left) kms_pm_rpm (system-suspend-modeset)
[98.042542] Starting subtest: system-suspend-modeset
[117.734196] Subtest system-suspend-modeset: SUCCESS (4.529s)
[118.116891] [016/132] (901s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[118.228237] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[118.230450] Starting dynamic subtest: pipe-A-eDP-1
[129.374827] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.334s)
[129.393966] Starting dynamic subtest: pipe-B-eDP-1
[141.382059] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.066s)
[141.384423] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.402s)
[142.209387] [017/132] (877s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[142.308749] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[142.313192] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[142.379399] [018/132] (876s left) gem_partial_pwrite_pread (write-display)
[142.448506] Subtest write-display: SKIP (0.000s)
[142.530734] [019/132] (876s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[142.627862] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[142.630219] Starting dynamic subtest: pipe-A
[142.657428] Dynamic subtest pipe-A: SKIP (0.024s)
[142.669160] Starting dynamic subtest: pipe-B
[142.690175] Dynamic subtest pipe-B: SKIP (0.033s)
[142.698701] Starting dynamic subtest: pipe-C
[142.723897] Dynamic subtest pipe-C: SKIP (0.032s)
[142.732662] Starting dynamic subtest: pipe-D
[142.755652] Dynamic subtest pipe-D: SKIP (0.033s)
[142.760043] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.124s)
[142.841086] [020/132] (876s left) gem_exec_parallel (contexts)
[142.908090] Starting subtest: contexts
[142.910448] Starting dynamic subtest: rcs0
[145.785212] Dynamic subtest rcs0: SUCCESS (2.879s)
[145.797105] Starting dynamic subtest: bcs0
[149.562729] Dynamic subtest bcs0: SUCCESS (3.775s)
[149.573927] Starting dynamic subtest: vcs0
[153.615116] Dynamic subtest vcs0: SUCCESS (4.049s)
[153.626499] Starting dynamic subtest: vcs1
[157.637145] Dynamic subtest vcs1: SUCCESS (4.020s)
[157.648028] Starting dynamic subtest: vecs0
[161.684270] Dynamic subtest vecs0: SUCCESS (4.046s)
[161.693546] Starting dynamic subtest: ccs0
[165.559879] Dynamic subtest ccs0: SUCCESS (3.875s)
[165.562696] Subtest contexts: SUCCESS (22.653s)
[165.762248] [021/132] (853s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[165.857760] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[165.860076] Starting dynamic subtest: pipe-A-default-mode
[168.557874] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[168.560188] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.701s)
[169.418419] [022/132] (850s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[169.525868] Starting subtest: plane-downscale-factor-0-5-with-rotation
[169.528171] Starting dynamic subtest: pipe-A
[169.546287] Dynamic subtest pipe-A: SKIP (0.017s)
[169.556069] Starting dynamic subtest: pipe-B
[169.577942] Dynamic subtest pipe-B: SKIP (0.032s)
[169.587192] Starting dynamic subtest: pipe-C
[169.609884] Dynamic subtest pipe-C: SKIP (0.031s)
[169.618374] Starting dynamic subtest: pipe-D
[169.640913] Dynamic subtest pipe-D: SKIP (0.031s)
[169.644792] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.113s)
[169.733908] [023/132] (849s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[169.829917] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[169.832256] Starting dynamic subtest: pipe-A-eDP-1
[169.856027] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.866490] Starting dynamic subtest: pipe-B-eDP-1
[169.888397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.897775] Starting dynamic subtest: pipe-C-eDP-1
[169.919254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.928087] Starting dynamic subtest: pipe-D-eDP-1
[169.950046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.954572] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[172.080134] [024/132] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[172.188234] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[172.192263] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[172.292942] [025/132] (847s left) kms_cursor_edge_walk (64x64-top-edge)
[172.395074] Starting subtest: 64x64-top-edge
[172.397447] Starting dynamic subtest: pipe-A-eDP-1
[175.849306] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[175.863770] Starting dynamic subtest: pipe-D-eDP-1
[178.986855] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[178.989165] Subtest 64x64-top-edge: SUCCESS (6.596s)
[179.787369] [026/132] (839s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[179.921390] Starting subtest: verify-pxp-stale-buf-optout-execution
[180.981016] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s)
[181.121469] [027/132] (838s left) gem_exec_params (invalid-ring2)
[181.181930] Starting subtest: invalid-ring2
[181.183935] Subtest invalid-ring2: SUCCESS (0.000s)
[181.273689] [028/132] (838s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[181.397831] Starting subtest: flip-vs-cursor-crc-legacy
[182.087174] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.691s)
[182.926395] [029/132] (836s left) gem_exec_params (rsvd2-dirt)
[182.993199] Starting subtest: rsvd2-dirt
[182.997461] Subtest rsvd2-dirt: SKIP (0.000s)
[183.095637] [030/132] (836s left) kms_vrr (seamless-rr-switch-vrr)
[183.187875] Starting subtest: seamless-rr-switch-vrr
[183.194162] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[183.259450] [031/132] (836s left) kms_atomic (plane-cursor-legacy)
[183.350542] Starting subtest: plane-cursor-legacy
[183.352880] Starting dynamic subtest: pipe-A-eDP-1
[183.717670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[183.720304] Subtest plane-cursor-legacy: SUCCESS (0.369s)
[184.549870] [032/132] (835s left) kms_pm_rpm (cursor-dpms)
[186.271196] Starting subtest: cursor-dpms
[186.276235] Subtest cursor-dpms: SKIP (0.000s)
[186.792698] [033/132] (833s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[186.890773] Starting subtest: primary-4-tiled-reflect-x-0
[194.017283] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.131s)
[195.234271] [034/132] (824s left) drm_buddy (drm_buddy)
[195.284323] Starting subtest: drm_buddy
[195.288958] Subtest drm_buddy: SKIP (0.001s)
[195.332539] [035/132] (824s left) kms_busy (extended-pageflip-hang-oldfb)
[195.419742] Starting subtest: extended-pageflip-hang-oldfb
[195.421995] Starting dynamic subtest: pipe-A
[195.817213] Dynamic subtest pipe-A: SUCCESS (0.394s)
[195.842589] Starting dynamic subtest: pipe-D
[196.957142] Dynamic subtest pipe-D: SUCCESS (1.136s)
[196.959432] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.538s)
[197.798528] [036/132] (822s left) gem_readwrite (beyond-eob)
[197.862830] Subtest beyond-EOB: SKIP (0.000s)
[197.928046] [037/132] (822s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[198.031470] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[205.048517] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.023s)
[205.171179] [038/132] (814s left) syncobj_timeline (wait-zero-handles)
[205.230855] Starting subtest: wait-zero-handles
[205.233149] Subtest wait-zero-handles: SUCCESS (0.000s)
[205.337541] [039/132] (814s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[205.398149] Starting subtest: multi-wait-all-available-submitted-signaled
[205.400469] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[205.503967] [040/132] (814s left) gem_exec_async (forked-writes)
[205.568518] Starting subtest: forked-writes
[205.570851] Starting dynamic subtest: rcs0
[205.595134] Dynamic subtest rcs0: SUCCESS (0.026s)
[205.605045] Starting dynamic subtest: bcs0
[205.620863] Dynamic subtest bcs0: SUCCESS (0.025s)
[205.629823] Starting dynamic subtest: vcs0
[205.645204] Dynamic subtest vcs0: SUCCESS (0.024s)
[205.654011] Starting dynamic subtest: vcs1
[205.668908] Dynamic subtest vcs1: SUCCESS (0.023s)
[205.677934] Starting dynamic subtest: vecs0
[205.695300] Dynamic subtest vecs0: SUCCESS (0.026s)
[205.704839] Starting dynamic subtest: ccs0
[205.717371] Dynamic subtest ccs0: SUCCESS (0.021s)
[205.719826] Subtest forked-writes: SUCCESS (0.149s)
[205.974568] [041/132] (814s left) kms_plane_multiple (tiling-none)
[206.073033] Starting subtest: tiling-none
[206.075325] Starting dynamic subtest: pipe-A-eDP-1
[209.820614] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.748s)
[209.830195] Starting dynamic subtest: pipe-B-eDP-1
[214.243287] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.422s)
[214.252770] Starting dynamic subtest: pipe-C-eDP-1
[218.565392] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[218.574365] Starting dynamic subtest: pipe-D-eDP-1
[222.919054] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.349s)
[222.921335] Subtest tiling-none: SUCCESS (16.843s)
[223.720504] [042/132] (796s left) i915_pm_rpm (gem-pread)
[225.363354] Starting subtest: gem-pread
[227.329305] Subtest gem-pread: SUCCESS (1.969s)
[227.418352] [043/132] (792s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[227.526474] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[227.528390] Starting dynamic subtest: pipe-A-eDP-1
[230.003869] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.475s)
[230.012170] Starting dynamic subtest: pipe-B-eDP-1
[232.352301] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.345s)
[232.361393] Starting dynamic subtest: pipe-C-eDP-1
[234.639252] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.286s)
[234.648609] Starting dynamic subtest: pipe-D-eDP-1
[236.811160] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[236.813186] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.283s)
[238.025395] [044/132] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[238.131051] Starting subtest: psr-rgb565-draw-pwrite
[245.114111] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.986s)
[245.237610] [045/132] (775s left) kms_invalid_mode (zero-vdisplay)
[245.331819] Starting subtest: zero-vdisplay
[245.334033] Starting dynamic subtest: pipe-A-eDP-1
[245.617035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[245.625867] Starting dynamic subtest: pipe-B-eDP-1
[245.627725] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[245.635947] Starting dynamic subtest: pipe-C-eDP-1
[245.638243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[245.646834] Starting dynamic subtest: pipe-D-eDP-1
[245.649115] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[245.651295] Subtest zero-vdisplay: SUCCESS (0.290s)
[246.473138] [046/132] (773s left) gen9_exec_parse (bb-chained)
[246.552491] Subtest bb-chained: SKIP (0.000s)
[246.611392] [047/132] (773s left) kms_psr (fbc-psr-cursor-plane-move)
[246.703710] Starting subtest: fbc-psr-cursor-plane-move
[246.705965] Starting dynamic subtest: eDP-1
[246.710297] Dynamic subtest eDP-1: SKIP (0.000s)
[246.714687] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[246.777191] [048/132] (773s left) kms_vblank (ts-continuation-idle)
[246.877697] Starting subtest: ts-continuation-idle
[246.879821] Starting dynamic subtest: pipe-A-eDP-1
[247.274234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[247.289258] Starting dynamic subtest: pipe-D-eDP-1
[248.358549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.084s)
[248.360804] Subtest ts-continuation-idle: SUCCESS (1.482s)
[249.228500] [049/132] (771s left) gem_mmap_gtt (hang-user)
[249.289910] Subtest hang-user: SKIP (0.000s)
[249.346862] [050/132] (771s left) kms_chamelium_audio (hdmi-audio-edid)
[249.736395] Subtest hdmi-audio-edid: SKIP (0.000s)
[250.538996] [051/132] (770s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[250.645337] Starting subtest: psr-rgb101010-draw-pwrite
[258.357033] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.717s)
[258.457179] [052/132] (762s left) kms_content_protection (legacy-hdcp14)
[258.592362] Starting subtest: legacy-hdcp14
[258.597019] Subtest legacy-hdcp14: SKIP (0.000s)
[258.711865] [053/132] (761s left) i915_hangman (engine-engine-error)
[258.769866] Starting subtest: engine-engine-error
[258.772026] Starting dynamic subtest: rcs0
[260.085319] Dynamic subtest rcs0: SUCCESS (1.315s)
[260.099967] Starting dynamic subtest: bcs0
[262.132334] Dynamic subtest bcs0: SUCCESS (2.045s)
[262.144308] Starting dynamic subtest: vcs0
[264.116680] Dynamic subtest vcs0: SUCCESS (1.982s)
[264.133812] Starting dynamic subtest: vcs1
[266.101217] Dynamic subtest vcs1: SUCCESS (1.981s)
[266.113616] Starting dynamic subtest: vecs0
[268.084670] Dynamic subtest vecs0: SUCCESS (1.981s)
[268.097398] Starting dynamic subtest: ccs0
[270.132704] Dynamic subtest ccs0: SUCCESS (2.045s)
[270.135671] Subtest engine-engine-error: SUCCESS (11.366s)
[270.232103] [054/132] (750s left) gem_softpin (evict-prime-sanity-check)
[270.289943] Starting subtest: evict-prime-sanity-check
[270.292306] Starting dynamic subtest: rcs0
[271.457890] Dynamic subtest rcs0: SUCCESS (1.167s)
[271.470096] Starting dynamic subtest: bcs0
[272.583617] Dynamic subtest bcs0: SUCCESS (1.123s)
[272.595441] Starting dynamic subtest: vcs0
[274.045683] Dynamic subtest vcs0: SUCCESS (1.459s)
[274.056190] Starting dynamic subtest: vcs1
[276.092648] Dynamic subtest vcs1: SUCCESS (2.046s)
[276.103454] Starting dynamic subtest: vecs0
[278.082495] Dynamic subtest vecs0: SUCCESS (1.988s)
[278.094158] Starting dynamic subtest: ccs0
[279.216183] Dynamic subtest ccs0: SUCCESS (1.133s)
[279.230354] Starting dynamic subtest: all
[280.336511] Dynamic subtest all: SUCCESS (1.117s)
[280.339064] Subtest evict-prime-sanity-check: SUCCESS (10.048s)
[280.414537] [055/132] (740s left) syncobj_basic (bad-handle-to-fd)
[280.467496] Starting subtest: bad-handle-to-fd
[280.469339] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[280.545759] [056/132] (740s left) kms_rotation_crc (primary-rotation-90)
[280.646475] Starting subtest: primary-rotation-90
[280.650856] Subtest primary-rotation-90: SKIP (0.001s)
[280.726858] [057/132] (740s left) kms_big_fb (linear-32bpp-rotate-180)
[280.827962] Starting subtest: linear-32bpp-rotate-180
[282.362682] Subtest linear-32bpp-rotate-180: SUCCESS (1.535s)
[282.494373] [058/132] (738s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[282.592592] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[282.604437] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[282.681908] [059/132] (738s left) kms_flip (2x-flip-vs-expired-vblank)
[282.777873] Starting subtest: 2x-flip-vs-expired-vblank
[282.786827] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[282.866638] [060/132] (738s left) i915_query (query-regions-garbage-items)
[282.922193] Starting subtest: query-regions-garbage-items
[282.923771] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[283.021526] [061/132] (737s left) kms_universal_plane (universal-plane-sanity)
[283.108417] Starting subtest: universal-plane-sanity
[283.110409] Starting dynamic subtest: pipe-A-eDP-1
[283.709842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[283.718761] Starting dynamic subtest: pipe-B-eDP-1
[284.905031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s)
[284.914983] Starting dynamic subtest: pipe-C-eDP-1
[286.111099] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[286.120760] Starting dynamic subtest: pipe-D-eDP-1
[287.342080] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[287.344323] Subtest universal-plane-sanity: SUCCESS (4.234s)
[288.205264] [062/132] (732s left) kms_psr (fbc-pr-sprite-render)
[288.295764] Starting subtest: fbc-pr-sprite-render
[288.299903] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[288.379000] [063/132] (732s left) kms_addfb_basic (addfb25-4-tiled)
[288.475901] Starting subtest: addfb25-4-tiled
[288.477739] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[288.564666] [064/132] (732s left) kms_color (legacy-gamma-reset)
[288.654574] Starting subtest: legacy-gamma-reset
[288.656571] Starting dynamic subtest: pipe-A-eDP-1
[289.040715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[289.049803] Starting dynamic subtest: pipe-B-eDP-1
[289.054714] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[289.063385] Starting dynamic subtest: pipe-C-eDP-1
[289.065683] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[289.075117] Starting dynamic subtest: pipe-D-eDP-1
[289.079794] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[289.082069] Subtest legacy-gamma-reset: SUCCESS (0.426s)
[289.854927] [065/132] (731s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[289.952011] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[290.553982] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[290.715727] [066/132] (730s left) api_intel_allocator (standalone)
[290.782606] Starting subtest: standalone
[290.797294] Subtest standalone: SUCCESS (0.016s)
[290.903562] [067/132] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[290.999372] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[294.484288] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.489s)
[295.644815] [068/132] (725s left) kms_plane (pixel-format-4-tiled-modifier)
[295.745247] Starting subtest: pixel-format-4-tiled-modifier
[295.770517] Starting dynamic subtest: pipe-A-plane-0
[296.403276] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[296.412358] Starting dynamic subtest: pipe-A-plane-3
[296.814350] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s)
[296.823334] Starting dynamic subtest: pipe-A-plane-5
[296.826702] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[297.916308] Starting dynamic subtest: pipe-B-plane-0
[298.609315] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[298.618511] Starting dynamic subtest: pipe-B-plane-3
[299.086484] Dynamic subtest pipe-B-plane-3: SUCCESS (0.476s)
[299.095659] Starting dynamic subtest: pipe-B-plane-5
[299.099098] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[299.396957] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.655s)
[300.200853] [069/132] (721s left) gem_lmem_swapping (smem-oom)
[300.248933] Subtest smem-oom: SKIP (0.000s)
[300.295059] [070/132] (721s left) gem_userptr_blits (dmabuf-unsync)
[300.353146] Subtest dmabuf-unsync: SKIP (0.000s)
[300.487044] [071/132] (720s left) gem_wait (invalid-buf)
[300.560189] Starting subtest: invalid-buf
[300.562507] Subtest invalid-buf: SUCCESS (0.000s)
[300.809252] [072/132] (720s left) gem_exec_fence (syncobj-channel)
[301.299198] Starting subtest: syncobj-channel
[302.317971] Subtest syncobj-channel: SUCCESS (1.015s)
[303.184111] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[303.187624] [073/132] (718s left) kms_getfb (getfb2-handle-zero)
[303.287736] Starting subtest: getfb2-handle-zero
[303.289960] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[303.403441] [074/132] (718s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[303.498821] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[303.501084] Starting dynamic subtest: pipe-A-eDP-1
[303.509860] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.520238] Starting dynamic subtest: pipe-B-eDP-1
[303.529046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.538348] Starting dynamic subtest: pipe-C-eDP-1
[303.546763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.555644] Starting dynamic subtest: pipe-D-eDP-1
[303.563784] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.567870] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[305.673095] [075/132] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[305.771727] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[328.827880] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.065s)
[328.960738] [076/132] (692s left) gem_exec_schedule (u-submit-golden-slice)
[329.038645] Starting subtest: u-submit-golden-slice
[329.040291] Starting dynamic subtest: rcs0
[329.068907] Dynamic subtest rcs0: SUCCESS (0.036s)
[329.080295] Starting dynamic subtest: bcs0
[329.097922] Dynamic subtest bcs0: SUCCESS (0.028s)
[329.106913] Starting dynamic subtest: vcs0
[329.134455] Dynamic subtest vcs0: SUCCESS (0.036s)
[329.145144] Starting dynamic subtest: vcs1
[329.163987] Dynamic subtest vcs1: SUCCESS (0.029s)
[329.172414] Starting dynamic subtest: vecs0
[329.196878] Dynamic subtest vecs0: SUCCESS (0.032s)
[329.205965] Starting dynamic subtest: ccs0
[329.233123] Dynamic subtest ccs0: SUCCESS (0.035s)
[329.234964] Subtest u-submit-golden-slice: SUCCESS (0.201s)
[330.237142] [077/132] (691s left) gem_wait (wait)
[330.301030] Starting subtest: wait
[330.303281] Starting dynamic subtest: all-engines
[332.118987] Dynamic subtest all-engines: SUCCESS (1.816s)
[332.131686] Starting dynamic subtest: rcs0
[333.166126] Dynamic subtest rcs0: SUCCESS (1.046s)
[333.177221] Starting dynamic subtest: bcs0
[334.212998] Dynamic subtest bcs0: SUCCESS (1.045s)
[334.224716] Starting dynamic subtest: vcs0
[335.257987] Dynamic subtest vcs0: SUCCESS (1.043s)
[335.269748] Starting dynamic subtest: vcs1
[336.303199] Dynamic subtest vcs1: SUCCESS (1.043s)
[336.314910] Starting dynamic subtest: vecs0
[337.348348] Dynamic subtest vecs0: SUCCESS (1.043s)
[337.360177] Starting dynamic subtest: ccs0
[338.395047] Dynamic subtest ccs0: SUCCESS (1.045s)
[338.397626] Subtest wait: SUCCESS (8.097s)
[338.594229] [078/132] (683s left) kms_lease (possible-crtcs-filtering)
[338.697646] Starting subtest: possible-crtcs-filtering
[338.702558] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[338.808641] [079/132] (682s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[338.921513] Starting subtest: basic-flip-before-cursor-atomic
[339.834401] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s)
[340.624694] [080/132] (681s left) gem_eio (in-flight-suspend)
[340.815157] Starting subtest: in-flight-suspend
[384.736306] Subtest in-flight-suspend: SUCCESS (14.258s)
[384.864807] [081/132] (636s left) kms_psr (pr-basic)
[384.956544] Starting subtest: pr-basic
[384.960568] Subtest pr-basic: SKIP (0.000s)
[385.038665] [082/132] (636s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[385.142860] Starting subtest: stress-xrgb8888-4tiled
[390.911200] Subtest stress-xrgb8888-4tiled: SUCCESS (5.947s)
[390.961942] [083/132] (630s left) gem_ctx_param (get-priority-new-ctx)
[391.021865] Starting subtest: get-priority-new-ctx
[391.023952] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[391.118200] [084/132] (630s left) gem_exec_balancer (full-pulse)
[391.172405] Starting subtest: full-pulse
[395.653989] Subtest full-pulse: SUCCESS (4.547s)
[395.963947] [085/132] (626s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[396.054233] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[396.058562] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[396.126283] [086/132] (625s left) gem_exec_flush (basic-uc-rw-default)
[396.189118] Starting subtest: basic-uc-rw-default
[401.612591] Subtest basic-uc-rw-default: SUCCESS (5.463s)
[401.800990] [087/132] (620s left) gem_ctx_persistence (engines-persistence)
[401.864220] Starting subtest: engines-persistence
[401.866278] Starting dynamic subtest: rcs0
[402.678288] Dynamic subtest rcs0: SUCCESS (0.821s)
[402.690917] Starting dynamic subtest: bcs0
[403.438600] Dynamic subtest bcs0: SUCCESS (0.761s)
[403.451127] Starting dynamic subtest: vcs0
[404.208237] Dynamic subtest vcs0: SUCCESS (0.770s)
[404.221087] Starting dynamic subtest: vcs1
[404.974336] Dynamic subtest vcs1: SUCCESS (0.767s)
[404.987260] Starting dynamic subtest: vecs0
[405.726225] Dynamic subtest vecs0: SUCCESS (0.752s)
[405.738663] Starting dynamic subtest: ccs0
[406.516024] Dynamic subtest ccs0: SUCCESS (0.790s)
[406.518605] Subtest engines-persistence: SUCCESS (4.674s)
[406.600511] [088/132] (615s left) kms_cursor_legacy (single-bo)
[406.717740] Starting subtest: single-bo
[406.719927] Starting dynamic subtest: pipe-A
[412.088412] Dynamic subtest pipe-A: SUCCESS (5.379s)
[412.099913] Starting dynamic subtest: pipe-B
[417.468324] Dynamic subtest pipe-B: SUCCESS (5.384s)
[417.484568] Starting dynamic subtest: pipe-C
[422.856115] Dynamic subtest pipe-C: SUCCESS (5.381s)
[422.868132] Starting dynamic subtest: pipe-D
[428.238404] Dynamic subtest pipe-D: SUCCESS (5.379s)
[428.250930] Starting dynamic subtest: all-pipes
[433.628286] Dynamic subtest all-pipes: SUCCESS (5.386s)
[433.630829] Subtest single-bo: SUCCESS (26.921s)
[433.787335] [089/132] (588s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[433.906871] Starting subtest: short-flip-before-cursor-toggle
[434.828069] Subtest short-flip-before-cursor-toggle: SUCCESS (0.920s)
[435.659862] [090/132] (586s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[435.722880] Starting subtest: multi-wait-available-unsubmitted-signaled
[435.724766] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[435.820353] [091/132] (586s left) perf_pmu (busy-no-semaphores)
[435.864962] Starting subtest: busy-no-semaphores
[435.866859] Starting dynamic subtest: rcs0
[436.426639] Dynamic subtest rcs0: SUCCESS (0.561s)
[436.440341] Starting dynamic subtest: bcs0
[436.977886] Dynamic subtest bcs0: SUCCESS (0.548s)
[436.992966] Starting dynamic subtest: vcs0
[437.529610] Dynamic subtest vcs0: SUCCESS (0.548s)
[437.542872] Starting dynamic subtest: vcs1
[439.353339] Dynamic subtest vcs1: SUCCESS (1.820s)
[439.365090] Starting dynamic subtest: vecs0
[441.334807] Dynamic subtest vecs0: SUCCESS (1.979s)
[441.348251] Starting dynamic subtest: ccs0
[443.320390] Dynamic subtest ccs0: SUCCESS (1.982s)
[443.323379] Subtest busy-no-semaphores: SUCCESS (7.456s)
[443.438438] [092/132] (578s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[443.539963] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[443.544155] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.637678] [093/132] (578s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[443.701239] Subtest tiled-to-untiled: SKIP (0.000s)
[443.773719] [094/132] (578s left) syncobj_wait (wait-all-delayed-signal)
[443.821442] Starting subtest: wait-all-delayed-signal
[443.924982] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[444.002382] [095/132] (578s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[444.117607] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[444.121582] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.215205] [096/132] (578s left) kms_flip (basic-flip-vs-modeset)
[444.322481] Starting subtest: basic-flip-vs-modeset
[444.324723] Starting dynamic subtest: A-eDP1
[446.860873] Dynamic subtest A-eDP1: SUCCESS (2.535s)
[446.871252] Starting dynamic subtest: B-eDP1
[449.030793] Dynamic subtest B-eDP1: SUCCESS (2.172s)
[449.040931] Starting dynamic subtest: C-eDP1
[451.202566] Dynamic subtest C-eDP1: SUCCESS (2.169s)
[451.213246] Starting dynamic subtest: D-eDP1
[453.376409] Dynamic subtest D-eDP1: SUCCESS (2.171s)
[453.378311] Subtest basic-flip-vs-modeset: SUCCESS (9.055s)
[454.187925] [097/132] (568s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[454.356837] Starting subtest: cursor-rapid-movement-64x64
[454.362106] Starting dynamic subtest: pipe-A-eDP-1
[454.927985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[454.958042] Starting dynamic subtest: pipe-D-eDP-1
[456.187410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[456.189776] Subtest cursor-rapid-movement-64x64: SUCCESS (1.830s)
[457.045289] [098/132] (565s left) vgem_basic (dmabuf-fence)
[457.104287] Starting subtest: dmabuf-fence
[457.106314] Subtest dmabuf-fence: SUCCESS (0.000s)
[457.166860] [099/132] (565s left) syncobj_wait (wait-delayed-signal)
[457.231160] Starting subtest: wait-delayed-signal
[457.332688] Subtest wait-delayed-signal: SUCCESS (0.102s)
[457.416109] [100/132] (565s left) gem_fence_thrash (bo-write-verify-none)
[457.453829] Starting subtest: bo-write-verify-none
[457.467405] Subtest bo-write-verify-none: SKIP (0.016s)
[457.542331] [101/132] (565s left) gem_exec_schedule (preempt-other-chain)
[457.617085] Starting subtest: preempt-other-chain
[457.619425] Starting dynamic subtest: rcs0
[457.710280] Dynamic subtest rcs0: SUCCESS (0.101s)
[457.720081] Starting dynamic subtest: bcs0
[457.798301] Dynamic subtest bcs0: SUCCESS (0.087s)
[457.809763] Starting dynamic subtest: vcs0
[457.886906] Dynamic subtest vcs0: SUCCESS (0.088s)
[457.902185] Starting dynamic subtest: vcs1
[457.966828] Dynamic subtest vcs1: SUCCESS (0.078s)
[457.979036] Starting dynamic subtest: vecs0
[458.055945] Dynamic subtest vecs0: SUCCESS (0.089s)
[458.068983] Starting dynamic subtest: ccs0
[458.144715] Dynamic subtest ccs0: SUCCESS (0.088s)
[458.146996] Subtest preempt-other-chain: SUCCESS (0.537s)
[458.889090] [102/132] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[458.990589] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[465.846138] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.861s)
[465.994778] [103/132] (556s left) syncobj_timeline (wait-all-interrupted)
[466.057195] Starting subtest: wait-all-interrupted
[466.160209] Subtest wait-all-interrupted: SUCCESS (0.102s)
[466.239308] [104/132] (556s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[466.333264] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[466.345053] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[466.420177] [105/132] (556s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[466.517628] Starting subtest: y-tiled-16bpp-rotate-270
[466.521544] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[466.614891] [106/132] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[466.703042] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[466.707079] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[466.795109] [107/132] (556s left) kms_chamelium_edid (hdmi-mode-timings)
[467.178069] Subtest hdmi-mode-timings: SKIP (0.000s)
[467.975870] [108/132] (555s left) gem_busy (extended)
[468.172343] Starting subtest: extended
[468.174396] Starting dynamic subtest: rcs0
[468.247649] Dynamic subtest rcs0: SUCCESS (0.079s)
[468.260736] Starting dynamic subtest: bcs0
[468.289695] Dynamic subtest bcs0: SUCCESS (0.040s)
[468.300528] Starting dynamic subtest: vcs0
[469.811582] Dynamic subtest vcs0: SUCCESS (1.518s)
[469.823372] Starting dynamic subtest: vcs1
[471.795379] Dynamic subtest vcs1: SUCCESS (1.982s)
[471.811325] Starting dynamic subtest: vecs0
[473.779417] Dynamic subtest vecs0: SUCCESS (1.981s)
[473.792544] Starting dynamic subtest: ccs0
[473.824123] Dynamic subtest ccs0: SUCCESS (0.044s)
[473.826589] Subtest extended: SUCCESS (5.658s)
[474.071666] [109/132] (548s left) perf (enable-disable)
[474.216390] Starting subtest: enable-disable
[474.218628] Starting dynamic subtest: 0-rcs0
[476.509074] Dynamic subtest 0-rcs0: SUCCESS (2.292s)
[476.520282] Starting dynamic subtest: 1-vcs1
[480.994994] Dynamic subtest 1-vcs1: SUCCESS (4.486s)
[480.997314] Subtest enable-disable: SUCCESS (6.781s)
[481.041811] [110/132] (542s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[481.159932] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[481.164436] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.272188] [111/132] (541s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[481.393744] Starting subtest: basic-busy-flip-before-cursor-atomic
[481.398306] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[481.550458] [112/132] (541s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[481.601138] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[481.651238] [113/132] (541s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[481.763307] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[481.767700] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[481.834092] [114/132] (541s left) gem_ctx_persistence (legacy-engines-persistence)
[481.886001] Starting subtest: legacy-engines-persistence
[481.888111] Starting dynamic subtest: render
[482.682211] Dynamic subtest render: SUCCESS (0.797s)
[482.693998] Starting dynamic subtest: bsd1
[483.436240] Dynamic subtest bsd1: SUCCESS (0.751s)
[483.449984] Starting dynamic subtest: bsd2
[484.185235] Dynamic subtest bsd2: SUCCESS (0.746s)
[484.196656] Starting dynamic subtest: blt
[484.981012] Dynamic subtest blt: SUCCESS (0.793s)
[484.996514] Starting dynamic subtest: vebox
[485.722313] Dynamic subtest vebox: SUCCESS (0.738s)
[485.724857] Subtest legacy-engines-persistence: SUCCESS (3.838s)
[485.862650] [115/132] (537s left) api_intel_bb (simple-bb)
[485.923559] Starting subtest: simple-bb
[485.928854] Subtest simple-bb: SUCCESS (0.009s)
[486.062421] [116/132] (537s left) kms_draw_crc (draw-method-mmap-wc)
[486.160017] Starting subtest: draw-method-mmap-wc
[486.161960] Starting dynamic subtest: xrgb8888-untiled
[486.403566] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[486.417784] Starting dynamic subtest: rgb565-untiled
[486.625714] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[486.636036] Starting dynamic subtest: xrgb2101010-untiled
[486.847594] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[486.859863] Starting dynamic subtest: xbgr16161616f-untiled
[487.082170] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[487.094278] Starting dynamic subtest: xrgb8888-xtiled
[487.226017] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.141s)
[487.235807] Starting dynamic subtest: rgb565-xtiled
[487.359295] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[487.369391] Starting dynamic subtest: xrgb2101010-xtiled
[487.481598] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[487.491428] Starting dynamic subtest: xbgr16161616f-xtiled
[487.614760] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[487.626673] Starting dynamic subtest: xrgb8888-4tiled
[487.781787] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.165s)
[487.792050] Starting dynamic subtest: rgb565-4tiled
[487.937958] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[487.949999] Starting dynamic subtest: xrgb2101010-4tiled
[488.093053] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s)
[488.102906] Starting dynamic subtest: xbgr16161616f-4tiled
[488.270772] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[488.272596] Subtest draw-method-mmap-wc: SUCCESS (2.112s)
[488.369011] [117/132] (535s left) prime_mmap_coherency (write)
[488.425777] Starting subtest: write
[493.806087] Subtest write: SUCCESS (5.376s)
[493.951755] [118/132] (529s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[494.052339] Starting subtest: 4-tiled-32bpp-rotate-90
[494.074683] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[494.190464] [119/132] (529s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[494.287009] Starting subtest: x-tiled-8bpp-rotate-270
[494.307650] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[494.411245] [120/132] (529s left) perf_pmu (semaphore-wait)
[494.458950] Starting subtest: semaphore-wait
[494.461298] Starting dynamic subtest: rcs0
[494.971124] Dynamic subtest rcs0: SUCCESS (0.511s)
[494.983383] Starting dynamic subtest: bcs0
[495.485052] Dynamic subtest bcs0: SUCCESS (0.511s)
[495.497395] Starting dynamic subtest: vcs0
[495.997888] Dynamic subtest vcs0: SUCCESS (0.510s)
[496.011024] Starting dynamic subtest: vcs1
[496.511740] Dynamic subtest vcs1: SUCCESS (0.510s)
[496.524200] Starting dynamic subtest: vecs0
[497.024707] Dynamic subtest vecs0: SUCCESS (0.510s)
[497.037977] Starting dynamic subtest: ccs0
[497.541221] Dynamic subtest ccs0: SUCCESS (0.513s)
[497.544277] Subtest semaphore-wait: SUCCESS (3.083s)
[498.816385] [121/132] (524s left) gem_exec_reloc (basic-write-read-noreloc)
[498.868219] Subtest basic-write-read-noreloc: SKIP (0.000s)
[498.940371] [122/132] (524s left) kms_cursor_crc (cursor-onscreen-64x64)
[499.124290] Starting subtest: cursor-onscreen-64x64
[499.130343] Starting dynamic subtest: pipe-A-eDP-1
[501.218410] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[501.249660] Starting dynamic subtest: pipe-D-eDP-1
[503.971738] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.729s)
[503.973675] Subtest cursor-onscreen-64x64: SUCCESS (4.845s)
[504.777607] [123/132] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[504.886559] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[512.293101] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.408s)
[512.411013] [124/132] (511s left) gem_create (create-size-update)
[512.465620] Starting subtest: create-size-update
[512.467510] Subtest create-size-update: SUCCESS (0.000s)
[512.671637] [125/132] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[512.765998] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[512.770321] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[512.862895] [126/132] (510s left) gem_flink_basic (bad-open)
[512.917568] Starting subtest: bad-open
[512.919414] Subtest bad-open: SUCCESS (0.000s)
[513.011250] [127/132] (510s left) gem_exec_nop (basic-series)
[513.082206] Starting subtest: basic-series
[528.823393] Subtest basic-series: SUCCESS (15.745s)
[529.041463] [128/132] (494s left) gen9_exec_parse (unaligned-access)
[529.105672] Subtest unaligned-access: SKIP (0.000s)
[529.180085] [129/132] (494s left) syncobj_wait (multi-wait-for-submit-submitted)
[529.241014] Starting subtest: multi-wait-for-submit-submitted
[529.351179] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[529.447923] [130/132] (494s left) kms_properties (crtc-properties-legacy)
[529.549444] Starting subtest: crtc-properties-legacy
[529.551836] Starting dynamic subtest: pipe-A-eDP-1
[529.986313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[529.997056] Starting dynamic subtest: pipe-B-eDP-1
[531.161273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s)
[531.175843] Starting dynamic subtest: pipe-C-eDP-1
[532.298242] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[532.308934] Starting dynamic subtest: pipe-D-eDP-1
[533.416778] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[533.419027] Subtest crtc-properties-legacy: SUCCESS (3.869s)
[534.251537] [131/132] (489s left) gem_exec_schedule (submit-late-slice)
[534.323523] Starting subtest: submit-late-slice
[534.325823] Starting dynamic subtest: rcs0
[534.363870] Dynamic subtest rcs0: SUCCESS (0.047s)
[534.375974] Starting dynamic subtest: bcs0
[534.400156] Dynamic subtest bcs0: SUCCESS (0.036s)
[534.410389] Starting dynamic subtest: vcs0
[534.435648] Dynamic subtest vcs0: SUCCESS (0.035s)
[534.445329] Starting dynamic subtest: vcs1
[534.470611] Dynamic subtest vcs1: SUCCESS (0.034s)
[534.480379] Starting dynamic subtest: vecs0
[534.516699] Dynamic subtest vecs0: SUCCESS (0.045s)
[534.526490] Starting dynamic subtest: ccs0
[534.558592] Dynamic subtest ccs0: SUCCESS (0.041s)
[534.560923] Subtest submit-late-slice: SUCCESS (0.242s)
[535.883674] [132/132] (488s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[535.981047] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[535.983175] Starting dynamic subtest: pipe-A-eDP-1
[536.058029] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[536.071927] Starting dynamic subtest: pipe-B-eDP-1
[537.214419] Dynamic subtest pipe-B-eDP-1: SKIP (1.154s)
[537.218761] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.235s)
[538.397531] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_pread
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_eventfd
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_exec_capture
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: gem_exec_parallel
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_vrr
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: drm_buddy
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: gem_readwrite
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_exec_async
results: parsing output: 40/ for test: kms_plane_multiple
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: gen9_exec_parse
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: i915_hangman
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: syncobj_basic
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: i915_query
results: parsing output: 60/ for test: kms_universal_plane
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_color
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_getfb
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_wait
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_pipe_stress
results: parsing output: 82/ for test: gem_ctx_param
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_set_tiling_vs_blt
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_fence_thrash
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: gem_busy
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_draw_crc
results: parsing output: 116/ for test: prime_mmap_coherency
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_create
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_flink_basic
results: parsing output: 126/ for test: gem_exec_nop
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_psr2_sf
Done.