[57.830200] Initializing watchdogs
[57.830246]   /dev/watchdog0
[57.843493] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.847292] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.849322] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.852453] [001/130] (960s left) gem_userptr_blits (unsync-unmap)
[57.983950] Subtest unsync-unmap: SKIP (0.000s)
[58.123556] [002/130] (960s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[58.221959] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[58.224345] Starting dynamic subtest: pipe-A
[58.233422] Dynamic subtest pipe-A: SKIP (0.007s)
[58.239915] Starting dynamic subtest: pipe-B
[58.251915] Dynamic subtest pipe-B: SKIP (0.018s)
[58.258218] Starting dynamic subtest: pipe-C
[58.273875] Dynamic subtest pipe-C: SKIP (0.019s)
[58.280045] Starting dynamic subtest: pipe-D
[58.292688] Dynamic subtest pipe-D: SKIP (0.019s)
[58.296550] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.063s)
[58.369642] [003/130] (960s left) kms_psr (psr-cursor-blt)
[58.467417] Starting subtest: psr-cursor-blt
[58.469723] Starting dynamic subtest: eDP-1
[60.144081] Dynamic subtest eDP-1: SUCCESS (1.655s)
[60.146550] Subtest psr-cursor-blt: SUCCESS (1.656s)
[61.017598] [004/130] (957s left) kms_psr (fbc-psr2-primary-page-flip)
[61.120084] Starting subtest: fbc-psr2-primary-page-flip
[61.122107] Starting dynamic subtest: eDP-1
[61.126385] Dynamic subtest eDP-1: SKIP (0.000s)
[61.130753] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[61.192531] [005/130] (957s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[61.256890] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[61.261481] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[61.427969] [006/130] (957s left) gem_ctx_engines (execute-oneforall)
[61.496895] Starting subtest: execute-oneforall
[61.944920] Subtest execute-oneforall: SUCCESS (0.444s)
[63.062105] [007/130] (955s left) kms_vblank (wait-idle-hang)
[63.157928] Starting subtest: wait-idle-hang
[63.160370] Starting dynamic subtest: pipe-A-eDP-1
[89.716292] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.501s)
[89.729584] Starting dynamic subtest: pipe-D-eDP-1
[104.679276] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.953s)
[104.681811] Subtest wait-idle-hang: SUCCESS (41.460s)
[105.538714] [008/130] (913s left) gem_exec_balancer (parallel-keep-in-fence)
[105.786929] Starting subtest: parallel-keep-in-fence
[106.812603] Subtest parallel-keep-in-fence: SUCCESS (1.025s)
[106.927862] [009/130] (911s left) drm_fdinfo (virtual-busy)
[106.967971] Starting subtest: virtual-busy
[106.972283] Subtest virtual-busy: SKIP (0.000s)
[107.021173] [010/130] (911s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[107.125380] Starting subtest: 4-tiled-16bpp-rotate-270
[107.145270] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[107.247752] [011/130] (911s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[107.354099] Starting subtest: x-tiled-8bpp-rotate-90
[107.374776] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[107.488585] [012/130] (911s left) gem_mmap_gtt (cpuset-basic-small-copy)
[107.551124] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[107.596146] [013/130] (911s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[107.699483] Starting subtest: yf-tiled-8bpp-rotate-90
[107.703553] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[107.797231] [014/130] (911s left) kms_addfb_basic (master-rmfb)
[107.849380] Starting subtest: master-rmfb
[107.850926] Subtest master-rmfb: SUCCESS (0.001s)
[107.989866] [015/130] (910s left) kms_cursor_crc (cursor-onscreen-256x85)
[108.212328] Starting subtest: cursor-onscreen-256x85
[108.249435] Subtest cursor-onscreen-256x85: SKIP (0.034s)
[108.434847] [016/130] (910s left) kms_plane_alpha_blend (constant-alpha-min)
[108.535661] Starting subtest: constant-alpha-min
[108.949177] Starting dynamic subtest: pipe-A-eDP-1
[109.639260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[109.647689] Starting dynamic subtest: pipe-D-eDP-1
[111.108607] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s)
[111.110636] Subtest constant-alpha-min: SUCCESS (2.570s)
[111.889203] [017/130] (907s left) syncobj_timeline (wait-all-for-submit-complex)
[111.943830] Starting subtest: wait-all-for-submit-complex
[112.157614] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[112.224370] [018/130] (906s left) kms_force_connector_basic (force-connector-state)
[112.298512] Starting subtest: force-connector-state
[112.882315] Subtest force-connector-state: SUCCESS (0.584s)
[113.823097] [019/130] (905s left) gem_exec_store (pages)
[113.888686] Starting subtest: pages
[113.890663] Starting dynamic subtest: rcs0
[113.998348] Dynamic subtest rcs0: SUCCESS (0.111s)
[114.007679] Starting dynamic subtest: bcs0
[114.068483] Dynamic subtest bcs0: SUCCESS (0.070s)
[114.077482] Starting dynamic subtest: vcs0
[114.146233] Dynamic subtest vcs0: SUCCESS (0.078s)
[114.155346] Starting dynamic subtest: vcs1
[114.218396] Dynamic subtest vcs1: SUCCESS (0.072s)
[114.226172] Starting dynamic subtest: vecs0
[114.288322] Dynamic subtest vecs0: SUCCESS (0.070s)
[114.297287] Starting dynamic subtest: ccs0
[114.360329] Dynamic subtest ccs0: SUCCESS (0.072s)
[114.362690] Subtest pages: SUCCESS (0.474s)
[114.530258] [020/130] (904s left) kms_psr (pr-no-drrs)
[114.630826] Starting subtest: pr-no-drrs
[114.635170] Subtest pr-no-drrs: SKIP (0.000s)
[114.695751] [021/130] (904s left) gem_exec_balancer (bonded-sync)
[114.756777] Starting subtest: bonded-sync
[114.761351] Subtest bonded-sync: SKIP (0.000s)
[115.053131] [022/130] (904s left) kms_flip (2x-flip-vs-fences-interruptible)
[115.148684] Starting subtest: 2x-flip-vs-fences-interruptible
[115.154070] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[115.245416] [023/130] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[115.349453] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[120.136620] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.789s)
[120.286830] [024/130] (898s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[120.403720] Starting subtest: fbcpsr-modesetfrombusy
[124.534148] Subtest fbcpsr-modesetfrombusy: SUCCESS (4.129s)
[124.675012] [025/130] (894s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[124.775545] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[124.777533] Starting dynamic subtest: pipe-A-eDP-1
[125.657559] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s)
[125.665596] Starting dynamic subtest: pipe-B-eDP-1
[127.275207] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s)
[127.284132] Starting dynamic subtest: pipe-C-eDP-1
[128.775139] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[128.783418] Starting dynamic subtest: pipe-D-eDP-1
[130.309083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.532s)
[130.311200] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.523s)
[131.515361] [026/130] (887s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[131.623817] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[131.627761] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[131.713261] [027/130] (887s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[136.817296] Starting subtest: pr-overlay-plane-update-continuous-sf
[136.821890] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[137.618287] [028/130] (881s left) gem_lmem_swapping (parallel-random-engines)
[137.664665] Subtest parallel-random-engines: SKIP (0.000s)
[137.699627] [029/130] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[137.805841] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[137.809907] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[137.891058] [030/130] (881s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[137.990208] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[143.144286] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.157s)
[143.270155] [031/130] (876s left) kms_dp_linktrain_fallback (dsc-fallback)
[143.367415] Starting subtest: dsc-fallback
[143.374324] Subtest dsc-fallback: SKIP (0.000s)
[143.435814] [032/130] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[143.533498] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[143.537789] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.610816] [033/130] (875s left) gem_workarounds (basic-read-fd)
[143.666538] Starting subtest: basic-read-fd
[143.674616] Subtest basic-read-fd: SUCCESS (0.010s)
[143.779816] [034/130] (875s left) drm_fdinfo (all-busy-check-all)
[143.828750] Starting subtest: all-busy-check-all
[143.833153] Subtest all-busy-check-all: SKIP (0.004s)
[143.897129] [035/130] (875s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[144.011829] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[144.968104] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.957s)
[145.102805] [036/130] (874s left) gem_exec_whisper (basic-fds-priority-all)
[145.169285] Starting subtest: basic-fds-priority-all
[167.102965] Subtest basic-fds-priority-all: SUCCESS (21.930s)
[167.280124] [037/130] (852s left) syncobj_timeline (reset-multiple-signaled)
[167.339436] Starting subtest: reset-multiple-signaled
[167.341868] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[167.449232] [038/130] (852s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[167.561988] Starting subtest: flip-vs-cursor-atomic
[174.291442] Subtest flip-vs-cursor-atomic: SUCCESS (6.729s)
[175.112976] [039/130] (844s left) gem_shrink (reclaim)
[175.172585] Starting subtest: reclaim
[177.698917] Subtest reclaim: SUCCESS (2.528s)
[177.851142] [040/130] (841s left) kms_atomic_transition (plane-all-transition-fencing)
[177.944344] Starting subtest: plane-all-transition-fencing
[177.946556] Starting dynamic subtest: pipe-A-eDP-1
[180.452897] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[180.739037] Starting dynamic subtest: pipe-B-eDP-1
[183.921333] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.189s)
[184.212990] Subtest plane-all-transition-fencing: SUCCESS (6.265s)
[185.013184] [041/130] (834s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[185.135129] Starting subtest: 2x-flip-vs-cursor-atomic
[185.139449] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[185.227703] [042/130] (834s left) kms_rotation_crc (sprite-rotation-180)
[185.316114] Starting subtest: sprite-rotation-180
[190.285679] Subtest sprite-rotation-180: SUCCESS (4.968s)
[191.503375] [043/130] (828s left) gem_exec_fence (syncobj-wait)
[191.980217] Starting subtest: syncobj-wait
[193.906439] Subtest syncobj-wait: SUCCESS (1.924s)
[194.206219] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[194.210043] [044/130] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[194.314700] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[194.319250] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[194.433791] [045/130] (825s left) kms_psr (psr2-cursor-mmap-cpu)
[194.531301] Starting subtest: psr2-cursor-mmap-cpu
[194.533590] Starting dynamic subtest: eDP-1
[196.250619] Dynamic subtest eDP-1: SUCCESS (1.716s)
[196.252961] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.717s)
[197.108533] [046/130] (822s left) gem_exec_schedule (in-order)
[197.184531] Starting subtest: in-order
[197.186465] Starting dynamic subtest: rcs0
[197.274629] Dynamic subtest rcs0: SUCCESS (0.097s)
[197.285848] Starting dynamic subtest: vcs0
[197.351525] Dynamic subtest vcs0: SUCCESS (0.076s)
[197.362453] Starting dynamic subtest: vcs1
[197.422357] Dynamic subtest vcs1: SUCCESS (0.070s)
[197.433392] Starting dynamic subtest: vecs0
[197.494694] Dynamic subtest vecs0: SUCCESS (0.072s)
[197.506672] Starting dynamic subtest: ccs0
[197.576318] Dynamic subtest ccs0: SUCCESS (0.081s)
[197.578711] Subtest in-order: SUCCESS (0.399s)
[199.063050] [047/130] (820s left) api_intel_bb (full-batch)
[199.113374] Starting subtest: full-batch
[199.117416] Subtest full-batch: SUCCESS (0.007s)
[199.249283] [048/130] (820s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[199.343080] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[199.345325] Starting dynamic subtest: pipe-A-default-mode
[199.629462] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[199.634063] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.284s)
[200.409863] [049/130] (819s left) gem_exec_create (basic)
[200.469492] Starting subtest: basic
[200.471826] Starting dynamic subtest: smem
[203.882472] Dynamic subtest smem: SUCCESS (3.411s)
[203.885721] Subtest basic: SUCCESS (3.412s)
[204.060705] [050/130] (815s left) gem_exec_parallel (fds)
[204.130928] Starting subtest: fds
[204.133279] Starting dynamic subtest: rcs0
[207.586127] Dynamic subtest rcs0: SUCCESS (3.454s)
[207.595423] Starting dynamic subtest: bcs0
[210.813788] Dynamic subtest bcs0: SUCCESS (3.224s)
[210.828678] Starting dynamic subtest: vcs0
[215.048937] Dynamic subtest vcs0: SUCCESS (4.236s)
[215.056928] Starting dynamic subtest: vcs1
[219.128843] Dynamic subtest vcs1: SUCCESS (4.077s)
[219.140136] Starting dynamic subtest: vecs0
[223.145870] Dynamic subtest vecs0: SUCCESS (4.016s)
[223.156082] Starting dynamic subtest: ccs0
[226.263461] Dynamic subtest ccs0: SUCCESS (3.117s)
[226.265944] Subtest fds: SUCCESS (22.130s)
[226.454354] [051/130] (793s left) perf (gen12-oa-tlb-invalidate)
[226.571310] Starting subtest: gen12-oa-tlb-invalidate
[226.573496] Starting dynamic subtest: 0-rcs0
[236.632388] Dynamic subtest 0-rcs0: SUCCESS (10.059s)
[236.640839] Starting dynamic subtest: 1-vcs0
[246.680054] Dynamic subtest 1-vcs0: SUCCESS (10.046s)
[246.682761] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.107s)
[246.712783] [052/130] (773s left) gen7_exec_parse (basic-allocation)
[246.780196] Subtest basic-allocation: SKIP (0.000s)
[246.844640] [053/130] (773s left) kms_lease (lease-uevent)
[246.946136] Starting subtest: lease-uevent
[247.958040] Subtest lease-uevent: SUCCESS (1.010s)
[248.031984] [054/130] (772s left) kms_hdr (static-toggle-suspend)
[248.129139] Starting subtest: static-toggle-suspend
[248.135874] Subtest static-toggle-suspend: SKIP (0.000s)
[248.195492] [055/130] (772s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[248.311973] Starting subtest: cursorA-vs-flipA-toggle
[259.460047] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.147s)
[260.301569] [056/130] (759s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[260.409507] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[264.911295] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.504s)
[265.027589] [057/130] (755s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[265.143451] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[265.147764] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[265.229951] [058/130] (755s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[265.628540] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[266.383271] [059/130] (753s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[266.500975] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[266.505539] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[266.616131] [060/130] (753s left) syncobj_basic (bad-destroy)
[266.672101] Starting subtest: bad-destroy
[266.674173] Subtest bad-destroy: SUCCESS (0.000s)
[266.769357] [061/130] (753s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[266.868927] Starting subtest: addfb25-yf-tiled-legacy
[266.871208] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[266.963370] [062/130] (753s left) kms_content_protection (legacy)
[267.137627] Starting subtest: legacy
[270.935197] Subtest legacy: SKIP (3.794s)
[272.106159] [063/130] (748s left) kms_flip (modeset-vs-vblank-race)
[272.213223] Starting subtest: modeset-vs-vblank-race
[272.215520] Starting dynamic subtest: A-eDP1
[276.903247] Dynamic subtest A-eDP1: SUCCESS (4.689s)
[276.913400] Starting dynamic subtest: B-eDP1
[281.602224] Dynamic subtest B-eDP1: SUCCESS (4.697s)
[281.616764] Starting dynamic subtest: C-eDP1
[286.281439] Dynamic subtest C-eDP1: SUCCESS (4.677s)
[286.290071] Starting dynamic subtest: D-eDP1
[290.980883] Dynamic subtest D-eDP1: SUCCESS (4.699s)
[290.985603] Subtest modeset-vs-vblank-race: SUCCESS (18.772s)
[292.206287] [064/130] (728s left) gem_exec_balancer (sliced)
[292.270078] Starting subtest: sliced
[292.274552] Subtest sliced: SKIP (0.000s)
[292.546461] [065/130] (728s left) gen9_exec_parse (secure-batches)
[292.593887] Subtest secure-batches: SKIP (0.000s)
[292.657538] [066/130] (727s left) kms_pm_rpm (dpms-lpsp)
[294.201505] Starting subtest: dpms-lpsp
[294.851038] Subtest dpms-lpsp: SUCCESS (0.654s)
[294.936054] [067/130] (725s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[295.042755] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[295.047251] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[295.146912] [068/130] (725s left) drm_read (short-buffer-block)
[295.307066] Starting subtest: short-buffer-block
[295.309235] Subtest short-buffer-block: SUCCESS (0.000s)
[295.435709] [069/130] (725s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[295.538634] Starting subtest: x-tiled-64bpp-rotate-0
[297.817993] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.279s)
[298.042908] [070/130] (722s left) kms_plane (plane-panning-bottom-right)
[298.144134] Starting subtest: plane-panning-bottom-right
[298.146356] Starting dynamic subtest: pipe-A
[299.818777] Dynamic subtest pipe-A: SUCCESS (1.672s)
[299.827876] Starting dynamic subtest: pipe-B
[302.122619] Dynamic subtest pipe-B: SUCCESS (2.303s)
[302.125295] Subtest plane-panning-bottom-right: SUCCESS (3.978s)
[302.903965] [071/130] (717s left) core_setmaster (master-drop-set-shared-fd)
[304.956297] Starting subtest: master-drop-set-shared-fd
[304.975449] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[305.001491] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true
[305.002142] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.xe: true
[305.005340] [072/130] (715s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[305.059884] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[305.128691] [073/130] (715s left) perf (invalid-oa-exponent)
[305.208417] Starting subtest: invalid-oa-exponent
[305.227641] Subtest invalid-oa-exponent: SUCCESS (0.016s)
[305.257322] [074/130] (715s left) perf_pmu (most-busy-idle-check-all)
[305.299332] Starting subtest: most-busy-idle-check-all
[305.301606] Starting dynamic subtest: rcs0
[306.923477] Dynamic subtest rcs0: SUCCESS (1.622s)
[306.933416] Starting dynamic subtest: bcs0
[308.909025] Dynamic subtest bcs0: SUCCESS (1.983s)
[308.919774] Starting dynamic subtest: vcs0
[310.955950] Dynamic subtest vcs0: SUCCESS (2.043s)
[310.967132] Starting dynamic subtest: vcs1
[312.939044] Dynamic subtest vcs1: SUCCESS (1.981s)
[312.949649] Starting dynamic subtest: vecs0
[314.923481] Dynamic subtest vecs0: SUCCESS (1.981s)
[314.933343] Starting dynamic subtest: ccs0
[316.971818] Dynamic subtest ccs0: SUCCESS (2.045s)
[316.974698] Subtest most-busy-idle-check-all: SUCCESS (11.672s)
[317.077780] [075/130] (703s left) kms_prop_blob (invalid-set-prop-any)
[317.124249] Starting subtest: invalid-set-prop-any
[317.126429] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[317.236154] [076/130] (703s left) gem_mmap_offset (clear-via-pagefault)
[317.300548] Starting subtest: clear-via-pagefault
[317.302440] Starting dynamic subtest: smem0
[370.843276] Dynamic subtest smem0: SUCCESS (53.534s)
[370.845824] Subtest clear-via-pagefault: SUCCESS (53.536s)
[370.988058] [077/130] (649s left) gem_exec_params (rsvd2-dirt)
[371.048567] Starting subtest: rsvd2-dirt
[371.053113] Subtest rsvd2-dirt: SKIP (0.000s)
[371.163787] [078/130] (649s left) kms_vblank (query-idle)
[371.271080] Starting subtest: query-idle
[371.273257] Starting dynamic subtest: pipe-A-eDP-1
[373.028201] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[373.040889] Starting dynamic subtest: pipe-D-eDP-1
[375.506372] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.476s)
[375.508807] Subtest query-idle: SUCCESS (4.233s)
[376.296391] [079/130] (644s left) kms_addfb_basic (bad-pitch-999)
[376.365690] Starting subtest: bad-pitch-999
[376.367701] Subtest bad-pitch-999: SUCCESS (0.000s)
[376.516497] [080/130] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[376.623192] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[376.627827] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[376.735396] [081/130] (644s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[376.830221] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[376.835026] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[377.893042] [082/130] (643s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[377.980494] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[377.982945] Starting dynamic subtest: pipe-A-eDP-1
[378.406396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[378.416557] Starting dynamic subtest: pipe-B-eDP-1
[379.764549] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[379.773668] Starting dynamic subtest: pipe-C-eDP-1
[381.141371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[381.151136] Starting dynamic subtest: pipe-D-eDP-1
[382.441355] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[382.443703] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.431s)
[383.599325] [083/130] (637s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[383.709868] Starting subtest: flip-primary-invalidate-overlay
[396.075920] Subtest flip-primary-invalidate-overlay: SUCCESS (12.369s)
[396.384767] [084/130] (624s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[396.467136] Starting subtest: map-fixed-invalidate-overlap-busy
[396.471556] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[396.603763] [085/130] (624s left) gem_sync (basic-each)
[396.682678] Starting subtest: basic-each
[399.086067] Subtest basic-each: SUCCESS (2.413s)
[399.268335] [086/130] (621s left) syncobj_timeline (multi-wait-all-available-submitted)
[399.324323] Starting subtest: multi-wait-all-available-submitted
[399.326560] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[399.438965] [087/130] (621s left) kms_flip (basic-flip-vs-wf_vblank)
[399.542128] Starting subtest: basic-flip-vs-wf_vblank
[399.544415] Starting dynamic subtest: A-eDP1
[401.516427] Dynamic subtest A-eDP1: SUCCESS (1.973s)
[401.526048] Starting dynamic subtest: B-eDP1
[403.415454] Dynamic subtest B-eDP1: SUCCESS (1.898s)
[403.424516] Starting dynamic subtest: C-eDP1
[405.306055] Dynamic subtest C-eDP1: SUCCESS (1.889s)
[405.316581] Starting dynamic subtest: D-eDP1
[407.206106] Dynamic subtest D-eDP1: SUCCESS (1.899s)
[407.208563] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.666s)
[408.393037] [088/130] (612s left) kms_cursor_legacy (forked-bo)
[408.503751] Starting subtest: forked-bo
[408.505892] Starting dynamic subtest: pipe-A
[413.988026] Dynamic subtest pipe-A: SUCCESS (5.480s)
[414.000127] Starting dynamic subtest: pipe-B
[419.488673] Dynamic subtest pipe-B: SUCCESS (5.498s)
[419.500737] Starting dynamic subtest: pipe-C
[424.983036] Dynamic subtest pipe-C: SUCCESS (5.492s)
[424.995633] Starting dynamic subtest: pipe-D
[430.471066] Dynamic subtest pipe-D: SUCCESS (5.486s)
[430.481250] Starting dynamic subtest: all-pipes
[436.015233] Dynamic subtest all-pipes: SUCCESS (5.542s)
[436.017872] Subtest forked-bo: SUCCESS (27.506s)
[436.141360] [089/130] (585s left) gem_madvise (dontneed-before-mmap)
[436.177580] Starting subtest: dontneed-before-mmap
[436.203533] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[436.317441] [090/130] (585s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[436.424684] Starting subtest: fbc-rgb565-draw-mmap-gtt
[436.428804] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[436.531554] [091/130] (584s left) sriov_basic (enable-vfs-autoprobe-off)
[436.597965] Starting subtest: enable-vfs-autoprobe-off
[436.599907] Starting dynamic subtest: numvfs-1
[436.672995] Dynamic subtest numvfs-1: FAIL (0.012s)
[436.682733] Starting dynamic subtest: numvfs-2
[436.759286] Dynamic subtest numvfs-2: FAIL (0.003s)
[436.768752] Starting dynamic subtest: numvfs-3
[436.842114] Dynamic subtest numvfs-3: FAIL (0.003s)
[436.852037] Starting dynamic subtest: numvfs-4
[436.924995] Dynamic subtest numvfs-4: FAIL (0.003s)
[436.935423] Starting dynamic subtest: numvfs-5
[437.009983] Dynamic subtest numvfs-5: FAIL (0.004s)
[437.018889] Starting dynamic subtest: numvfs-6
[437.083395] Dynamic subtest numvfs-6: FAIL (0.003s)
[437.092839] Starting dynamic subtest: numvfs-7
[437.153830] Dynamic subtest numvfs-7: FAIL (0.003s)
[437.161959] Starting dynamic subtest: numvfs-random
[437.221621] Dynamic subtest numvfs-random: FAIL (0.003s)
[437.230863] Starting dynamic subtest: numvfs-all
[437.289078] Dynamic subtest numvfs-all: FAIL (0.499s)
[437.290610] Subtest enable-vfs-autoprobe-off: FAIL (0.538s)
[437.317908] [092/130] (584s left) gem_ctx_persistence (heartbeat-hostile)
[437.369335] Starting subtest: heartbeat-hostile
[437.373073] Subtest heartbeat-hostile: SKIP (0.000s)
[437.458088] [093/130] (584s left) gem_ctx_param (set-priority-range)
[437.515316] Starting subtest: set-priority-range
[437.531914] Subtest set-priority-range: SUCCESS (0.017s)
[437.629619] [094/130] (583s left) kms_chamelium_frames (dp-crc-single)
[438.008066] Subtest dp-crc-single: SKIP (0.000s)
[438.774106] [095/130] (582s left) i915_hangman (gt-engine-hang)
[438.842063] Starting subtest: gt-engine-hang
[438.844384] Starting dynamic subtest: rcs0
[439.881483] Dynamic subtest rcs0: SUCCESS (1.039s)
[439.893301] Starting dynamic subtest: bcs0
[441.863833] Dynamic subtest bcs0: SUCCESS (1.980s)
[441.872994] Starting dynamic subtest: vcs0
[443.849420] Dynamic subtest vcs0: SUCCESS (1.983s)
[443.860658] Starting dynamic subtest: vcs1
[445.896614] Dynamic subtest vcs1: SUCCESS (2.045s)
[445.908293] Starting dynamic subtest: vecs0
[447.881454] Dynamic subtest vecs0: SUCCESS (1.982s)
[447.895901] Starting dynamic subtest: ccs0
[449.928098] Dynamic subtest ccs0: SUCCESS (2.044s)
[449.930814] Subtest gt-engine-hang: SUCCESS (11.086s)
[450.002842] [096/130] (571s left) syncobj_wait (invalid-reset-bad-pad)
[450.065971] Starting subtest: invalid-reset-bad-pad
[450.068582] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[450.180180] [097/130] (571s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[455.280338] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[455.282634] Starting dynamic subtest: pipe-A-eDP-1
[456.042152] Dynamic subtest pipe-A-eDP-1: SKIP (0.758s)
[456.051533] Starting dynamic subtest: pipe-B-eDP-1
[457.242087] Dynamic subtest pipe-B-eDP-1: SKIP (1.197s)
[457.248028] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.959s)
[458.388546] [098/130] (563s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[458.491073] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[458.493251] Starting dynamic subtest: pipe-A-eDP-1
[458.513081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[458.523133] Starting dynamic subtest: pipe-B-eDP-1
[458.541621] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[458.550504] Starting dynamic subtest: pipe-C-eDP-1
[458.571275] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[458.584800] Starting dynamic subtest: pipe-D-eDP-1
[458.604721] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[458.606799] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[460.689625] [099/130] (561s left) gem_exec_reloc (basic-cpu-gtt)
[460.759881] Subtest basic-cpu-gtt: SKIP (0.000s)
[460.832788] [100/130] (560s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[460.930384] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[460.932805] Starting dynamic subtest: pipe-A-default-mode
[461.217413] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[461.221922] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.285s)
[461.992586] [101/130] (559s left) gem_ctx_param (invalid-ctx-get)
[462.051962] Starting subtest: invalid-ctx-get
[462.054428] Subtest invalid-ctx-get: SUCCESS (0.000s)
[462.116903] [102/130] (559s left) gem_exec_schedule (semaphore-codependency)
[462.188675] Starting subtest: semaphore-codependency
[462.193561] Subtest semaphore-codependency: SUCCESS (0.011s)
[462.524862] [103/130] (559s left) kms_color (legacy-gamma-reset)
[462.612020] Starting subtest: legacy-gamma-reset
[462.614260] Starting dynamic subtest: pipe-A-eDP-1
[462.989929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[462.999030] Starting dynamic subtest: pipe-B-eDP-1
[463.001387] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[463.009656] Starting dynamic subtest: pipe-C-eDP-1
[463.012048] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[463.020225] Starting dynamic subtest: pipe-D-eDP-1
[463.022207] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[463.024668] Subtest legacy-gamma-reset: SUCCESS (0.413s)
[463.792046] [104/130] (558s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[463.897070] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[463.899263] Starting dynamic subtest: pipe-A-eDP-1
[464.641607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[464.651266] Starting dynamic subtest: pipe-B-eDP-1
[466.399053] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.755s)
[466.412057] Starting dynamic subtest: pipe-C-eDP-1
[468.198474] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.798s)
[468.206045] Starting dynamic subtest: pipe-D-eDP-1
[469.987435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.787s)
[469.989507] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.081s)
[471.187757] [105/130] (550s left) kms_joiner (basic-ultra-joiner)
[471.299568] Starting subtest: basic-ultra-joiner
[471.303569] Subtest basic-ultra-joiner: SKIP (0.000s)
[471.358888] [106/130] (550s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[471.459095] Starting subtest: sprite-rotation-90-pos-100-0
[471.463749] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[471.529275] [107/130] (550s left) perf_pmu (all-busy-idle-check-all)
[471.572722] Starting subtest: all-busy-idle-check-all
[472.938876] Subtest all-busy-idle-check-all: SUCCESS (1.366s)
[473.050060] [108/130] (548s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[473.151116] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[473.153383] Starting dynamic subtest: pipe-A
[473.488884] Dynamic subtest pipe-A: SUCCESS (0.337s)
[473.497804] Starting dynamic subtest: pipe-B
[474.845142] Dynamic subtest pipe-B: SUCCESS (1.356s)
[474.858330] Starting dynamic subtest: pipe-C
[476.245088] Dynamic subtest pipe-C: SUCCESS (1.399s)
[476.253057] Starting dynamic subtest: pipe-D
[477.655975] Dynamic subtest pipe-D: SUCCESS (1.410s)
[477.658317] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.505s)
[478.790121] [109/130] (543s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[478.890876] Starting subtest: primary-x-tiled-reflect-x-0
[485.771913] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.878s)
[486.988175] [110/130] (535s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[487.049699] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[487.158872] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[487.229727] [111/130] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[487.340352] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[487.344517] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[487.450262] [112/130] (534s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[487.552904] Starting subtest: fbc-pr-sprite-mmap-gtt
[487.556853] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[487.621192] [113/130] (534s left) gem_exec_alignment (single)
[487.689559] Starting subtest: single
[487.694765] Subtest single: SUCCESS (0.003s)
[487.824646] [114/130] (534s left) kms_busy (basic-hang)
[487.921664] Starting subtest: basic-hang
[487.924066] Starting dynamic subtest: flip-pipe-A
[488.521785] Dynamic subtest flip-pipe-A: SUCCESS (0.597s)
[488.530545] Starting dynamic subtest: modeset-pipe-A
[491.927251] Dynamic subtest modeset-pipe-A: SUCCESS (3.405s)
[491.936435] Starting dynamic subtest: flip-pipe-D
[493.196674] Dynamic subtest flip-pipe-D: SUCCESS (1.265s)
[493.205814] Starting dynamic subtest: modeset-pipe-D
[496.518930] Dynamic subtest modeset-pipe-D: SUCCESS (3.322s)
[496.521751] Subtest basic-hang: SUCCESS (8.595s)
[497.389350] [115/130] (524s left) kms_cursor_crc (cursor-sliding-64x21)
[497.548053] Starting subtest: cursor-sliding-64x21
[497.588301] Subtest cursor-sliding-64x21: SKIP (0.034s)
[497.826745] [116/130] (524s left) i915_pm_rps (basic-api)
[497.886963] Starting subtest: basic-api
[497.891770] Subtest basic-api: SKIP (0.000s)
[497.957365] [117/130] (524s left) gem_ctx_shared (q-in-order)
[498.018284] Starting subtest: Q-in-order
[498.020614] Starting dynamic subtest: rcs0
[498.128354] Dynamic subtest rcs0: SUCCESS (0.108s)
[498.137265] Starting dynamic subtest: vcs0
[498.216710] Dynamic subtest vcs0: SUCCESS (0.088s)
[498.229290] Starting dynamic subtest: vcs1
[498.300747] Dynamic subtest vcs1: SUCCESS (0.083s)
[498.315302] Starting dynamic subtest: vecs0
[498.392888] Dynamic subtest vecs0: SUCCESS (0.091s)
[498.408541] Starting dynamic subtest: ccs0
[498.465477] Dynamic subtest ccs0: SUCCESS (0.071s)
[498.468059] Subtest Q-in-order: SUCCESS (0.447s)
[500.047371] [118/130] (522s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[500.154790] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[500.159291] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[500.244526] [119/130] (522s left) gem_pxp (reject-modify-context-protection-off-3)
[500.368899] Starting subtest: reject-modify-context-protection-off-3
[500.371350] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[500.491521] [120/130] (521s left) vgem_basic (second-client)
[500.536099] Starting subtest: second-client
[500.556635] Subtest second-client: SUCCESS (0.021s)
[500.604573] [121/130] (521s left) perf (missing-sample-flags)
[500.686455] Starting subtest: missing-sample-flags
[500.688805] Subtest missing-sample-flags: SUCCESS (0.000s)
[500.728957] [122/130] (521s left) syncobj_timeline (invalid-signal-bad-pad)
[500.795059] Starting subtest: invalid-signal-bad-pad
[500.797363] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[500.886888] [123/130] (521s left) gem_mmap_wc (copy)
[500.947338] Subtest copy: SKIP (0.000s)
[501.015486] [124/130] (521s left) kms_panel_fitting (atomic-fastset)
[501.118770] Starting subtest: atomic-fastset
[501.120737] Starting dynamic subtest: pipe-A-eDP-1
[501.261206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[501.269644] Starting dynamic subtest: pipe-B-eDP-1
[502.522989] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s)
[502.533336] Starting dynamic subtest: pipe-C-eDP-1
[503.669552] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.144s)
[503.677216] Starting dynamic subtest: pipe-D-eDP-1
[504.865971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[504.868312] Subtest atomic-fastset: SUCCESS (3.745s)
[506.086937] [125/130] (516s left) gem_softpin (evict-prime-sanity-check)
[506.146510] Starting subtest: evict-prime-sanity-check
[506.149074] Starting dynamic subtest: rcs0
[507.314112] Dynamic subtest rcs0: SUCCESS (1.167s)
[507.324847] Starting dynamic subtest: bcs0
[508.464280] Dynamic subtest bcs0: SUCCESS (1.148s)
[508.476260] Starting dynamic subtest: vcs0
[509.912470] Dynamic subtest vcs0: SUCCESS (1.445s)
[509.923743] Starting dynamic subtest: vcs1
[511.896634] Dynamic subtest vcs1: SUCCESS (1.982s)
[511.907024] Starting dynamic subtest: vecs0
[513.907547] Dynamic subtest vecs0: SUCCESS (2.009s)
[513.918113] Starting dynamic subtest: ccs0
[515.051061] Dynamic subtest ccs0: SUCCESS (1.142s)
[515.062367] Starting dynamic subtest: all
[516.193337] Dynamic subtest all: SUCCESS (1.140s)
[516.196110] Subtest evict-prime-sanity-check: SUCCESS (10.047s)
[516.268022] [126/130] (506s left) kms_feature_discovery (dp-mst)
[516.365142] Starting subtest: dp-mst
[516.369216] Subtest dp-mst: SKIP (0.000s)
[516.428338] [127/130] (506s left) prime_vgem (basic-fence-read)
[516.498074] Starting subtest: basic-fence-read
[516.518288] Subtest basic-fence-read: SKIP (0.017s)
[516.632985] [128/130] (506s left) gem_compute (compute-square)
[516.684035] Starting subtest: compute-square
[516.788901] Subtest compute-square: FAIL (0.010s)
[516.821576] [129/130] (505s left) gem_partial_pwrite_pread (writes-after-reads-display)
[516.877425] Subtest writes-after-reads-display: SKIP (0.000s)
[516.952277] [130/130] (505s left) gem_userptr_blits (nohangcheck)
[517.025799] Starting subtest: nohangcheck
[517.300871] Subtest nohangcheck: SUCCESS (0.271s)
[517.418125] Closing watchdogs
Done.