[66.990477] Initializing watchdogs
[66.990560]   /dev/watchdog0
[67.020867] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.034516] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.039569] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.042865] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[68.543568] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[68.546590] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[68.786732] [002/134] (958s left) kms_hdr (bpc-switch)
[70.271829] Starting subtest: bpc-switch
[70.276418] Subtest bpc-switch: SKIP (0.001s)
[70.441764] [003/134] (957s left) i915_module_load (reload)
[70.493036] Starting subtest: reload
[75.917898] Subtest reload: SUCCESS (5.426s)
[76.021369] [004/134] (951s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[77.607653] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[77.673958] [005/134] (950s left) kms_pm_rpm (cursor)
[82.038522] Starting subtest: cursor
[82.043472] Subtest cursor: SKIP (0.000s)
[83.050312] [006/134] (945s left) kms_rotation_crc (cursor-rotation-180)
[84.545640] Starting subtest: cursor-rotation-180
[85.383955] Subtest cursor-rotation-180: SUCCESS (0.839s)
[85.661414] [007/134] (942s left) vgem_basic (bad-pad)
[85.768195] Starting subtest: bad-pad
[85.769756] Subtest bad-pad: SUCCESS (0.000s)
[85.942057] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[85.944293] [008/134] (942s left) kms_addfb_basic (invalid-get-prop)
[85.988429] Starting subtest: invalid-get-prop
[85.989809] Subtest invalid-get-prop: SUCCESS (0.000s)
[87.685188] [009/134] (940s left) gem_mmap_gtt (hang-busy)
[87.737706] Subtest hang-busy: SKIP (0.000s)
[87.808241] [010/134] (940s left) gem_eio (in-flight-1us)
[87.978596] Starting subtest: in-flight-1us
[91.604047] Subtest in-flight-1us: SUCCESS (3.626s)
[93.266217] [011/134] (935s left) gem_ctx_shared (disjoint-timelines)
[93.322430] Starting subtest: disjoint-timelines
[93.349454] Subtest disjoint-timelines: SUCCESS (0.027s)
[93.690349] [012/134] (934s left) kms_rotation_crc (bad-tiling)
[95.173795] Starting subtest: bad-tiling
[99.407790] Subtest bad-tiling: SUCCESS (4.235s)
[99.650825] [013/134] (929s left) gem_exec_fence (syncobj-channel)
[100.036284] Starting subtest: syncobj-channel
[101.065817] Subtest syncobj-channel: SUCCESS (1.025s)
[101.543424] [014/134] (927s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[103.051991] Starting subtest: y-tiled-64bpp-rotate-270
[103.124490] Subtest y-tiled-64bpp-rotate-270: SKIP (0.067s)
[103.368371] [015/134] (925s left) kms_psr (psr2-cursor-plane-move)
[104.854903] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[104.923073] [016/134] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[106.414890] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[106.418171] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[106.661648] [017/134] (922s left) i915_pm_rpm (gem-execbuf)
[111.075488] Starting subtest: gem-execbuf
[111.077867] Starting dynamic subtest: lmem0
[116.160625] Dynamic subtest lmem0: SUCCESS (5.086s)
[116.175852] Starting dynamic subtest: smem0
[120.021444] Dynamic subtest smem0: SUCCESS (3.860s)
[120.023077] Subtest gem-execbuf: SUCCESS (8.948s)
[121.135456] [018/134] (908s left) syncobj_timeline (wait-zero-handles)
[121.198610] Starting subtest: wait-zero-handles
[121.200304] Subtest wait-zero-handles: SUCCESS (0.000s)
[121.365340] [019/134] (908s left) kms_pm_rpm (dpms-non-lpsp)
[125.084015] Starting subtest: dpms-non-lpsp
[125.179068] Subtest dpms-non-lpsp: SUCCESS (0.098s)
[126.011552] [020/134] (903s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[127.515644] Starting subtest: yf-tiled-addfb-size-offset-overflow
[127.518950] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[127.757294] [021/134] (901s left) gem_render_copy (linear)
[127.811250] Starting subtest: linear
[127.812951] Starting dynamic subtest: smem
[127.899087] Dynamic subtest smem: SUCCESS (0.087s)
[127.909408] Starting dynamic subtest: lmem0
[128.034770] Dynamic subtest lmem0: SUCCESS (0.132s)
[128.036589] Subtest linear: SUCCESS (0.220s)
[128.368350] [022/134] (901s left) i915_drm_fdinfo (basics)
[128.419297] Starting subtest: basics
[128.420637] Subtest basics: SUCCESS (0.000s)
[128.598852] [023/134] (901s left) kms_cursor_edge_walk (64x64-top-bottom)
[130.086795] Starting subtest: 64x64-top-bottom
[130.088413] Starting dynamic subtest: pipe-A-HDMI-A-4
[133.397163] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.310s)
[133.407882] Starting dynamic subtest: pipe-D-HDMI-A-4
[136.620532] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.222s)
[136.622269] Subtest 64x64-top-bottom: SUCCESS (6.535s)
[136.831909] [024/134] (893s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[138.335570] Starting subtest: 4-tiled-addfb-size-offset-overflow
[138.339235] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[138.574024] [025/134] (891s left) kms_psr (fbc-pr-primary-blt)
[140.062293] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[140.140412] [026/134] (889s left) kms_cursor_crc (cursor-size-hints)
[141.689920] Starting subtest: cursor-size-hints
[141.691655] Starting dynamic subtest: pipe-A-HDMI-A-4
[142.264493] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.573s)
[142.276952] Starting dynamic subtest: pipe-D-HDMI-A-4
[142.699810] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.434s)
[142.701380] Subtest cursor-size-hints: SUCCESS (1.010s)
[143.358580] [027/134] (886s left) kms_color (ctm-green-to-red)
[144.842116] Starting subtest: ctm-green-to-red
[144.844194] Starting dynamic subtest: pipe-A-HDMI-A-4
[145.520313] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.678s)
[145.530723] Starting dynamic subtest: pipe-B-HDMI-A-4
[146.029650] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.510s)
[146.040175] Starting dynamic subtest: pipe-C-HDMI-A-4
[146.554089] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.522s)
[146.564285] Starting dynamic subtest: pipe-D-HDMI-A-4
[147.029029] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.475s)
[147.030752] Subtest ctm-green-to-red: SUCCESS (2.187s)
[147.288352] [028/134] (882s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[148.776645] Starting subtest: 2x-flip-vs-cursor-atomic
[148.779619] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[148.953144] [029/134] (881s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[150.444733] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[150.525962] [030/134] (879s left) gem_create (create-clear)
[150.574075] Starting subtest: create-clear
[150.575547] Starting dynamic subtest: lmem0
[183.744473] Dynamic subtest lmem0: SUCCESS (33.158s)
[183.755187] Starting dynamic subtest: smem0
[218.447679] Dynamic subtest smem0: SUCCESS (34.704s)
[218.449168] Subtest create-clear: SUCCESS (67.864s)
[218.966709] [031/134] (811s left) kms_chamelium_hpd (hdmi-hpd)
[220.495791] Subtest hdmi-hpd: SKIP (0.000s)
[220.607078] [032/134] (809s left) i915_suspend (fence-restore-untiled)
[220.654240] Starting subtest: fence-restore-untiled
[220.657771] Subtest fence-restore-untiled: SKIP (0.000s)
[220.829662] [033/134] (809s left) gem_sync (basic-each)
[220.893393] Starting subtest: basic-each
[223.288830] Subtest basic-each: SUCCESS (2.398s)
[223.614520] [034/134] (807s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu)
[225.104914] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu
[225.108420] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.331637] [035/134] (805s left) gem_userptr_blits (map-fixed-invalidate)
[225.396465] Starting subtest: map-fixed-invalidate
[225.398932] Subtest map-fixed-invalidate: SKIP (0.000s)
[225.596612] [036/134] (805s left) api_intel_allocator (reloc-allocator)
[225.640655] Starting subtest: reloc-allocator
[225.641968] Starting dynamic subtest: basic
[225.659379] Dynamic subtest basic: SUCCESS (0.019s)
[225.670779] Starting dynamic subtest: parallel-one
[225.672170] Dynamic subtest parallel-one: SUCCESS (0.005s)
[225.682802] Starting dynamic subtest: print
[225.684198] Dynamic subtest print: SUCCESS (0.000s)
[225.694855] Starting dynamic subtest: reuse
[225.696407] Dynamic subtest reuse: SUCCESS (0.000s)
[225.706688] Starting dynamic subtest: fork-reopen-allocator
[225.708215] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[225.709814] Subtest reloc-allocator: SUCCESS (0.043s)
[225.918877] [037/134] (805s left) kms_flip (2x-flip-vs-fences)
[227.403504] Starting subtest: 2x-flip-vs-fences
[227.406473] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[227.616270] [038/134] (803s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[229.099966] Starting subtest: 2x-cursor-vs-flip-legacy
[229.105945] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s)
[229.289700] [039/134] (802s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[230.775653] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[230.777228] Starting dynamic subtest: pipe-A-valid-mode
[230.818907] Dynamic subtest pipe-A-valid-mode: SKIP (0.040s)
[230.822212] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.042s)
[231.011297] [040/134] (800s left) gem_exec_params (cliprects-invalid)
[231.059938] Starting subtest: cliprects-invalid
[231.061355] Subtest cliprects-invalid: SUCCESS (0.000s)
[231.281290] [041/134] (800s left) gem_mmap (pf-nonblock)
[231.328311] Subtest pf-nonblock: SKIP (0.000s)
[231.403862] [042/134] (800s left) kms_atomic_transition (modeset-transition)
[232.888273] Starting subtest: modeset-transition
[232.889928] Starting dynamic subtest: 1x-outputs
[234.863953] Dynamic subtest 1x-outputs: SUCCESS (1.974s)
[234.865673] Subtest modeset-transition: SUCCESS (1.975s)
[235.084108] [043/134] (796s left) sw_sync (sync_expired_merge)
[235.127103] Starting subtest: sync_expired_merge
[236.204903] Subtest sync_expired_merge: SUCCESS (1.074s)
[236.327853] [044/134] (795s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[236.371316] Starting subtest: invalid-signal-one-illegal-handle
[236.372899] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[236.509600] [045/134] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[237.998350] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[238.001142] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[238.244347] [046/134] (793s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[238.294938] Subtest no-spare-fences-busy: SKIP (0.000s)
[238.372038] [047/134] (793s left) syncobj_wait (wait-all-delayed-signal)
[238.417941] Starting subtest: wait-all-delayed-signal
[238.524183] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[238.699413] [048/134] (793s left) gem_exec_reloc (basic-concurrent16)
[238.750135] Subtest basic-concurrent16: SKIP (0.000s)
[238.880131] [049/134] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[240.373622] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[240.376728] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[240.609439] [050/134] (791s left) kms_big_fb (x-tiled-addfb)
[242.113702] Starting subtest: x-tiled-addfb
[242.115399] Subtest x-tiled-addfb: SUCCESS (0.000s)
[242.351681] [051/134] (790s left) perf_pmu (semaphore-wait)
[242.402432] Starting subtest: semaphore-wait
[242.403991] Starting dynamic subtest: rcs0
[242.932548] Dynamic subtest rcs0: SUCCESS (0.528s)
[242.948233] Starting dynamic subtest: bcs0
[243.450180] Dynamic subtest bcs0: SUCCESS (0.510s)
[243.461946] Starting dynamic subtest: vcs0
[243.964194] Dynamic subtest vcs0: SUCCESS (0.510s)
[243.975973] Starting dynamic subtest: vcs1
[244.478131] Dynamic subtest vcs1: SUCCESS (0.510s)
[244.489968] Starting dynamic subtest: vecs0
[244.992266] Dynamic subtest vecs0: SUCCESS (0.510s)
[244.993934] Subtest semaphore-wait: SUCCESS (2.588s)
[245.198015] [052/134] (787s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[246.682749] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[246.684300] Starting dynamic subtest: pipe-A-HDMI-A-4
[246.704571] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[246.716534] Starting dynamic subtest: pipe-B-HDMI-A-4
[246.734985] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[246.746602] Starting dynamic subtest: pipe-C-HDMI-A-4
[246.762025] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[246.773239] Starting dynamic subtest: pipe-D-HDMI-A-4
[246.787401] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[246.792706] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[246.965686] [053/134] (785s left) syncobj_timeline (multi-wait-for-submit-signaled)
[247.012236] Starting subtest: multi-wait-for-submit-signaled
[247.013710] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[247.210904] [054/134] (785s left) gem_userptr_blits (invalid-null-pointer)
[247.262438] Starting subtest: invalid-null-pointer
[247.263890] Subtest invalid-null-pointer: SUCCESS (0.001s)
[247.517831] [055/134] (785s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[247.569914] Starting subtest: y-tiled-to-vebox-y-tiled
[247.571505] Starting dynamic subtest: smem
[247.653381] Dynamic subtest smem: SUCCESS (0.083s)
[247.665400] Starting dynamic subtest: lmem0
[248.412670] Dynamic subtest lmem0: SUCCESS (0.755s)
[248.414423] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.840s)
[248.714692] [056/134] (784s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[250.206336] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[250.209755] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[250.465306] [057/134] (782s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[251.954662] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[251.957792] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[252.178449] [058/134] (780s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[253.661490] Starting subtest: bad-aux-stride-y-tiled-ccs
[253.662957] Starting dynamic subtest: pipe-A-HDMI-A-4
[253.677967] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[253.689942] Starting dynamic subtest: pipe-B-HDMI-A-4
[253.705542] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[253.716950] Starting dynamic subtest: pipe-C-HDMI-A-4
[253.733649] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[253.745370] Starting dynamic subtest: pipe-D-HDMI-A-4
[253.762771] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[253.766456] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.008s)
[253.947133] [059/134] (779s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[253.996045] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[253.997597] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[254.190248] [060/134] (779s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[255.680791] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[255.683905] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[255.953228] [061/134] (777s left) kms_sequence (get-forked)
[257.437514] Starting subtest: get-forked
[257.439195] Starting dynamic subtest: pipe-A-HDMI-A-4
[259.878893] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.441s)
[259.890759] Starting dynamic subtest: pipe-B-HDMI-A-4
[262.154715] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.275s)
[262.168857] Starting dynamic subtest: pipe-C-HDMI-A-4
[264.421784] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.265s)
[264.436175] Starting dynamic subtest: pipe-D-HDMI-A-4
[266.709232] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.284s)
[266.710517] Subtest get-forked: SUCCESS (9.273s)
[266.939217] [062/134] (766s left) gen3_render_tiledy_blits
[267.066750] [063/134] (766s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[267.110563] Starting subtest: etime-single-wait-for-submit-submitted
[267.216936] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[267.412962] [064/134] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[268.907393] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[268.910050] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[269.156150] [065/134] (764s left) kms_feature_discovery (display-3x)
[270.642472] Starting subtest: display-3x
[270.645855] Subtest display-3x: SKIP (0.000s)
[270.852776] [066/134] (763s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[272.345532] Starting subtest: fbc-rgb101010-draw-mmap-wc
[272.348326] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[272.585110] [067/134] (761s left) gem_exec_balancer (full-pulse)
[272.640072] Starting subtest: full-pulse
[275.072147] Subtest full-pulse: SUCCESS (2.432s)
[275.577493] [068/134] (758s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[277.061136] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[277.062818] Starting dynamic subtest: pipe-A-valid-mode
[277.113824] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[277.116720] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.052s)
[277.314767] [069/134] (757s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[278.818688] Starting subtest: yf-tiled-32bpp-rotate-270
[278.821419] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[279.073262] [070/134] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[280.565747] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[280.569047] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[280.834959] [071/134] (753s left) gem_fence_thrash (bo-write-verify-threaded-none)
[280.876788] Starting subtest: bo-write-verify-threaded-none
[280.881180] Subtest bo-write-verify-threaded-none: SKIP (0.002s)
[281.001471] [072/134] (753s left) gem_ctx_persistence (engines-hang)
[281.054528] Starting subtest: engines-hang
[281.055992] Starting dynamic subtest: rcs0
[281.135895] Dynamic subtest rcs0: SUCCESS (0.083s)
[281.158960] Starting dynamic subtest: bcs0
[281.243901] Dynamic subtest bcs0: SUCCESS (0.105s)
[281.291719] Starting dynamic subtest: vcs0
[281.322840] Dynamic subtest vcs0: SUCCESS (0.075s)
[281.341831] Starting dynamic subtest: vcs1
[281.435988] Dynamic subtest vcs1: SUCCESS (0.110s)
[281.483017] Starting dynamic subtest: vecs0
[281.494712] Dynamic subtest vecs0: SUCCESS (0.054s)
[281.496278] Subtest engines-hang: SUCCESS (0.443s)
[281.720648] [073/134] (753s left) kms_plane_lowres (tiling-4)
[283.206830] Starting subtest: tiling-4
[283.209749] Subtest tiling-4: SKIP (0.000s)
[283.425237] [074/134] (751s left) gem_exercise_blt (fast-copy)
[283.475031] Starting subtest: fast-copy
[283.476567] Starting dynamic subtest: linear-smem-smem
[283.515806] Dynamic subtest linear-smem-smem: SUCCESS (0.040s)
[283.528099] Starting dynamic subtest: linear-smem-lmem0
[283.533516] Dynamic subtest linear-smem-lmem0: SUCCESS (0.017s)
[283.545669] Starting dynamic subtest: linear-lmem0-smem
[283.596443] Dynamic subtest linear-lmem0-smem: SUCCESS (0.062s)
[283.608120] Starting dynamic subtest: linear-lmem0-lmem0
[283.657715] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.060s)
[283.669375] Starting dynamic subtest: ymajor-smem-smem
[283.675331] Dynamic subtest ymajor-smem-smem: SUCCESS (0.017s)
[283.687424] Starting dynamic subtest: ymajor-smem-lmem0
[283.692308] Dynamic subtest ymajor-smem-lmem0: SUCCESS (0.016s)
[283.704462] Starting dynamic subtest: ymajor-lmem0-smem
[283.755176] Dynamic subtest ymajor-lmem0-smem: SUCCESS (0.062s)
[283.767224] Starting dynamic subtest: ymajor-lmem0-lmem0
[283.817331] Dynamic subtest ymajor-lmem0-lmem0: SUCCESS (0.061s)
[283.829432] Starting dynamic subtest: tile4-smem-smem
[283.835873] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[283.848043] Starting dynamic subtest: tile4-smem-lmem0
[283.852896] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.016s)
[283.865120] Starting dynamic subtest: tile4-lmem0-smem
[283.915828] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.062s)
[283.927744] Starting dynamic subtest: tile4-lmem0-lmem0
[283.977186] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.060s)
[283.989223] Starting dynamic subtest: tile64-smem-smem
[283.994908] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[284.007302] Starting dynamic subtest: tile64-smem-lmem0
[284.011652] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s)
[284.023647] Starting dynamic subtest: tile64-lmem0-smem
[284.074042] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.061s)
[284.086109] Starting dynamic subtest: tile64-lmem0-lmem0
[284.136256] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.061s)
[284.137869] Subtest fast-copy: SUCCESS (0.662s)
[284.377471] [075/134] (750s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[285.863777] Starting subtest: compare-crc-sanitycheck-xr24
[285.865439] Starting dynamic subtest: pipe-A-HDMI-A-4
[286.394917] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.531s)
[286.406658] Starting dynamic subtest: pipe-B-HDMI-A-4
[286.794029] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.397s)
[286.809488] Starting dynamic subtest: pipe-C-HDMI-A-4
[287.225817] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.428s)
[287.239111] Starting dynamic subtest: pipe-D-HDMI-A-4
[287.657530] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.419s)
[287.658897] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.786s)
[287.926989] [076/134] (747s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[287.975362] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[288.082285] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[288.300973] [077/134] (747s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[289.791655] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[289.794456] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[290.048676] [078/134] (745s left) gem_exec_reloc (basic-cpu)
[290.100514] Subtest basic-cpu: SKIP (0.000s)
[290.279262] [079/134] (745s left) syncobj_timeline (reset-unsignaled)
[290.327049] Starting subtest: reset-unsignaled
[290.328687] Subtest reset-unsignaled: SUCCESS (0.000s)
[290.518606] [080/134] (745s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[292.004623] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[292.006196] Starting dynamic subtest: pipe-A-HDMI-A-4
[294.407995] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.393s)
[294.424586] Starting dynamic subtest: pipe-B-HDMI-A-4
[295.063446] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.646s)
[295.101946] Starting dynamic subtest: pipe-C-HDMI-A-4
[295.754716] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.679s)
[295.792686] Starting dynamic subtest: pipe-D-HDMI-A-4
[296.463242] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.697s)
[296.466040] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SUCCESS (4.455s)
[296.729852] [081/134] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[298.220397] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[298.223898] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[298.481821] [082/134] (737s left) kms_psr (psr-cursor-plane-move)
[299.969458] Subtest psr-cursor-plane-move: SKIP (0.000s)
[300.057300] [083/134] (735s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[301.549092] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[301.551872] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[301.786848] [084/134] (734s left) gem_wait (write-wait)
[301.847513] Starting subtest: write-wait
[301.849048] Starting dynamic subtest: all-engines
[302.962155] Dynamic subtest all-engines: SUCCESS (1.114s)
[302.997562] Starting dynamic subtest: rcs0
[304.054539] Dynamic subtest rcs0: SUCCESS (1.090s)
[304.074340] Starting dynamic subtest: bcs0
[305.125556] Dynamic subtest bcs0: SUCCESS (1.069s)
[305.139962] Starting dynamic subtest: vcs0
[306.184617] Dynamic subtest vcs0: SUCCESS (1.057s)
[306.210059] Starting dynamic subtest: vcs1
[307.247240] Dynamic subtest vcs1: SUCCESS (1.060s)
[307.292517] Starting dynamic subtest: vecs0
[308.328278] Dynamic subtest vecs0: SUCCESS (1.075s)
[308.336721] Subtest write-wait: SUCCESS (6.483s)
[308.699211] [085/134] (727s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[310.187204] Starting subtest: cursorB-vs-flipA-varying-size
[310.190196] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[310.412551] [086/134] (726s left) perf (blocking-parameterized)
[310.596286] Starting subtest: blocking-parameterized
[330.638780] Subtest blocking-parameterized: SUCCESS (20.042s)
[330.706308] [087/134] (705s left) kms_chamelium_edid (hdmi-edid-read)
[332.234303] Subtest hdmi-edid-read: SKIP (0.000s)
[332.345872] [088/134] (704s left) prime_mmap (test_errors)
[332.391034] Starting subtest: test_errors
[332.392351] Starting dynamic subtest: test_errors-smem
[332.580165] Dynamic subtest test_errors-smem: SUCCESS (0.185s)
[332.592036] Starting dynamic subtest: test_errors-lmem0
[332.762364] Dynamic subtest test_errors-lmem0: SUCCESS (0.184s)
[332.763693] Subtest test_errors: SUCCESS (0.372s)
[332.939112] [089/134] (703s left) fbdev (pan)
[332.983243] Starting subtest: pan
[333.030493] Subtest pan: SUCCESS (0.047s)
[333.252637] [090/134] (703s left) kms_invalid_mode (zero-clock)
[334.736644] Starting subtest: zero-clock
[334.737989] Starting dynamic subtest: pipe-A-HDMI-A-4
[334.787630] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.049s)
[334.799849] Starting dynamic subtest: pipe-B-HDMI-A-4
[334.801504] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[334.812894] Starting dynamic subtest: pipe-C-HDMI-A-4
[334.814322] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[334.825707] Starting dynamic subtest: pipe-D-HDMI-A-4
[334.827090] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[334.828527] Subtest zero-clock: SUCCESS (0.060s)
[335.016443] [091/134] (701s left) kms_atomic_transition (plane-all-transition-nonblocking)
[336.501744] Starting subtest: plane-all-transition-nonblocking
[336.503111] Starting dynamic subtest: pipe-A-HDMI-A-4
[340.379073] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.876s)
[340.465648] Starting dynamic subtest: pipe-B-HDMI-A-4
[344.377361] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.923s)
[344.450759] Subtest plane-all-transition-nonblocking: SUCCESS (7.950s)
[344.676040] [092/134] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[346.176528] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[346.182421] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[346.408785] [093/134] (690s left) gem_pxp (regular-baseline-src-copy-readible)
[348.980420] Starting subtest: regular-baseline-src-copy-readible
[348.984127] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[349.137922] [094/134] (687s left) kms_plane_scaling (planes-downscale-factor-0-5)
[350.625567] Starting subtest: planes-downscale-factor-0-5
[350.627168] Starting dynamic subtest: pipe-A
[350.775820] Dynamic subtest pipe-A: SUCCESS (0.152s)
[350.789357] Starting dynamic subtest: pipe-B
[350.916494] Dynamic subtest pipe-B: SUCCESS (0.139s)
[350.930726] Starting dynamic subtest: pipe-C
[351.057449] Dynamic subtest pipe-C: SUCCESS (0.139s)
[351.071860] Starting dynamic subtest: pipe-D
[351.198664] Dynamic subtest pipe-D: SUCCESS (0.140s)
[351.200152] Subtest planes-downscale-factor-0-5: SUCCESS (0.576s)
[351.421259] [095/134] (685s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[352.908504] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[352.984672] [096/134] (684s left) kms_content_protection (legacy-hdcp14)
[354.529745] Starting subtest: legacy-hdcp14
[354.538915] Subtest legacy-hdcp14: SKIP (0.005s)
[354.789589] [097/134] (682s left) gem_caching (writes)
[354.840364] Starting subtest: writes
[359.909322] Subtest writes: SUCCESS (5.069s)
[360.094242] [098/134] (677s left) kms_cursor_crc (cursor-onscreen-128x42)
[361.763671] Starting subtest: cursor-onscreen-128x42
[361.770934] Starting dynamic subtest: pipe-A-HDMI-A-4
[364.543774] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.773s)
[364.581755] Starting dynamic subtest: pipe-D-HDMI-A-4
[367.191156] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.622s)
[367.193194] Subtest cursor-onscreen-128x42: SUCCESS (5.427s)
[367.656826] [099/134] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[369.159985] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[372.245286] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.087s)
[372.537479] [100/134] (665s left) core_auth (getclient-master-drop)
[372.582090] Starting subtest: getclient-master-drop
[372.585209] Subtest getclient-master-drop: SUCCESS (0.004s)
[372.771502] [101/134] (665s left) gem_lmem_swapping (random)
[377.070049] Starting subtest: random
[377.071547] Starting dynamic subtest: lmem0
[378.256656] Dynamic subtest lmem0: SUCCESS (1.185s)
[378.258239] Subtest random: SUCCESS (1.186s)
[381.026408] [FACT gem_lmem_swapping (random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[381.027535] [FACT gem_lmem_swapping (random)] deleted: kernel.kmod_is_loaded.i915: true
[381.030335] [102/134] (656s left) kms_psr (pr-cursor-blt)
[385.801363] Subtest pr-cursor-blt: SKIP (0.000s)
[385.901310] [FACT kms_psr (pr-cursor-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[385.904806] [FACT kms_psr (pr-cursor-blt)] new: kernel.kmod_is_loaded.i915: true
[385.909059] [103/134] (652s left) kms_async_flips (alternate-sync-async-flip)
[387.403171] Starting subtest: alternate-sync-async-flip
[387.634498] Starting dynamic subtest: pipe-A-HDMI-A-4
[389.263272] Dynamic subtest pipe-A-HDMI-A-4: FAIL (1.220s)
[389.303064] Starting dynamic subtest: pipe-B-HDMI-A-4
[391.143992] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.084s)
[391.362722] Starting dynamic subtest: pipe-C-HDMI-A-4
[393.447073] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.089s)
[393.656548] Starting dynamic subtest: pipe-D-HDMI-A-4
[395.749553] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.098s)
[395.752296] Subtest alternate-sync-async-flip: FAIL (8.346s)
[396.203891] [104/134] (641s left) gem_exec_whisper (basic-contexts-all)
[396.267166] Starting subtest: basic-contexts-all
[403.853336] Subtest basic-contexts-all: SUCCESS (7.581s)
[404.134073] [105/134] (633s left) syncobj_wait (wait-any-interrupted)
[404.182748] Starting subtest: wait-any-interrupted
[404.284238] Subtest wait-any-interrupted: SUCCESS (0.102s)
[404.486619] [106/134] (633s left) kms_rotation_crc (bad-pixel-format)
[405.973116] Starting subtest: bad-pixel-format
[408.020033] Subtest bad-pixel-format: SUCCESS (2.050s)
[408.320615] [107/134] (629s left) kms_addfb_basic (too-wide)
[409.807522] Starting subtest: too-wide
[409.809155] Subtest too-wide: SUCCESS (0.000s)
[410.059324] [108/134] (628s left) gem_spin_batch (legacy-resubmit-new)
[410.117660] Starting subtest: legacy-resubmit-new
[410.119122] Starting dynamic subtest: default
[410.137422] Dynamic subtest default: SUCCESS (0.021s)
[410.149129] Starting dynamic subtest: render
[410.150756] Dynamic subtest render: SUCCESS (0.004s)
[410.162323] Starting dynamic subtest: bsd
[410.163812] Dynamic subtest bsd: SUCCESS (0.004s)
[410.175160] Starting dynamic subtest: bsd1
[410.176966] Dynamic subtest bsd1: SUCCESS (0.004s)
[410.188209] Starting dynamic subtest: bsd2
[410.189924] Dynamic subtest bsd2: SUCCESS (0.004s)
[410.200779] Starting dynamic subtest: blt
[410.202475] Dynamic subtest blt: SUCCESS (0.006s)
[410.213201] Starting dynamic subtest: vebox
[410.214912] Dynamic subtest vebox: SUCCESS (0.004s)
[410.216659] Subtest legacy-resubmit-new: SUCCESS (0.059s)
[410.532596] [109/134] (628s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[412.019962] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[412.021384] Starting dynamic subtest: pipe-A-valid-mode
[413.250859] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.229s)
[413.252310] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.232s)
[413.500979] [110/134] (625s left) gem_exec_balancer (parallel-keep-submit-fence)
[413.856602] Starting subtest: parallel-keep-submit-fence
[416.103233] Subtest parallel-keep-submit-fence: SUCCESS (2.247s)
[416.250970] [111/134] (622s left) perf (non-system-wide-paranoid)
[416.426939] Starting subtest: non-system-wide-paranoid
[416.473136] Subtest non-system-wide-paranoid: SUCCESS (0.047s)
[416.546606] [112/134] (622s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[418.034383] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[418.037310] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[418.245220] [113/134] (620s left) kms_busy (basic)
[419.738767] Starting subtest: basic
[419.740452] Starting dynamic subtest: flip
[420.386446] Dynamic subtest flip: SUCCESS (0.648s)
[420.398152] Starting dynamic subtest: modeset
[420.980874] Dynamic subtest modeset: SUCCESS (0.591s)
[420.982363] Subtest basic: SUCCESS (1.243s)
[421.274745] [114/134] (617s left) kms_plane (plane-panning-bottom-right-suspend)
[422.763704] Starting subtest: plane-panning-bottom-right-suspend
[422.765257] Starting dynamic subtest: pipe-A
[444.493790] Dynamic subtest pipe-A: SUCCESS (10.429s)
[444.507488] Starting dynamic subtest: pipe-B
[466.479404] Dynamic subtest pipe-B: SUCCESS (10.063s)
[466.481014] Subtest plane-panning-bottom-right-suspend: SUCCESS (20.497s)
[472.737001] [115/134] (572s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[472.787518] Starting subtest: invalid-multi-wait-all-unsubmitted
[472.789020] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[472.940737] [116/134] (572s left) kms_big_fb (linear-64bpp-rotate-180)
[474.445626] Starting subtest: linear-64bpp-rotate-180
[476.760599] Subtest linear-64bpp-rotate-180: SUCCESS (2.314s)
[477.074957] [117/134] (568s left) perf (invalid-oa-metric-set-id)
[477.226154] Starting subtest: invalid-oa-metric-set-id
[477.247532] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[477.327777] [118/134] (568s left) gen7_exec_parse (batch-without-end)
[477.380511] Subtest batch-without-end: SKIP (0.000s)
[477.458098] [119/134] (567s left) perf_pmu (most-busy-idle-check-all)
[477.507610] Starting subtest: most-busy-idle-check-all
[477.509159] Starting dynamic subtest: rcs0
[478.211107] Dynamic subtest rcs0: FAIL (0.647s)
[478.227021] Starting dynamic subtest: bcs0
[478.816834] Dynamic subtest bcs0: SUCCESS (0.662s)
[478.837747] Starting dynamic subtest: vcs0
[479.471441] Dynamic subtest vcs0: SUCCESS (0.651s)
[479.490245] Starting dynamic subtest: vcs1
[480.123486] Dynamic subtest vcs1: SUCCESS (0.650s)
[480.142059] Starting dynamic subtest: vecs0
[480.776514] Dynamic subtest vecs0: SUCCESS (0.651s)
[480.778194] Subtest most-busy-idle-check-all: FAIL (3.271s)
[480.949441] [120/134] (564s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[482.435708] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[482.438502] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[482.725163] [121/134] (562s left) perf_pmu (all-busy-idle-check-all)
[482.774704] Starting subtest: all-busy-idle-check-all
[483.445859] Subtest all-busy-idle-check-all: SUCCESS (0.671s)
[483.616611] [122/134] (562s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[485.100550] Starting subtest: primary-x-tiled-reflect-x-0
[495.707564] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.606s)
[495.976754] [123/134] (549s left) syncobj_wait (multi-wait-submitted)
[496.022964] Starting subtest: multi-wait-submitted
[496.130969] Subtest multi-wait-submitted: SUCCESS (0.107s)
[496.347224] [124/134] (549s left) dmabuf_sync_file (export-before-signal)
[496.407069] Starting subtest: export-before-signal
[496.408473] Subtest export-before-signal: SUCCESS (0.001s)
[496.554356] [125/134] (549s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[498.042857] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[498.051159] Starting dynamic subtest: pipe-A-HDMI-A-4
[498.063908] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[498.077785] Starting dynamic subtest: pipe-B-HDMI-A-4
[498.091003] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[498.104440] Starting dynamic subtest: pipe-C-HDMI-A-4
[498.117855] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[498.131185] Starting dynamic subtest: pipe-D-HDMI-A-4
[498.145222] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[498.147969] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[498.328549] [126/134] (547s left) kms_prop_blob (blob-prop-validate)
[498.374273] Starting subtest: blob-prop-validate
[498.375986] Subtest blob-prop-validate: SUCCESS (0.000s)
[498.577114] [127/134] (547s left) kms_vblank (query-busy-hang)
[500.062930] Starting subtest: query-busy-hang
[500.064364] Starting dynamic subtest: pipe-A-HDMI-A-4
[526.685977] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.626s)
[526.704785] Starting dynamic subtest: pipe-D-HDMI-A-4
[551.696445] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.005s)
[551.698085] Subtest query-busy-hang: SUCCESS (51.640s)
[551.916146] [128/134] (494s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[553.407284] Starting subtest: psr-2p-primscrn-cur-indfb-move
[553.410847] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[553.667764] [129/134] (492s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[555.163026] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[555.168225] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[555.431963] [130/134] (491s left) gem_exec_schedule (promotion)
[555.494295] Starting subtest: promotion
[555.495926] Starting dynamic subtest: rcs0
[555.697287] Dynamic subtest rcs0: SUCCESS (0.199s)
[555.711102] Starting dynamic subtest: bcs0
[555.839534] Dynamic subtest bcs0: SUCCESS (0.144s)
[555.853202] Starting dynamic subtest: vcs0
[555.982855] Dynamic subtest vcs0: SUCCESS (0.142s)
[555.996905] Starting dynamic subtest: vcs1
[556.138721] Dynamic subtest vcs1: SUCCESS (0.154s)
[556.155636] Starting dynamic subtest: vecs0
[556.302594] Dynamic subtest vecs0: SUCCESS (0.162s)
[556.304398] Subtest promotion: SUCCESS (0.809s)
[556.833532] [131/134] (489s left) gem_ctx_persistence (legacy-engines-queued)
[556.885724] Starting subtest: legacy-engines-queued
[556.887477] Starting dynamic subtest: render
[556.946763] Dynamic subtest render: SUCCESS (0.060s)
[556.961644] Starting dynamic subtest: bsd1
[556.971934] Dynamic subtest bsd1: SUCCESS (0.023s)
[556.986131] Starting dynamic subtest: bsd2
[557.017332] Dynamic subtest bsd2: SUCCESS (0.044s)
[557.033381] Starting dynamic subtest: blt
[557.056562] Dynamic subtest blt: SUCCESS (0.037s)
[557.072536] Starting dynamic subtest: vebox
[557.107481] Dynamic subtest vebox: SUCCESS (0.049s)
[557.108833] Subtest legacy-engines-queued: SUCCESS (0.223s)
[557.352297] [132/134] (489s left) gem_readwrite (new-obj)
[557.398720] Subtest new-obj: SKIP (0.000s)
[557.490203] [133/134] (489s left) gem_exec_reloc (basic-cpu-read-noreloc)
[557.540928] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[557.647448] [134/134] (489s left) gem_exec_schedule (preemptive-hang)
[557.820250] Starting subtest: preemptive-hang
[557.821793] Starting dynamic subtest: rcs0
[567.275747] Dynamic subtest rcs0: SUCCESS (9.456s)
[567.289990] Starting dynamic subtest: bcs0
[576.301785] Dynamic subtest bcs0: SUCCESS (9.025s)
[576.316476] Starting dynamic subtest: vcs0
[585.329760] Dynamic subtest vcs0: SUCCESS (9.026s)
[585.344074] Starting dynamic subtest: vcs1
[594.290378] Dynamic subtest vcs1: SUCCESS (8.959s)
[594.304603] Starting dynamic subtest: vecs0
[603.307480] Dynamic subtest vecs0: SUCCESS (9.016s)
[603.308942] Subtest preemptive-hang: SUCCESS (45.490s)
[603.683935] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: i915_module_load
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_pm_rpm
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: i915_suspend
results: parsing output: 32/ for test: gem_sync
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_mmap
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_fenced_exec_thrash
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: gen3_render_tiledy_blits
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_fence_thrash
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_plane_lowres
results: parsing output: 73/ for test: gem_exercise_blt
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_wait
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_chamelium_edid
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: fbdev
results: parsing output: 89/ for test: kms_invalid_mode
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: gem_caching
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: core_auth
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_async_flips
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gen7_exec_parse
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: dmabuf_sync_file
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_prop_blob
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: gem_readwrite
results: parsing output: 132/ for test: gem_exec_reloc
results: parsing output: 133/ for test: gem_exec_schedule
Done.