[51.644680] Initializing watchdogs
[51.644748]   /dev/watchdog0
[51.660108] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[51.665741] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.669060] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.671278] [001/133] (960s left) gem_exec_fence (basic-await)
[51.844526] Starting subtest: basic-await
[51.845401] Starting dynamic subtest: rcs0
[51.926728] Dynamic subtest rcs0: SUCCESS (0.082s)
[51.938771] Starting dynamic subtest: bcs0
[52.012437] Dynamic subtest bcs0: SUCCESS (0.085s)
[52.026464] Starting dynamic subtest: vcs0
[52.099698] Dynamic subtest vcs0: SUCCESS (0.087s)
[52.112612] Starting dynamic subtest: vcs1
[52.186157] Dynamic subtest vcs1: SUCCESS (0.086s)
[52.198335] Starting dynamic subtest: vecs0
[52.272679] Dynamic subtest vecs0: SUCCESS (0.085s)
[52.273679] Subtest basic-await: SUCCESS (0.428s)
[52.771634] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[52.773909] [002/133] (959s left) kms_big_fb (linear-8bpp-rotate-0)
[52.873953] Starting subtest: linear-8bpp-rotate-0
[53.895991] Subtest linear-8bpp-rotate-0: SUCCESS (1.022s)
[54.004171] [003/133] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[54.096374] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[54.097722] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[54.180451] [004/133] (958s left) gem_exec_params (rel-constants-invalid)
[54.216524] Starting subtest: rel-constants-invalid
[54.217215] Subtest rel-constants-invalid: SUCCESS (0.000s)
[54.300535] [005/133] (958s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[54.394755] Starting subtest: 4-tiled-addfb-size-offset-overflow
[54.396130] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[54.473492] [006/133] (957s left) gem_sync (basic-store-all)
[54.517558] Starting subtest: basic-store-all
[57.008177] Subtest basic-store-all: SUCCESS (2.491s)
[57.190612] [007/133] (955s left) gem_mmap_gtt (fault-concurrent-x)
[57.223288] Starting subtest: fault-concurrent-X
[61.559662] Subtest fault-concurrent-X: SUCCESS (4.303s)
[61.644264] [008/133] (950s left) kms_chamelium_color (ctm-blue-to-red)
[61.730877] Subtest ctm-blue-to-red: SKIP (0.000s)
[61.767297] [009/133] (950s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[61.851439] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[61.852131] Starting dynamic subtest: pipe-A-valid-mode
[62.714443] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.862s)
[62.715177] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.864s)
[62.846510] [010/133] (949s left) kms_hdr (static-toggle)
[62.939182] Starting subtest: static-toggle
[62.941190] Subtest static-toggle: SKIP (0.001s)
[62.998318] [011/133] (949s left) prime_vgem (fence-wait)
[63.070490] Starting subtest: fence-wait
[63.071214] Starting dynamic subtest: rcs0
[64.117985] Dynamic subtest rcs0: SUCCESS (1.039s)
[64.126987] Starting dynamic subtest: bcs0
[65.143900] Dynamic subtest bcs0: SUCCESS (1.025s)
[65.152938] Starting dynamic subtest: vcs0
[66.183846] Dynamic subtest vcs0: SUCCESS (1.039s)
[66.196209] Starting dynamic subtest: vcs1
[67.207512] Dynamic subtest vcs1: SUCCESS (1.023s)
[67.213528] Starting dynamic subtest: vecs0
[68.301041] Dynamic subtest vecs0: SUCCESS (1.092s)
[68.302378] Subtest fence-wait: SUCCESS (5.223s)
[68.389751] [012/133] (944s left) gen7_exec_parse (cmd-crossing-page)
[68.426549] Subtest cmd-crossing-page: SKIP (0.000s)
[68.466854] [013/133] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[68.562827] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[68.564201] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[68.687537] [014/133] (944s left) kms_chamelium_hpd (dp-hpd-storm)
[68.822115] Subtest dp-hpd-storm: SKIP (0.000s)
[68.919090] [015/133] (943s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[69.009573] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[69.011052] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.017743] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[69.023830] Starting dynamic subtest: pipe-B-HDMI-A-1
[69.030509] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[69.036381] Starting dynamic subtest: pipe-C-HDMI-A-1
[69.042796] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[69.048528] Starting dynamic subtest: pipe-D-HDMI-A-1
[69.055111] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[69.056394] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[69.249558] [016/133] (943s left) kms_content_protection (legacy-hdcp14)
[69.340504] Starting subtest: legacy-hdcp14
[69.354013] Subtest legacy-hdcp14: SKIP (0.012s)
[69.439814] [017/133] (943s left) kms_plane_multiple (tiling-yf)
[69.524464] Starting subtest: tiling-yf
[69.525831] Subtest tiling-yf: SKIP (0.000s)
[69.580406] [018/133] (943s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[69.663754] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[69.665111] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[69.812599] [019/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[69.904490] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[69.905870] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[69.996221] [020/133] (942s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[70.029806] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[70.082577] [021/133] (942s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[70.176306] Starting subtest: y-tiled-32bpp-rotate-180
[71.536066] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.359s)
[71.664314] [022/133] (941s left) kms_lease (atomic-implicit-crtc)
[71.758186] Starting subtest: atomic-implicit-crtc
[71.758873] Starting dynamic subtest: pipe-A-HDMI-A-1
[71.762247] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[71.768174] Starting dynamic subtest: pipe-B-HDMI-A-1
[71.773079] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.010s)
[71.779118] Starting dynamic subtest: pipe-C-HDMI-A-1
[71.782458] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s)
[71.788426] Starting dynamic subtest: pipe-D-HDMI-A-1
[71.791874] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[71.792572] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[71.874224] [023/133] (941s left) kms_cursor_crc (cursor-dpms)
[71.963116] Starting subtest: cursor-dpms
[71.964604] Starting dynamic subtest: pipe-A-HDMI-A-1
[72.571976] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.607s)
[72.580414] Starting dynamic subtest: pipe-D-HDMI-A-1
[73.164394] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.591s)
[73.165170] Subtest cursor-dpms: SUCCESS (1.201s)
[73.353889] [024/133] (939s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[73.390139] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[73.390861] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[73.452702] [025/133] (939s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[73.548339] Starting subtest: x-tiled-32bpp-rotate-270
[73.627013] Subtest x-tiled-32bpp-rotate-270: SKIP (0.078s)
[73.736588] [026/133] (939s left) kms_cursor_crc (cursor-tearing-position-change)
[73.821873] Starting subtest: cursor-tearing-position-change
[73.823493] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.084710] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.262s)
[74.092157] Starting dynamic subtest: pipe-D-HDMI-A-1
[74.320397] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.233s)
[74.321151] Subtest cursor-tearing-position-change: SUCCESS (0.498s)
[74.477223] [027/133] (938s left) api_intel_allocator (execbuf-with-allocator)
[74.511688] Starting subtest: execbuf-with-allocator
[74.514366] Subtest execbuf-with-allocator: SUCCESS (0.003s)
[74.618643] [028/133] (938s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[74.703690] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[74.705090] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[74.758341] [029/133] (938s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[74.843612] Starting subtest: cursorB-vs-flipA-varying-size
[74.846577] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[74.923338] [030/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[75.012462] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[75.013829] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[75.110659] [031/133] (938s left) gem_exec_reloc (basic-gtt-read-active)
[75.148481] Starting subtest: basic-gtt-read-active
[75.282230] Subtest basic-gtt-read-active: SUCCESS (0.123s)
[75.391078] [032/133] (938s left) kms_async_flips (crc-atomic)
[75.474632] Starting subtest: crc-atomic
[75.602104] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.741212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.130s)
[77.865270] Starting dynamic subtest: pipe-B-HDMI-A-1
[79.985393] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.117s)
[80.100887] Starting dynamic subtest: pipe-C-HDMI-A-1
[82.231220] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.129s)
[82.356035] Starting dynamic subtest: pipe-D-HDMI-A-1
[84.479164] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.121s)
[84.479952] Subtest crc-atomic: SUCCESS (8.996s)
[84.690548] [033/133] (928s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[84.778416] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[84.779101] Starting dynamic subtest: pipe-A-valid-mode
[85.797518] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.018s)
[85.798314] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.020s)
[85.937802] [034/133] (927s left) api_intel_bb (object-noreloc-purge-cache-simple)
[85.973748] Starting subtest: object-noreloc-purge-cache-simple
[85.976874] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.003s)
[86.090397] [035/133] (927s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[86.180829] Starting subtest: cursor-rapid-movement-256x85
[86.184678] Starting dynamic subtest: pipe-A-HDMI-A-1
[86.433726] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.249s)
[86.465463] Starting dynamic subtest: pipe-D-HDMI-A-1
[86.686733] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.226s)
[86.687524] Subtest cursor-rapid-movement-256x85: SUCCESS (0.507s)
[86.847406] [036/133] (926s left) syncobj_wait (wait-all-snapshot)
[86.883920] Starting subtest: wait-all-snapshot
[86.966572] Subtest wait-all-snapshot: SUCCESS (0.082s)
[87.053502] [037/133] (926s left) gem_eio (kms)
[87.148963] Starting subtest: kms
[109.945798] Subtest kms: SUCCESS (22.797s)
[110.111620] [038/133] (903s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[110.207609] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[110.481418] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.274s)
[110.613680] [039/133] (903s left) gem_render_copy_redux (interruptible)
[110.651197] Starting subtest: interruptible
[110.990482] Subtest interruptible: SUCCESS (0.333s)
[111.096870] [040/133] (902s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[111.185734] Starting subtest: fbcpsr-slowdraw
[111.187093] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[111.319633] [041/133] (902s left) syncobj_basic (bad-handle-to-fd)
[111.353109] Starting subtest: bad-handle-to-fd
[111.353838] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[111.409930] [042/133] (902s left) gem_exec_reloc (basic-gtt-read)
[111.447265] Starting subtest: basic-gtt-read
[111.453648] Subtest basic-gtt-read: SUCCESS (0.006s)
[111.566437] [043/133] (902s left) kms_atomic_transition (plane-all-modeset-transition)
[111.651771] Starting subtest: plane-all-modeset-transition
[111.653427] Starting dynamic subtest: pipe-A-HDMI-A-1
[122.866758] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (11.214s)
[122.909167] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.406720] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (9.503s)
[132.433801] Subtest plane-all-modeset-transition: SUCCESS (20.782s)
[132.555186] [044/133] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[132.648576] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[132.649904] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[132.752208] [045/133] (881s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[132.785294] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[132.886746] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[132.961813] [046/133] (881s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[133.048605] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[141.983720] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.936s)
[142.115234] [047/133] (871s left) kms_chamelium_frames (hdmi-crc-multiple)
[142.262952] Subtest hdmi-crc-multiple: SKIP (0.000s)
[142.367512] [048/133] (871s left) kms_sequence (get-idle)
[142.454017] Starting subtest: get-idle
[142.455779] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.655253] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.200s)
[143.663255] Starting dynamic subtest: pipe-B-HDMI-A-1
[144.850138] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.192s)
[144.858185] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.039240] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.187s)
[146.049916] Starting dynamic subtest: pipe-D-HDMI-A-1
[147.205792] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.164s)
[147.206548] Subtest get-idle: SUCCESS (4.752s)
[147.311518] [049/133] (866s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[147.403934] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[147.405708] Starting dynamic subtest: pipe-A-HDMI-A-1
[147.412352] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[147.418627] Starting dynamic subtest: pipe-B-HDMI-A-1
[147.425225] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[147.431466] Starting dynamic subtest: pipe-C-HDMI-A-1
[147.438014] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[147.444058] Starting dynamic subtest: pipe-D-HDMI-A-1
[147.450878] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[147.452233] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[147.657263] [050/133] (866s left) kms_feature_discovery (display-4x)
[147.750756] Starting subtest: display-4x
[147.752112] Subtest display-4x: SKIP (0.000s)
[147.813629] [051/133] (866s left) kms_cursor_legacy (single-move)
[147.898874] Starting subtest: single-move
[147.899583] Starting dynamic subtest: pipe-A
[153.313234] Dynamic subtest pipe-A: SUCCESS (5.379s)
[153.319562] Starting dynamic subtest: pipe-B
[158.692545] Dynamic subtest pipe-B: SUCCESS (5.379s)
[158.698729] Starting dynamic subtest: pipe-C
[164.072179] Dynamic subtest pipe-C: SUCCESS (5.378s)
[164.078476] Starting dynamic subtest: pipe-D
[169.451711] Dynamic subtest pipe-D: SUCCESS (5.379s)
[169.458028] Starting dynamic subtest: all-pipes
[174.832344] Dynamic subtest all-pipes: SUCCESS (5.379s)
[174.833186] Subtest single-move: SUCCESS (26.899s)
[174.870930] [052/133] (839s left) kms_plane_scaling (planes-scaler-unity-scaling)
[174.958939] Starting subtest: planes-scaler-unity-scaling
[174.960108] Starting dynamic subtest: pipe-A
[175.024460] Dynamic subtest pipe-A: SUCCESS (0.066s)
[175.031818] Starting dynamic subtest: pipe-B
[175.177142] Dynamic subtest pipe-B: SUCCESS (0.152s)
[175.188361] Starting dynamic subtest: pipe-C
[175.311757] Dynamic subtest pipe-C: SUCCESS (0.133s)
[175.323196] Starting dynamic subtest: pipe-D
[175.438895] Dynamic subtest pipe-D: SUCCESS (0.126s)
[175.439725] Subtest planes-scaler-unity-scaling: SUCCESS (0.482s)
[175.624824] [053/133] (838s left) gem_pxp (fail-invalid-protected-context)
[175.729347] Starting subtest: fail-invalid-protected-context
[175.730386] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[175.801556] [054/133] (838s left) sw_sync (timeline_closed_signaled)
[175.834293] Starting subtest: timeline_closed_signaled
[175.835065] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[175.881737] [055/133] (838s left) kms_addfb_basic (bad-pitch-32)
[175.914942] Starting subtest: bad-pitch-32
[175.915664] Subtest bad-pitch-32: SUCCESS (0.000s)
[176.050282] [056/133] (838s left) kms_psr2_su (page_flip-nv12)
[176.083800] Subtest page_flip-NV12: SKIP (0.000s)
[176.127627] [057/133] (838s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[176.215384] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[176.216759] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[176.349148] [058/133] (838s left) kms_pm_rpm (modeset-non-lpsp)
[177.742965] Starting subtest: modeset-non-lpsp
[178.941140] Subtest modeset-non-lpsp: SKIP (1.197s)
[179.110841] [059/133] (835s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[179.146357] Starting subtest: multi-wait-all-for-submit-available-submitted
[179.148129] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[179.216860] [060/133] (835s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[179.301693] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[179.303703] Starting dynamic subtest: A-HDMI-A1
[180.042274] Dynamic subtest A-HDMI-A1: SUCCESS (0.737s)
[180.057814] Starting dynamic subtest: B-HDMI-A1
[180.650589] Dynamic subtest B-HDMI-A1: SUCCESS (0.609s)
[180.658337] Starting dynamic subtest: C-HDMI-A1
[181.321350] Dynamic subtest C-HDMI-A1: SUCCESS (0.669s)
[181.331076] Starting dynamic subtest: D-HDMI-A1
[181.959765] Dynamic subtest D-HDMI-A1: SUCCESS (0.637s)
[181.961758] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.661s)
[182.078229] [061/133] (832s left) gem_workarounds (basic-read)
[182.127453] Starting subtest: basic-read
[182.134981] Subtest basic-read: SUCCESS (0.007s)
[182.235218] [062/133] (832s left) i915_drm_fdinfo (virtual-idle)
[182.271271] Starting subtest: virtual-idle
[184.798922] Subtest virtual-idle: SUCCESS (2.518s)
[184.859089] [063/133] (829s left) kms_vrr (negative-basic)
[184.946991] Starting subtest: negative-basic
[184.949016] Subtest negative-basic: SKIP (0.000s)
[185.008742] [064/133] (829s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[185.102836] Starting subtest: yf-tiled-8bpp-rotate-0
[185.104216] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[185.191121] [065/133] (829s left) kms_psr (fbc-psr-primary-blt)
[185.279323] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[185.320390] [066/133] (829s left) gem_exec_schedule (manyslice)
[185.362175] Starting subtest: manyslice
[185.362869] Starting dynamic subtest: rcs0
[185.950652] Dynamic subtest rcs0: SUCCESS (0.579s)
[185.957312] Starting dynamic subtest: bcs0
[186.300724] Dynamic subtest bcs0: SUCCESS (0.349s)
[186.307189] Starting dynamic subtest: vcs0
[186.617851] Dynamic subtest vcs0: SUCCESS (0.316s)
[186.624828] Starting dynamic subtest: vcs1
[186.943083] Dynamic subtest vcs1: SUCCESS (0.324s)
[186.949698] Starting dynamic subtest: vecs0
[187.252959] Dynamic subtest vecs0: SUCCESS (0.309s)
[187.253684] Subtest manyslice: SUCCESS (1.883s)
[187.546066] [067/133] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[187.639373] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[187.640814] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[187.733709] [068/133] (827s left) kms_fbcon_fbt (fbc)
[187.770230] Starting subtest: fbc
[191.181311] Subtest fbc: SUCCESS (3.405s)
[191.244865] [069/133] (823s left) gem_create (create-ext-cpu-access-big)
[191.406308] Starting subtest: create-ext-cpu-access-big
[191.408207] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[191.483674] [070/133] (823s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[191.569288] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[191.570056] Starting dynamic subtest: pipe-A-HDMI-A-1
[191.586827] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[191.593197] Starting dynamic subtest: pipe-B-HDMI-A-1
[191.610308] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[191.616735] Starting dynamic subtest: pipe-C-HDMI-A-1
[191.633903] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[191.642266] Starting dynamic subtest: pipe-D-HDMI-A-1
[191.660791] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[191.662240] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.014s)
[191.806095] [071/133] (823s left) gem_ctx_isolation (clean)
[191.852062] Starting subtest: clean
[191.852755] Starting dynamic subtest: rcs0
[191.875566] Dynamic subtest rcs0: SUCCESS (0.024s)
[191.882389] Starting dynamic subtest: bcs0
[191.932842] Dynamic subtest bcs0: SUCCESS (0.056s)
[191.940340] Starting dynamic subtest: vcs0
[191.995703] Dynamic subtest vcs0: SUCCESS (0.062s)
[192.003589] Starting dynamic subtest: vcs1
[192.060853] Dynamic subtest vcs1: SUCCESS (0.064s)
[192.069259] Starting dynamic subtest: vecs0
[192.129580] Dynamic subtest vecs0: SUCCESS (0.067s)
[192.130405] Subtest clean: SUCCESS (0.279s)
[192.327709] [072/133] (822s left) kms_rotation_crc (sprite-rotation-180)
[192.413008] Starting subtest: sprite-rotation-180
[195.881823] Subtest sprite-rotation-180: SUCCESS (3.469s)
[196.057251] [073/133] (819s left) gem_exec_whisper (basic-sync-all)
[196.103595] Starting subtest: basic-sync-all
[197.500823] Subtest basic-sync-all: SUCCESS (1.396s)
[197.693893] [074/133] (817s left) i915_pm_rpm (sysfs-read)
[199.092123] Starting subtest: sysfs-read
[200.289656] Subtest sysfs-read: SUCCESS (1.197s)
[200.464275] [075/133] (814s left) kms_plane (plane-panning-bottom-right-suspend)
[200.552053] Starting subtest: plane-panning-bottom-right-suspend
[200.553821] Starting dynamic subtest: pipe-A
[217.082662] Dynamic subtest pipe-A: SUCCESS (1.661s)
[217.094856] Starting dynamic subtest: pipe-B
[234.102018] Dynamic subtest pipe-B: SUCCESS (1.570s)
[234.102839] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.237s)
[243.301222] [076/133] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[243.404763] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[243.406164] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[243.509015] [077/133] (780s left) kms_vblank (wait-busy-hang)
[243.595107] Starting subtest: wait-busy-hang
[243.595924] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.787585] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.187s)
[257.807706] Starting dynamic subtest: pipe-D-HDMI-A-1
[272.108291] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.315s)
[272.109029] Subtest wait-busy-hang: SUCCESS (28.509s)
[272.274450] [078/133] (752s left) i915_selftest (mock)
[273.201452] Starting subtest: mock
[273.202250] Starting dynamic subtest: sanitycheck
[273.875672] Dynamic subtest sanitycheck: SUCCESS (0.673s)
[273.890711] Starting dynamic subtest: shmem
[274.548338] Dynamic subtest shmem: SUCCESS (0.669s)
[274.563327] Starting dynamic subtest: fence
[282.317562] Dynamic subtest fence: SUCCESS (7.767s)
[282.325997] Starting dynamic subtest: scatterlist
[283.973046] Dynamic subtest scatterlist: SUCCESS (1.662s)
[283.984309] Starting dynamic subtest: syncmap
[286.787577] Dynamic subtest syncmap: SUCCESS (2.804s)
[286.796552] Starting dynamic subtest: uncore
[287.443313] Dynamic subtest uncore: SUCCESS (0.661s)
[287.456382] Starting dynamic subtest: ring
[288.101162] Dynamic subtest ring: SUCCESS (0.657s)
[288.115884] Starting dynamic subtest: engine
[288.766252] Dynamic subtest engine: SUCCESS (0.663s)
[288.781211] Starting dynamic subtest: timelines
[293.186615] Dynamic subtest timelines: SUCCESS (4.409s)
[293.195084] Starting dynamic subtest: requests
[297.586582] Dynamic subtest requests: SUCCESS (4.397s)
[297.597490] Starting dynamic subtest: objects
[298.347459] Dynamic subtest objects: SUCCESS (0.759s)
[298.355448] Starting dynamic subtest: phys
[299.098406] Dynamic subtest phys: SUCCESS (0.749s)
[299.106050] Starting dynamic subtest: dmabuf
[299.841465] Dynamic subtest dmabuf: SUCCESS (0.741s)
[299.849208] Starting dynamic subtest: vma
[307.288393] Dynamic subtest vma: SUCCESS (7.444s)
[307.295355] Starting dynamic subtest: evict
[308.870586] Dynamic subtest evict: SUCCESS (1.580s)
[308.881536] Starting dynamic subtest: gtt
[312.560581] Dynamic subtest gtt: SUCCESS (3.687s)
[312.568574] Starting dynamic subtest: hugepages
[313.473401] Dynamic subtest hugepages: SUCCESS (0.911s)
[313.480751] Starting dynamic subtest: memory_region
[316.655521] Dynamic subtest memory_region: SUCCESS (3.179s)
[316.656491] Subtest mock: SUCCESS (43.452s)
[316.690304] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[316.691309] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[316.694407] [079/133] (707s left) gem_readwrite (write-bad-handle)
[317.709215] Starting subtest: write-bad-handle
[317.710840] Subtest write-bad-handle: SUCCESS (0.000s)
[317.801595] [FACT gem_readwrite (write-bad-handle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[317.803133] [FACT gem_readwrite (write-bad-handle)] new: kernel.kmod_is_loaded.i915: true
[317.805707] [080/133] (706s left) syncobj_timeline (reset-during-wait-for-submit)
[317.844759] Starting subtest: reset-during-wait-for-submit
[317.947762] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[318.022186] [081/133] (706s left) fbdev (write)
[318.064073] Starting subtest: write
[318.520017] Subtest write: SUCCESS (0.447s)
[318.565689] [082/133] (705s left) gem_eio (in-flight-1us)
[318.611846] Starting subtest: in-flight-1us
[320.824384] Subtest in-flight-1us: SUCCESS (2.212s)
[320.942045] [083/133] (703s left) syncobj_wait (invalid-wait-bad-flags)
[320.978981] Starting subtest: invalid-wait-bad-flags
[320.979670] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[321.046654] [084/133] (703s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[321.131964] Starting subtest: primary-x-tiled-reflect-x-180
[324.685697] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.553s)
[324.861115] [085/133] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[324.955765] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[324.957160] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[325.055787] [086/133] (699s left) perf_pmu (enable-race)
[325.091840] Starting subtest: enable-race
[325.092610] Starting dynamic subtest: rcs0
[337.662360] Dynamic subtest rcs0: SUCCESS (12.569s)
[337.670872] Starting dynamic subtest: bcs0
[350.259645] Dynamic subtest bcs0: SUCCESS (12.575s)
[350.271156] Starting dynamic subtest: vcs0
[362.834553] Dynamic subtest vcs0: SUCCESS (12.571s)
[362.846150] Starting dynamic subtest: vcs1
[375.402101] Dynamic subtest vcs1: SUCCESS (12.576s)
[375.413238] Starting dynamic subtest: vecs0
[387.956785] Dynamic subtest vecs0: SUCCESS (12.572s)
[387.957489] Subtest enable-race: SUCCESS (62.869s)
[388.049825] [087/133] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[388.143627] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[388.145000] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[388.244045] [088/133] (636s left) gem_exec_schedule (implicit-boths)
[388.288626] Starting subtest: implicit-boths
[388.289296] Starting dynamic subtest: rcs0
[388.351662] Dynamic subtest rcs0: SUCCESS (0.063s)
[388.364561] Starting dynamic subtest: bcs0
[388.416645] Dynamic subtest bcs0: SUCCESS (0.063s)
[388.430624] Starting dynamic subtest: vcs0
[388.485227] Dynamic subtest vcs0: SUCCESS (0.066s)
[388.500811] Starting dynamic subtest: vcs1
[388.554236] Dynamic subtest vcs1: SUCCESS (0.066s)
[388.569605] Starting dynamic subtest: vecs0
[388.624583] Dynamic subtest vecs0: SUCCESS (0.067s)
[388.628362] Subtest implicit-boths: SUCCESS (0.338s)
[388.920070] [089/133] (635s left) gem_exec_schedule (u-fairslice)
[388.965698] Starting subtest: u-fairslice
[388.966375] Starting dynamic subtest: rcs0
[390.995510] Dynamic subtest rcs0: SUCCESS (2.013s)
[391.006147] Starting dynamic subtest: bcs0
[393.002782] Dynamic subtest bcs0: SUCCESS (2.014s)
[393.013687] Starting dynamic subtest: vcs0
[395.015234] Dynamic subtest vcs0: SUCCESS (2.011s)
[395.025799] Starting dynamic subtest: vcs1
[397.028175] Dynamic subtest vcs1: SUCCESS (2.012s)
[397.038934] Starting dynamic subtest: vecs0
[399.040465] Dynamic subtest vecs0: SUCCESS (2.011s)
[399.041415] Subtest u-fairslice: SUCCESS (10.066s)
[399.327652] [090/133] (625s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[399.424683] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[399.731658] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.307s)
[399.854650] [091/133] (624s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[399.945005] Starting subtest: compare-crc-sanitycheck-xr24
[399.947305] Starting dynamic subtest: pipe-A-HDMI-A-1
[400.207917] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.261s)
[400.218660] Starting dynamic subtest: pipe-B-HDMI-A-1
[400.471583] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.261s)
[400.481292] Starting dynamic subtest: pipe-C-HDMI-A-1
[400.718958] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.245s)
[400.729397] Starting dynamic subtest: pipe-D-HDMI-A-1
[400.969720] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.248s)
[400.970498] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.025s)
[401.118374] [092/133] (623s left) kms_properties (plane-properties-atomic)
[401.208825] Starting subtest: plane-properties-atomic
[401.210678] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.462410] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.252s)
[401.473070] Starting dynamic subtest: pipe-B-HDMI-A-1
[401.738279] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.274s)
[401.750336] Starting dynamic subtest: pipe-C-HDMI-A-1
[402.023778] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.284s)
[402.033876] Starting dynamic subtest: pipe-D-HDMI-A-1
[402.311851] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.284s)
[402.312681] Subtest plane-properties-atomic: SUCCESS (1.103s)
[402.482458] [093/133] (622s left) gem_ringfill (legacy-basic)
[402.720421] Starting subtest: legacy-basic
[402.723612] Starting dynamic subtest: default
[402.756604] Dynamic subtest default: SUCCESS (0.034s)
[402.776711] Starting dynamic subtest: render
[402.779697] Dynamic subtest render: SUCCESS (0.021s)
[402.789708] Starting dynamic subtest: bsd
[402.803076] Dynamic subtest bsd: SUCCESS (0.022s)
[402.819118] Starting dynamic subtest: bsd1
[402.822822] Dynamic subtest bsd1: SUCCESS (0.018s)
[402.833943] Starting dynamic subtest: bsd2
[402.836700] Dynamic subtest bsd2: SUCCESS (0.012s)
[402.846395] Starting dynamic subtest: blt
[402.853742] Dynamic subtest blt: SUCCESS (0.016s)
[402.863133] Starting dynamic subtest: vebox
[402.866961] Dynamic subtest vebox: SUCCESS (0.012s)
[402.867660] Subtest legacy-basic: SUCCESS (0.147s)
[402.937789] [094/133] (622s left) gem_mmap_wc (read)
[402.971716] Starting subtest: read
[402.979168] Subtest read: SUCCESS (0.008s)
[403.062467] [095/133] (621s left) kms_psr (psr2-cursor-mmap-gtt)
[403.150006] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[403.206108] [096/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[403.295175] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[403.296611] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[403.373125] [097/133] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[403.465790] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[403.467207] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[403.551793] [098/133] (621s left) gem_exec_balancer (full-pulse)
[403.595070] Starting subtest: full-pulse
[405.204607] Subtest full-pulse: SUCCESS (1.610s)
[405.388696] [099/133] (619s left) gem_exec_whisper (basic-fds-priority-all)
[405.432933] Starting subtest: basic-fds-priority-all
[409.755877] Subtest basic-fds-priority-all: SUCCESS (4.313s)
[409.936832] [100/133] (615s left) kms_pm_backlight (basic-brightness)
[410.024985] Subtest basic-brightness: SKIP (0.000s)
[410.071537] [101/133] (615s left) gem_ctx_persistence (legacy-engines-mixed-process)
[410.108504] Starting subtest: legacy-engines-mixed-process
[410.109218] Starting dynamic subtest: render
[410.478219] Dynamic subtest render: SUCCESS (0.362s)
[410.491141] Starting dynamic subtest: bsd1
[410.839007] Dynamic subtest bsd1: SUCCESS (0.364s)
[410.856943] Starting dynamic subtest: bsd2
[411.201946] Dynamic subtest bsd2: SUCCESS (0.360s)
[411.219349] Starting dynamic subtest: blt
[411.556316] Dynamic subtest blt: SUCCESS (0.352s)
[411.568965] Starting dynamic subtest: vebox
[411.906811] Dynamic subtest vebox: SUCCESS (0.348s)
[411.910326] Subtest legacy-engines-mixed-process: SUCCESS (1.799s)
[411.982487] [102/133] (613s left) gem_exec_reloc (basic-wc-gtt-active)
[412.023623] Starting subtest: basic-wc-gtt-active
[412.156796] Subtest basic-wc-gtt-active: SUCCESS (0.124s)
[412.272923] [103/133] (613s left) gem_wait (await)
[412.318474] Starting subtest: await
[412.319215] Starting dynamic subtest: all-engines
[413.355060] Dynamic subtest all-engines: SUCCESS (1.036s)
[413.368098] Starting dynamic subtest: rcs0
[414.387015] Dynamic subtest rcs0: SUCCESS (1.030s)
[414.398999] Starting dynamic subtest: bcs0
[415.419153] Dynamic subtest bcs0: SUCCESS (1.030s)
[415.432854] Starting dynamic subtest: vcs0
[416.451084] Dynamic subtest vcs0: SUCCESS (1.030s)
[416.462983] Starting dynamic subtest: vcs1
[417.482067] Dynamic subtest vcs1: SUCCESS (1.029s)
[417.495211] Starting dynamic subtest: vecs0
[418.517129] Dynamic subtest vecs0: SUCCESS (1.032s)
[418.520062] Subtest await: SUCCESS (6.200s)
[418.715544] [104/133] (606s left) kms_psr (fbc-psr2-sprite-blt)
[418.802327] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[418.844998] [105/133] (606s left) i915_drm_fdinfo (virtual-busy-hang)
[418.883537] Starting subtest: virtual-busy-hang
[424.063821] Subtest virtual-busy-hang: SUCCESS (5.183s)
[424.142618] [106/133] (601s left) gem_exec_create (madvise)
[424.183344] Starting subtest: madvise
[424.184050] Starting dynamic subtest: smem
[444.333537] Dynamic subtest smem: SUCCESS (20.149s)
[444.334348] Subtest madvise: SUCCESS (20.151s)
[445.717014] [107/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[445.807661] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[445.809020] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[445.895289] [108/133] (579s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[445.982152] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[446.025620] [109/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[446.113819] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[446.115147] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[446.204456] [110/133] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[446.293662] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[446.295040] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[446.409611] [111/133] (579s left) gem_exec_fence (syncobj-timeline-repeat)
[446.861347] Starting subtest: syncobj-timeline-repeat
[447.219748] Subtest syncobj-timeline-repeat: SUCCESS (0.358s)
[447.392393] [112/133] (578s left) gem_mmap_gtt (basic-write-read)
[447.425752] Starting subtest: basic-write-read
[447.430509] Subtest basic-write-read: SUCCESS (0.005s)
[447.514776] [113/133] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[447.607133] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[447.608578] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[447.680396] [114/133] (578s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[447.714791] Starting subtest: single-wait-all-for-submit-signaled
[447.715491] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[447.798356] [115/133] (578s left) kms_async_flips (async-flip-suspend-resume)
[447.882872] Starting subtest: async-flip-suspend-resume
[448.024132] Starting dynamic subtest: pipe-A-HDMI-A-1
[464.996075] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.325s)
[465.148901] Starting dynamic subtest: pipe-B-HDMI-A-1
[482.974535] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.287s)
[483.096949] Starting dynamic subtest: pipe-C-HDMI-A-1
[500.974224] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.296s)
[501.095552] Starting dynamic subtest: pipe-D-HDMI-A-1
[518.986290] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.279s)
[518.988189] Subtest async-flip-suspend-resume: SUCCESS (9.697s)
[532.259883] [116/133] (506s left) kms_flip (2x-flip-vs-dpms-on-nop)
[532.357339] Starting subtest: 2x-flip-vs-dpms-on-nop
[532.366408] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.009s)
[532.439501] [117/133] (506s left) prime_vgem (basic-fence-read)
[532.507910] Starting subtest: basic-fence-read
[532.553938] Subtest basic-fence-read: SUCCESS (0.046s)
[532.648094] [118/133] (506s left) gem_unref_active_buffers
[532.835746] [119/133] (506s left) kms_psr (pr-primary-mmap-gtt)
[532.923305] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[532.968084] [120/133] (506s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[533.001514] Starting subtest: etime-single-wait-available-unsubmitted
[533.103271] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[533.183807] [121/133] (505s left) syncobj_wait (single-wait-for-submit-signaled)
[533.217671] Starting subtest: single-wait-for-submit-signaled
[533.218391] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[533.287263] [122/133] (505s left) gem_ctx_bad_destroy (invalid-ctx)
[533.320484] Starting subtest: invalid-ctx
[533.321206] Subtest invalid-ctx: SUCCESS (0.000s)
[533.389070] [123/133] (505s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[533.482989] Starting subtest: protected-encrypted-src-copy-not-readible
[533.571469] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.090s)
[533.685448] [124/133] (505s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[533.776390] Starting subtest: 2x-absolute-wf_vblank-interruptible
[533.784983] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.009s)
[533.848106] [125/133] (505s left) gem_userptr_blits (relocations)
[533.886209] Starting subtest: relocations
[533.888070] Subtest relocations: SUCCESS (0.002s)
[534.008470] [126/133] (505s left) kms_properties (colorop-properties-legacy)
[534.093212] Starting subtest: colorop-properties-legacy
[534.093999] Starting dynamic subtest: pipe-A-HDMI-A-1
[534.176935] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.083s)
[534.187798] Starting dynamic subtest: pipe-B-HDMI-A-1
[534.306814] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.127s)
[534.318485] Starting dynamic subtest: pipe-C-HDMI-A-1
[534.426019] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.118s)
[534.438822] Starting dynamic subtest: pipe-D-HDMI-A-1
[534.546042] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.117s)
[534.546783] Subtest colorop-properties-legacy: SUCCESS (0.453s)
[534.696953] [127/133] (504s left) gem_mmap_gtt (hang-user)
[534.732790] Starting subtest: hang-user
[571.076473] Subtest hang-user: SUCCESS (36.337s)
[571.186485] [128/133] (468s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[571.278436] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[572.616869] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.338s)
[572.746553] [129/133] (466s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[572.837412] Starting subtest: plane-lut1d-ctm3x4
[572.925732] Starting dynamic subtest: pipe-A-plane-0
[573.024781] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[573.042757] Starting dynamic subtest: pipe-A-plane-1
[573.116327] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[573.132525] Starting dynamic subtest: pipe-A-plane-2
[573.216453] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s)
[573.422458] Starting dynamic subtest: pipe-B-plane-0
[573.497705] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s)
[573.513691] Starting dynamic subtest: pipe-B-plane-1
[573.589461] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[573.605520] Starting dynamic subtest: pipe-B-plane-2
[573.681012] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[573.921826] Starting dynamic subtest: pipe-C-plane-0
[574.003913] Dynamic subtest pipe-C-plane-0: SUCCESS (0.091s)
[574.018853] Starting dynamic subtest: pipe-C-plane-1
[574.103887] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[574.119576] Starting dynamic subtest: pipe-C-plane-2
[574.203774] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s)
[574.428594] Starting dynamic subtest: pipe-D-plane-0
[574.510900] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[574.522568] Starting dynamic subtest: pipe-D-plane-1
[574.611509] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[574.631741] Starting dynamic subtest: pipe-D-plane-2
[574.719679] Dynamic subtest pipe-D-plane-2: SUCCESS (0.106s)
[574.778443] Subtest plane-lut1d-ctm3x4: SUCCESS (1.941s)
[574.886237] [130/133] (464s left) sysfs_timeslice_duration (duration)
[574.924849] Starting subtest: duration
[574.926690] Starting dynamic subtest: vecs0
[574.991557] Dynamic subtest vecs0: SUCCESS (0.065s)
[575.012553] Starting dynamic subtest: vcs0
[575.064520] Dynamic subtest vcs0: SUCCESS (0.070s)
[575.083294] Starting dynamic subtest: bcs0
[575.133564] Dynamic subtest bcs0: SUCCESS (0.066s)
[575.150344] Starting dynamic subtest: rcs0
[575.196599] Dynamic subtest rcs0: SUCCESS (0.060s)
[575.215905] Starting dynamic subtest: vcs1
[575.270845] Dynamic subtest vcs1: SUCCESS (0.071s)
[575.274302] Subtest duration: SUCCESS (0.347s)
[575.360529] [131/133] (464s left) gem_spin_batch (resubmit-new)
[575.403243] Starting subtest: resubmit-new
[575.403962] Starting dynamic subtest: rcs0
[575.406783] Dynamic subtest rcs0: SUCCESS (0.003s)
[575.417143] Starting dynamic subtest: bcs0
[575.417868] Dynamic subtest bcs0: SUCCESS (0.003s)
[575.427018] Starting dynamic subtest: vcs0
[575.427719] Dynamic subtest vcs0: SUCCESS (0.003s)
[575.436162] Starting dynamic subtest: vcs1
[575.436849] Dynamic subtest vcs1: SUCCESS (0.003s)
[575.445127] Starting dynamic subtest: vecs0
[575.445841] Dynamic subtest vecs0: SUCCESS (0.003s)
[575.446521] Subtest resubmit-new: SUCCESS (0.022s)
[575.617972] [132/133] (463s left) gem_userptr_blits (create-destroy-sync)
[575.662686] Starting subtest: create-destroy-sync
[580.709188] Subtest create-destroy-sync: SUCCESS (5.012s)
[580.794488] [133/133] (458s left) dmabuf_sync_file (export-multiwait)
[580.830419] Starting subtest: export-multiwait
[580.831143] Subtest export-multiwait: SUCCESS (0.001s)
[580.880412] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_sync
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_chamelium_color
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gen7_exec_parse
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr_stress_test
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_render_copy_redux
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_chamelium_frames
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: sw_sync
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_psr2_su
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_fbcon_fbt
results: parsing output: 68/ for test: gem_create
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: i915_selftest
results: parsing output: 78/ for test: gem_readwrite
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_pm_backlight
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_create
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: gem_unref_active_buffers
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: gem_ctx_bad_destroy
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: sysfs_timeslice_duration
results: parsing output: 130/ for test: gem_spin_batch
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: dmabuf_sync_file
Done.