[57.455029] Initializing watchdogs
[57.455149]   /dev/watchdog0
[57.472280] [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.476642] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.479255] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.482607] [001/133] (960s left) kms_pm_backlight (fade)
[57.596089] Starting subtest: fade
[57.685897] Starting dynamic subtest: eDP-1
[60.162931] Dynamic subtest eDP-1: SUCCESS (2.476s)
[60.165342] Subtest fade: SUCCESS (2.567s)
[61.001059] [002/133] (957s left) gem_ctx_persistence (file)
[61.062204] Starting subtest: file
[61.172832] Subtest file: SUCCESS (0.110s)
[61.279734] [003/133] (956s left) gem_cs_tlb (engines)
[61.333980] Starting subtest: engines
[61.335878] Starting dynamic subtest: rcs0
[63.487903] Dynamic subtest rcs0: SUCCESS (2.152s)
[63.498143] Starting dynamic subtest: bcs0
[65.642881] Dynamic subtest bcs0: SUCCESS (2.153s)
[65.649504] Starting dynamic subtest: vcs0
[67.796346] Dynamic subtest vcs0: SUCCESS (2.152s)
[67.806990] Starting dynamic subtest: vcs1
[69.947365] Dynamic subtest vcs1: SUCCESS (2.152s)
[69.957520] Starting dynamic subtest: vecs0
[72.100463] Dynamic subtest vecs0: SUCCESS (2.151s)
[72.108171] Starting dynamic subtest: ccs0
[74.257549] Dynamic subtest ccs0: SUCCESS (2.156s)
[74.260116] Subtest engines: SUCCESS (12.919s)
[74.388894] [004/133] (943s left) kms_chamelium_audio (hdmi-audio)
[74.772031] Subtest hdmi-audio: SKIP (0.000s)
[75.617685] [005/133] (942s left) kms_big_fb (linear-32bpp-rotate-270)
[75.715618] Starting subtest: linear-32bpp-rotate-270
[75.737087] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[75.833938] [006/133] (942s left) gem_ctx_param (invalid-ctx-get)
[75.902864] Starting subtest: invalid-ctx-get
[75.905510] Subtest invalid-ctx-get: SUCCESS (0.000s)
[75.985431] [007/133] (942s left) fbdev (unaligned-read)
[76.027561] Starting subtest: unaligned-read
[76.041746] Subtest unaligned-read: SUCCESS (0.014s)
[76.093055] [008/133] (942s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[76.195341] Starting subtest: y-tiled-16bpp-rotate-180
[76.199600] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[76.318512] [009/133] (941s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[76.406126] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[76.408509] Starting dynamic subtest: pipe-A
[76.468406] Dynamic subtest pipe-A: SUCCESS (0.065s)
[76.475103] Starting dynamic subtest: pipe-B
[77.656061] Dynamic subtest pipe-B: SUCCESS (1.187s)
[77.669914] Starting dynamic subtest: pipe-C
[78.772837] Dynamic subtest pipe-C: SUCCESS (1.116s)
[78.781595] Starting dynamic subtest: pipe-D
[79.905512] Dynamic subtest pipe-D: SUCCESS (1.132s)
[79.908034] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.502s)
[81.065114] [010/133] (937s left) kms_plane_multiple (tiling-none)
[81.159231] Starting subtest: tiling-none
[81.161608] Starting dynamic subtest: pipe-A-eDP-1
[84.804509] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.646s)
[84.812046] Starting dynamic subtest: pipe-B-eDP-1
[89.243051] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.438s)
[89.252257] Starting dynamic subtest: pipe-C-eDP-1
[93.563622] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[93.572660] Starting dynamic subtest: pipe-D-eDP-1
[97.885798] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.320s)
[97.888096] Subtest tiling-none: SUCCESS (16.727s)
[98.694273] [011/133] (919s left) gen3_render_mixed_blits
[98.833844] [012/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[98.934181] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[98.938140] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[99.018763] [013/133] (919s left) gem_exec_params (invalid-batch-start-offset)
[99.070087] Starting subtest: invalid-batch-start-offset
[99.072530] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[99.190910] [014/133] (919s left) kms_scaling_modes (scaling-mode-center)
[99.288262] Starting subtest: scaling-mode-center
[99.290728] Starting dynamic subtest: pipe-A-eDP-1
[99.378830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[99.387446] Starting dynamic subtest: pipe-B-eDP-1
[100.533074] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[100.540585] Starting dynamic subtest: pipe-C-eDP-1
[101.644499] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[101.651822] Starting dynamic subtest: pipe-D-eDP-1
[102.772053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[102.774377] Subtest scaling-mode-center: SUCCESS (3.487s)
[103.933962] [015/133] (914s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[104.025243] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[104.027406] Starting dynamic subtest: pipe-A-eDP-1
[104.826132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s)
[104.835300] Starting dynamic subtest: pipe-B-eDP-1
[106.341348] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.514s)
[106.348731] Starting dynamic subtest: pipe-C-eDP-1
[107.866197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.525s)
[107.874726] Starting dynamic subtest: pipe-D-eDP-1
[109.426032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.559s)
[109.428358] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.395s)
[110.570366] [016/133] (907s left) testdisplay
[110.870544] [017/133] (907s left) vgem_basic (bad-flag)
[110.993076] Starting subtest: bad-flag
[110.995261] Subtest bad-flag: SUCCESS (0.000s)
[111.044557] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[111.048122] [018/133] (907s left) gem_mmap (short-mmap)
[111.108263] Subtest short-mmap: SKIP (0.000s)
[111.170171] [019/133] (907s left) kms_psr (pr-cursor-blt)
[111.260946] Starting subtest: pr-cursor-blt
[111.265276] Subtest pr-cursor-blt: SKIP (0.000s)
[111.331126] [020/133] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[111.430167] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[111.434463] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[111.539567] [021/133] (907s left) kms_joiner (invalid-modeset-big-joiner)
[111.637364] Starting subtest: invalid-modeset-big-joiner
[111.640792] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[111.701795] [022/133] (907s left) i915_query (query-garbage)
[111.759781] Starting subtest: query-garbage
[111.761332] Subtest query-garbage: SUCCESS (0.000s)
[111.850192] [023/133] (906s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[111.936669] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[111.938502] Starting dynamic subtest: pipe-A-eDP-1
[111.957064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.965632] Starting dynamic subtest: pipe-B-eDP-1
[111.982858] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.989535] Starting dynamic subtest: pipe-C-eDP-1
[112.006525] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.014179] Starting dynamic subtest: pipe-D-eDP-1
[112.031953] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.035374] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[114.243677] [024/133] (904s left) gem_exec_reloc (basic-write-gtt)
[114.305433] Subtest basic-write-gtt: SKIP (0.000s)
[114.372247] [025/133] (904s left) gem_mmap (pf-nonblock)
[114.422344] Subtest pf-nonblock: SKIP (0.000s)
[114.489164] [026/133] (904s left) kms_addfb_basic (size-max)
[114.572964] Starting subtest: size-max
[114.575216] Subtest size-max: SUCCESS (0.000s)
[114.666704] [027/133] (904s left) i915_suspend (forcewake)
[114.730278] Starting subtest: forcewake
[146.778308] Subtest forcewake: SUCCESS (2.359s)
[146.845944] [028/133] (872s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[146.957019] Starting subtest: 4-tiled-64bpp-rotate-90
[146.977257] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[147.086094] [029/133] (871s left) gem_exec_reloc (basic-gtt-cpu)
[147.142601] Subtest basic-gtt-cpu: SKIP (0.000s)
[147.211461] [030/133] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[147.303272] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[147.307995] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[147.398632] [031/133] (871s left) gem_eio (wait-10ms)
[147.621140] Starting subtest: wait-10ms
[147.970554] Subtest wait-10ms: SUCCESS (0.348s)
[148.082143] [032/133] (871s left) kms_draw_crc (draw-method-render)
[148.165653] Starting subtest: draw-method-render
[148.167712] Starting dynamic subtest: xrgb8888-untiled
[148.418605] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[148.427917] Starting dynamic subtest: rgb565-untiled
[148.640852] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[148.648795] Starting dynamic subtest: xrgb2101010-untiled
[148.876726] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[148.884230] Starting dynamic subtest: xbgr16161616f-untiled
[149.107608] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[149.115268] Starting dynamic subtest: xrgb8888-xtiled
[149.230285] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[149.238699] Starting dynamic subtest: rgb565-xtiled
[149.364224] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[149.373666] Starting dynamic subtest: xrgb2101010-xtiled
[149.474941] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[149.483489] Starting dynamic subtest: xbgr16161616f-xtiled
[149.596881] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[149.605314] Starting dynamic subtest: xrgb8888-4tiled
[149.731135] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[149.742600] Starting dynamic subtest: rgb565-4tiled
[149.841377] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[149.849821] Starting dynamic subtest: xrgb2101010-4tiled
[149.963836] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[149.975181] Starting dynamic subtest: xbgr16161616f-4tiled
[150.097661] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[150.099744] Subtest draw-method-render: SUCCESS (1.933s)
[150.213314] [033/133] (868s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[150.334773] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[150.340857] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[150.479614] [034/133] (868s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[150.568954] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[150.571232] Starting dynamic subtest: pipe-A-eDP-1
[150.703476] Dynamic subtest pipe-A-eDP-1: SKIP (0.136s)
[150.716541] Starting dynamic subtest: pipe-B-eDP-1
[151.897056] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[151.902097] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.326s)
[153.077685] [035/133] (866s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[153.179909] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[153.182463] Starting dynamic subtest: pipe-A-eDP-1
[153.246947] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[153.255503] Starting dynamic subtest: pipe-B-eDP-1
[153.322977] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[153.332032] Starting dynamic subtest: pipe-C-eDP-1
[153.399153] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[153.407972] Starting dynamic subtest: pipe-D-eDP-1
[153.473091] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[153.477989] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[155.349032] [036/133] (863s left) gem_ctx_shared (q-independent)
[155.414256] Starting subtest: Q-independent
[155.416541] Starting dynamic subtest: rcs0
[155.481628] Dynamic subtest rcs0: SUCCESS (0.069s)
[155.490220] Starting dynamic subtest: vcs0
[155.529153] Dynamic subtest vcs0: SUCCESS (0.047s)
[155.542668] Starting dynamic subtest: vcs1
[155.572234] Dynamic subtest vcs1: SUCCESS (0.042s)
[155.580509] Starting dynamic subtest: vecs0
[155.616622] Dynamic subtest vecs0: SUCCESS (0.043s)
[155.625251] Starting dynamic subtest: ccs0
[155.678000] Dynamic subtest ccs0: SUCCESS (0.061s)
[155.681014] Subtest Q-independent: SUCCESS (0.266s)
[156.642991] [037/133] (862s left) gem_ctx_persistence (engines-persistence)
[156.707103] Starting subtest: engines-persistence
[156.709543] Starting dynamic subtest: rcs0
[157.500618] Dynamic subtest rcs0: SUCCESS (0.796s)
[157.511093] Starting dynamic subtest: bcs0
[158.245655] Dynamic subtest bcs0: SUCCESS (0.743s)
[158.255284] Starting dynamic subtest: vcs0
[159.015430] Dynamic subtest vcs0: SUCCESS (0.768s)
[159.026076] Starting dynamic subtest: vcs1
[159.802528] Dynamic subtest vcs1: SUCCESS (0.785s)
[159.814565] Starting dynamic subtest: vecs0
[160.573520] Dynamic subtest vecs0: SUCCESS (0.769s)
[160.584649] Starting dynamic subtest: ccs0
[161.324551] Dynamic subtest ccs0: SUCCESS (0.749s)
[161.327397] Subtest engines-persistence: SUCCESS (4.621s)
[161.430412] [038/133] (857s left) kms_cursor_edge_walk (64x64-top-edge)
[161.523560] Starting subtest: 64x64-top-edge
[161.526477] Starting dynamic subtest: pipe-A-eDP-1
[165.008684] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.486s)
[165.017618] Starting dynamic subtest: pipe-D-eDP-1
[168.133093] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[168.136122] Subtest 64x64-top-edge: SUCCESS (6.612s)
[168.937031] [039/133] (850s left) api_intel_allocator (two-level-inception-interruptible)
[168.989077] Starting subtest: two-level-inception-interruptible
[174.406156] Subtest two-level-inception-interruptible: SUCCESS (5.412s)
[174.518644] [040/133] (844s left) gem_softpin (allocator-basic)
[174.595649] Starting subtest: allocator-basic
[174.678412] Subtest allocator-basic: SUCCESS (0.082s)
[174.842577] [041/133] (844s left) kms_cursor_crc (cursor-random-32x10)
[175.077195] Starting subtest: cursor-random-32x10
[175.146515] Subtest cursor-random-32x10: SKIP (0.063s)
[175.500460] [042/133] (844s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[175.616661] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[182.511441] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.895s)
[182.622328] [043/133] (836s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[182.716070] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[183.406851] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.693s)
[183.558990] [044/133] (836s left) sw_sync (alloc_fence)
[183.596073] Starting subtest: alloc_fence
[183.599037] Subtest alloc_fence: SUCCESS (0.000s)
[183.642542] [045/133] (836s left) gem_wait (write-wait)
[183.716490] Starting subtest: write-wait
[183.719034] Starting dynamic subtest: all-engines
[184.824791] Dynamic subtest all-engines: SUCCESS (1.107s)
[184.844265] Starting dynamic subtest: rcs0
[185.890516] Dynamic subtest rcs0: SUCCESS (1.062s)
[185.907079] Starting dynamic subtest: bcs0
[186.954249] Dynamic subtest bcs0: SUCCESS (1.061s)
[186.971164] Starting dynamic subtest: vcs0
[188.014279] Dynamic subtest vcs0: SUCCESS (1.058s)
[188.030088] Starting dynamic subtest: vcs1
[189.074215] Dynamic subtest vcs1: SUCCESS (1.058s)
[189.089333] Starting dynamic subtest: vecs0
[190.132004] Dynamic subtest vecs0: SUCCESS (1.056s)
[190.146759] Starting dynamic subtest: ccs0
[191.195130] Dynamic subtest ccs0: SUCCESS (1.061s)
[191.198153] Subtest write-wait: SUCCESS (7.479s)
[191.398625] [046/133] (828s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[191.458099] Subtest writes-after-reads: SKIP (0.000s)
[191.531099] [047/133] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[191.626906] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[198.142454] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.517s)
[198.258504] [048/133] (821s left) kms_setmode (basic)
[198.317505] Starting subtest: basic
[198.648973] Starting dynamic subtest: pipe-A-eDP-1
[200.735904] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.081s)
[201.081698] Starting dynamic subtest: pipe-B-eDP-1
[203.173766] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.094s)
[203.482909] Subtest basic: SUCCESS (5.161s)
[204.309883] [049/133] (815s left) gem_mmap_offset (bad-object)
[204.371493] Starting subtest: bad-object
[204.374240] Subtest bad-object: SUCCESS (0.001s)
[204.472493] [050/133] (815s left) syncobj_timeline (wait-all-snapshot)
[204.530728] Starting subtest: wait-all-snapshot
[204.612145] Subtest wait-all-snapshot: SUCCESS (0.083s)
[204.702254] [051/133] (815s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[204.795091] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[204.800402] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[204.861971] [052/133] (815s left) vgem_slow (nohang)
[204.914061] Starting subtest: nohang
[215.132055] Subtest nohang: SUCCESS (10.218s)
[215.203630] [053/133] (804s left) kms_psr (fbc-psr-cursor-blt)
[215.300840] Starting subtest: fbc-psr-cursor-blt
[215.303445] Starting dynamic subtest: eDP-1
[215.308772] Dynamic subtest eDP-1: SKIP (0.000s)
[215.313950] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[215.377971] [054/133] (804s left) i915_pm_rc6_residency (media-rc6-accuracy)
[215.435105] Starting subtest: media-rc6-accuracy
[215.439999] Subtest media-rc6-accuracy: SKIP (0.000s)
[215.519122] [055/133] (804s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[215.579824] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[215.661935] [056/133] (804s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[215.780282] Starting subtest: x-tiled-64bpp-rotate-90
[215.809280] Subtest x-tiled-64bpp-rotate-90: SKIP (0.027s)
[215.912162] [057/133] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[216.011498] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[223.511695] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.503s)
[223.641055] [058/133] (796s left) kms_cursor_crc (cursor-offscreen-64x21)
[223.836986] Starting subtest: cursor-offscreen-64x21
[223.882970] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[224.106486] [059/133] (796s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[224.195904] Starting subtest: psr-rgb565-draw-mmap-cpu
[230.908243] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.716s)
[231.009734] [060/133] (789s left) i915_drm_fdinfo (busy-hang)
[231.070187] Starting subtest: busy-hang
[231.073116] Starting dynamic subtest: rcs0
[231.090240] Dynamic subtest rcs0: SKIP (0.020s)
[231.101279] Starting dynamic subtest: bcs0
[231.106273] Dynamic subtest bcs0: SKIP (0.001s)
[231.117274] Starting dynamic subtest: vcs0
[231.122253] Dynamic subtest vcs0: SKIP (0.000s)
[231.130572] Starting dynamic subtest: vcs1
[231.135085] Dynamic subtest vcs1: SKIP (0.000s)
[231.143173] Starting dynamic subtest: vecs0
[231.148011] Dynamic subtest vecs0: SKIP (0.000s)
[231.156156] Starting dynamic subtest: ccs0
[231.161017] Dynamic subtest ccs0: SKIP (0.000s)
[231.165795] Subtest busy-hang: SKIP (0.026s)
[231.203117] [061/133] (789s left) gem_exec_create (basic)
[231.257441] Starting subtest: basic
[231.260147] Starting dynamic subtest: smem
[233.350568] Dynamic subtest smem: SUCCESS (2.093s)
[233.353586] Subtest basic: SUCCESS (2.094s)
[233.537579] [062/133] (786s left) gem_exec_whisper (basic-normal-all)
[233.603282] Starting subtest: basic-normal-all
[236.977432] Subtest basic-normal-all: SUCCESS (3.376s)
[237.204236] [063/133] (783s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[237.322157] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[237.327243] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[237.424346] [064/133] (783s left) gem_mmap_gtt (bad-object)
[237.488503] Subtest bad-object: SKIP (0.000s)
[237.549602] [065/133] (782s left) gem_exec_schedule (noreorder)
[237.730494] Starting subtest: noreorder
[237.733109] Starting dynamic subtest: rcs0
[237.783557] Dynamic subtest rcs0: SUCCESS (0.055s)
[237.795310] Starting dynamic subtest: vcs0
[239.547006] Dynamic subtest vcs0: SUCCESS (1.761s)
[239.561385] Starting dynamic subtest: vcs1
[241.510280] Dynamic subtest vcs1: SUCCESS (1.960s)
[241.522511] Starting dynamic subtest: vecs0
[243.587898] Dynamic subtest vecs0: SUCCESS (2.075s)
[243.599741] Starting dynamic subtest: ccs0
[243.662481] Dynamic subtest ccs0: SUCCESS (0.073s)
[243.665285] Subtest noreorder: SUCCESS (5.935s)
[243.850804] [066/133] (776s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[244.243730] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[245.089348] [067/133] (775s left) kms_frontbuffer_tracking (psr-slowdraw)
[245.186231] Starting subtest: psr-slowdraw
[270.410878] Subtest psr-slowdraw: SUCCESS (25.229s)
[270.544817] [068/133] (750s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[270.599527] Starting subtest: invalid-multi-wait-all-unsubmitted
[270.602091] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[270.703501] [069/133] (750s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[270.795179] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[270.797957] Starting dynamic subtest: pipe-A
[272.144024] Dynamic subtest pipe-A: SUCCESS (1.351s)
[272.153048] Starting dynamic subtest: pipe-B
[274.351223] Dynamic subtest pipe-B: SUCCESS (2.206s)
[274.361584] Starting dynamic subtest: pipe-C
[275.526844] Dynamic subtest pipe-C: SUCCESS (1.174s)
[275.536230] Starting dynamic subtest: pipe-D
[276.773682] Dynamic subtest pipe-D: SUCCESS (1.246s)
[276.776277] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.981s)
[277.967401] [070/133] (742s left) perf_pmu (interrupts-sync)
[278.016786] Starting subtest: interrupts-sync
[279.104506] Subtest interrupts-sync: SUCCESS (1.088s)
[279.211481] [071/133] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[279.322280] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[279.328082] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[279.432410] [072/133] (741s left) kms_chamelium_hpd (dp-hpd)
[279.828374] Subtest dp-hpd: SKIP (0.000s)
[280.680311] [073/133] (740s left) kms_busy (extended-modeset-hang-oldfb)
[280.805303] Starting subtest: extended-modeset-hang-oldfb
[280.808255] Starting dynamic subtest: pipe-A
[293.030035] Dynamic subtest pipe-A: SUCCESS (12.226s)
[293.046953] Starting dynamic subtest: pipe-D
[305.590182] Dynamic subtest pipe-D: SUCCESS (12.555s)
[305.593125] Subtest extended-modeset-hang-oldfb: SUCCESS (24.787s)
[306.394022] [074/133] (714s left) drm_mm (drm_mm)
[306.438289] Starting subtest: drm_mm
[306.467041] Starting dynamic subtest: drm_test_mm_init
[306.550173] Dynamic subtest drm_test_mm_init: SUCCESS (0.082s)
[306.560956] Starting dynamic subtest: drm_test_mm_debug
[306.647284] Dynamic subtest drm_test_mm_debug: SUCCESS (0.094s)
[306.656723] Starting dynamic subtest: drm_test_mm_align32
[306.738805] Dynamic subtest drm_test_mm_align32: SUCCESS (0.092s)
[306.748839] Starting dynamic subtest: drm_test_mm_align64
[306.833028] Dynamic subtest drm_test_mm_align64: SUCCESS (0.090s)
[306.842582] Starting dynamic subtest: drm_test_mm_lowest
[306.907604] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.077s)
[306.917850] Starting dynamic subtest: drm_test_mm_highest
[306.993066] Dynamic subtest drm_test_mm_highest: SUCCESS (0.084s)
[306.996103] Subtest drm_mm: SUCCESS (0.555s)
[307.136327] [075/133] (713s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[307.229171] Starting subtest: bad-aux-stride-yf-tiled-ccs
[307.231922] Starting dynamic subtest: pipe-A-eDP-1
[307.257945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.268556] Starting dynamic subtest: pipe-B-eDP-1
[307.293853] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.302778] Starting dynamic subtest: pipe-C-eDP-1
[307.327826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.336191] Starting dynamic subtest: pipe-D-eDP-1
[307.358170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.362764] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[309.462611] [076/133] (711s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[309.566909] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[309.595148] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.025s)
[309.678702] [077/133] (711s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[309.738035] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[309.740249] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[309.831016] [078/133] (711s left) gem_exec_whisper (basic-sync-all)
[309.895969] Starting subtest: basic-sync-all
[318.260520] Subtest basic-sync-all: SUCCESS (8.366s)
[318.449674] [079/133] (702s left) kms_vrr (seamless-rr-switch-vrr)
[318.538927] Starting subtest: seamless-rr-switch-vrr
[318.545696] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[318.621754] [080/133] (702s left) api_intel_bb (purge-bb)
[318.676042] Starting subtest: purge-bb
[318.678608] Subtest purge-bb: SUCCESS (0.004s)
[318.781717] [081/133] (702s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[318.903127] Starting subtest: cursor-vs-flip-atomic
[348.242109] Subtest cursor-vs-flip-atomic: SUCCESS (29.338s)
[349.086831] [082/133] (672s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[349.178970] Starting subtest: fbc-dirtyfb-ioctl
[349.181598] Starting dynamic subtest: A-eDP-1
[351.780841] Dynamic subtest A-eDP-1: SUCCESS (2.600s)
[351.783260] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.601s)
[352.654687] [083/133] (668s left) perf_pmu (init-sema)
[352.698026] Starting subtest: init-sema
[352.700986] Starting dynamic subtest: rcs0
[352.703884] Dynamic subtest rcs0: SUCCESS (0.002s)
[352.713834] Starting dynamic subtest: bcs0
[352.716233] Dynamic subtest bcs0: SUCCESS (0.000s)
[352.725518] Starting dynamic subtest: vcs0
[352.728072] Dynamic subtest vcs0: SUCCESS (0.001s)
[352.737170] Starting dynamic subtest: vcs1
[352.739565] Dynamic subtest vcs1: SUCCESS (0.001s)
[352.752234] Starting dynamic subtest: vecs0
[352.755119] Dynamic subtest vecs0: SUCCESS (0.001s)
[352.774338] Starting dynamic subtest: ccs0
[352.777247] Dynamic subtest ccs0: SUCCESS (0.001s)
[352.780128] Subtest init-sema: SUCCESS (0.008s)
[352.849414] [084/133] (668s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[352.951918] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[357.062631] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.115s)
[358.269273] [085/133] (663s left) prime_self_import (basic-llseek-size)
[358.309187] Starting subtest: basic-llseek-size
[358.323151] Subtest basic-llseek-size: SUCCESS (0.017s)
[358.422428] [086/133] (663s left) gem_exec_fence (parallel)
[358.594260] Starting subtest: parallel
[358.597225] Starting dynamic subtest: rcs0
[360.744721] Dynamic subtest rcs0: SUCCESS (2.151s)
[360.753778] Starting dynamic subtest: bcs0
[362.896703] Dynamic subtest bcs0: SUCCESS (2.151s)
[362.906969] Starting dynamic subtest: vcs0
[365.051039] Dynamic subtest vcs0: SUCCESS (2.154s)
[365.061084] Starting dynamic subtest: vcs1
[367.206789] Dynamic subtest vcs1: SUCCESS (2.154s)
[367.216236] Starting dynamic subtest: vecs0
[369.357258] Dynamic subtest vecs0: SUCCESS (2.151s)
[369.366871] Starting dynamic subtest: ccs0
[371.510047] Dynamic subtest ccs0: SUCCESS (2.151s)
[371.512557] Subtest parallel: SUCCESS (12.916s)
[372.629102] [087/133] (648s left) gem_flink_race (flink_close)
[372.677685] Starting subtest: flink_close
[377.777194] Subtest flink_close: SUCCESS (5.097s)
[377.852840] [088/133] (643s left) gem_exec_balancer (sequential)
[377.940566] Starting subtest: sequential
[381.006078] Subtest sequential: SUCCESS (3.067s)
[381.318539] [089/133] (640s left) kms_plane (pixel-format-x-tiled-modifier)
[381.440134] Starting subtest: pixel-format-x-tiled-modifier
[381.465881] Starting dynamic subtest: pipe-A-plane-0
[382.176858] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[382.185781] Starting dynamic subtest: pipe-A-plane-3
[382.643294] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[382.652443] Starting dynamic subtest: pipe-A-plane-5
[382.656283] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[383.729259] Starting dynamic subtest: pipe-B-plane-0
[384.444208] Dynamic subtest pipe-B-plane-0: SUCCESS (0.722s)
[384.455698] Starting dynamic subtest: pipe-B-plane-3
[384.910850] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[384.920507] Starting dynamic subtest: pipe-B-plane-5
[384.925400] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[385.227018] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.788s)
[386.094140] [090/133] (635s left) gem_ppgtt (flink-and-close-vma-leak)
[386.152839] Starting subtest: flink-and-close-vma-leak
[386.195889] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[386.300501] [091/133] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[386.403121] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[386.407553] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[386.497433] [092/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[386.603499] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[386.608500] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[386.701657] [093/133] (635s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[388.744873] Starting subtest: modeset-lpsp-stress-no-wait
[398.456266] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.715s)
[398.570542] [094/133] (623s left) i915_hangman (gt-engine-error)
[398.636710] Starting subtest: gt-engine-error
[398.639053] Starting dynamic subtest: rcs0
[400.541234] Dynamic subtest rcs0: SUCCESS (1.904s)
[400.553079] Starting dynamic subtest: bcs0
[402.525636] Dynamic subtest bcs0: SUCCESS (1.981s)
[402.538404] Starting dynamic subtest: vcs0
[404.573629] Dynamic subtest vcs0: SUCCESS (2.045s)
[404.586499] Starting dynamic subtest: vcs1
[406.557542] Dynamic subtest vcs1: SUCCESS (1.981s)
[406.569644] Starting dynamic subtest: vecs0
[408.540662] Dynamic subtest vecs0: SUCCESS (1.980s)
[408.553237] Starting dynamic subtest: ccs0
[410.525554] Dynamic subtest ccs0: SUCCESS (1.981s)
[410.528506] Subtest gt-engine-error: SUCCESS (11.889s)
[410.614187] [095/133] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[410.719125] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[410.724252] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.827559] [096/133] (611s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[410.921105] Starting subtest: yf-tiled-addfb-size-offset-overflow
[410.926413] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[411.034743] [097/133] (610s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[411.129701] Starting subtest: 4-tiled-16bpp-rotate-180
[412.375861] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.248s)
[412.524103] [098/133] (609s left) gem_exec_reloc (basic-wc-noreloc)
[412.577708] Subtest basic-wc-noreloc: SKIP (0.000s)
[412.648687] [099/133] (609s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[412.746664] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[412.748459] Starting dynamic subtest: pipe-A-default-mode
[415.438556] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[415.441295] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.692s)
[416.321113] [100/133] (605s left) kms_universal_plane (disable-primary-vs-flip)
[416.417065] Starting subtest: disable-primary-vs-flip
[416.419225] Starting dynamic subtest: pipe-A-eDP-1
[417.984867] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.566s)
[417.995310] Starting dynamic subtest: pipe-B-eDP-1
[420.163139] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.176s)
[420.174362] Starting dynamic subtest: pipe-C-eDP-1
[422.413010] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.253s)
[422.427269] Starting dynamic subtest: pipe-D-eDP-1
[424.589065] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[424.591341] Subtest disable-primary-vs-flip: SUCCESS (8.171s)
[425.387290] [101/133] (596s left) gem_ctx_param (set-priority-range)
[425.446216] Starting subtest: set-priority-range
[425.461259] Subtest set-priority-range: SUCCESS (0.015s)
[425.568582] [102/133] (596s left) kms_psr (psr2-primary-mmap-cpu)
[425.668738] Starting subtest: psr2-primary-mmap-cpu
[425.671073] Starting dynamic subtest: eDP-1
[427.386261] Dynamic subtest eDP-1: SUCCESS (1.717s)
[427.389080] Subtest psr2-primary-mmap-cpu: SUCCESS (1.718s)
[428.254125] [103/133] (593s left) kms_content_protection (mei-interface)
[428.393060] Starting subtest: mei-interface
[428.398978] Subtest mei-interface: SKIP (0.001s)
[428.516054] [104/133] (593s left) kms_getfb (getfb-handle-protection)
[428.608952] Starting subtest: getfb-handle-protection
[428.625233] Subtest getfb-handle-protection: SUCCESS (0.017s)
[428.730076] [105/133] (593s left) gem_exec_balancer (nohangcheck)
[428.999179] Starting subtest: nohangcheck
[429.902495] Subtest nohangcheck: SUCCESS (0.905s)
[430.015141] [106/133] (592s left) kms_color (ctm-0-75)
[430.106221] Starting subtest: ctm-0-75
[430.108818] Starting dynamic subtest: pipe-A-eDP-1
[435.009568] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.905s)
[435.020173] Starting dynamic subtest: pipe-B-eDP-1
[440.556981] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.547s)
[440.568270] Starting dynamic subtest: pipe-C-eDP-1
[445.946222] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.385s)
[445.960675] Starting dynamic subtest: pipe-D-eDP-1
[451.266295] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.319s)
[451.269058] Subtest ctm-0-75: SUCCESS (21.160s)
[452.076767] [107/133] (570s left) kms_vblank (ts-continuation-modeset-hang)
[452.171933] Starting subtest: ts-continuation-modeset-hang
[452.174306] Starting dynamic subtest: pipe-A-eDP-1
[478.334081] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.161s)
[478.350187] Starting dynamic subtest: pipe-D-eDP-1
[503.354108] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[503.357144] Subtest ts-continuation-modeset-hang: SUCCESS (51.182s)
[504.195159] [108/133] (518s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[504.297812] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[511.640529] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.344s)
[511.765659] [109/133] (510s left) gem_softpin (noreloc)
[511.823100] Starting subtest: noreloc
[517.237144] Subtest noreloc: SUCCESS (5.412s)
[517.360075] [110/133] (505s left) kms_setmode (basic-clone-single-crtc)
[517.415470] Starting subtest: basic-clone-single-crtc
[517.423083] Subtest basic-clone-single-crtc: SKIP (0.000s)
[517.508665] [111/133] (505s left) kms_flip (2x-blocking-absolute-wf_vblank)
[517.608762] Starting subtest: 2x-blocking-absolute-wf_vblank
[517.617251] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[517.697540] [112/133] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[517.787084] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[517.792300] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[517.885351] [113/133] (504s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[517.988111] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[517.993061] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[518.083088] [114/133] (504s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[518.137995] Starting subtest: yf-tiled-to-vebox-y-tiled
[518.143164] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[518.323128] [115/133] (504s left) kms_properties (plane-properties-legacy)
[518.411407] Starting subtest: plane-properties-legacy
[518.413245] Starting dynamic subtest: pipe-A-eDP-1
[518.959713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.549s)
[518.970244] Starting dynamic subtest: pipe-B-eDP-1
[520.198543] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s)
[520.209699] Starting dynamic subtest: pipe-C-eDP-1
[521.424073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[521.434516] Starting dynamic subtest: pipe-D-eDP-1
[522.659463] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[522.661958] Subtest plane-properties-legacy: SUCCESS (4.249s)
[523.448809] [116/133] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[523.540968] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[523.543566] Starting dynamic subtest: pipe-A-default-mode
[524.728273] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[524.732993] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.185s)
[524.874797] [117/133] (497s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[524.991670] Starting subtest: basic-flip-after-cursor-atomic
[525.909465] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.918s)
[526.713153] [118/133] (496s left) prime_busy (after-wait)
[526.778836] Starting subtest: after-wait
[526.785055] Starting dynamic subtest: rcs0
[526.813713] Dynamic subtest rcs0: SUCCESS (0.031s)
[526.823787] Starting dynamic subtest: bcs0
[526.854791] Dynamic subtest bcs0: SUCCESS (0.040s)
[526.866229] Starting dynamic subtest: vcs0
[526.897015] Dynamic subtest vcs0: SUCCESS (0.042s)
[526.907071] Starting dynamic subtest: vcs1
[526.939281] Dynamic subtest vcs1: SUCCESS (0.041s)
[526.949101] Starting dynamic subtest: vecs0
[526.981847] Dynamic subtest vecs0: SUCCESS (0.041s)
[526.991289] Starting dynamic subtest: ccs0
[527.023830] Dynamic subtest ccs0: SUCCESS (0.041s)
[527.134592] Subtest after-wait: SUCCESS (0.354s)
[527.209916] [119/133] (495s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[527.269263] Starting subtest: yf-tiled-ccs-to-yf-tiled
[527.274234] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[527.456018] [120/133] (495s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[527.555612] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[527.557955] Starting dynamic subtest: pipe-A-eDP-1
[534.197212] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.642s)
[534.206707] Starting dynamic subtest: pipe-B-eDP-1
[541.134901] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.936s)
[541.137274] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.581s)
[541.999138] [121/133] (480s left) kms_plane_alpha_blend (alpha-transparent-fb)
[542.098810] Starting subtest: alpha-transparent-fb
[542.383050] Starting dynamic subtest: pipe-A-eDP-1
[543.009729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[543.019652] Starting dynamic subtest: pipe-D-eDP-1
[544.350172] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[544.353151] Subtest alpha-transparent-fb: SUCCESS (2.254s)
[545.156688] [122/133] (477s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[545.255639] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[549.341870] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.090s)
[550.551413] [123/133] (472s left) intel_hwmon (hwmon-write)
[550.619623] Subtest hwmon-write: SKIP (0.000s)
[550.678667] [124/133] (472s left) gen7_exec_parse (load-register-reg)
[550.734177] Subtest load-register-reg: SKIP (0.000s)
[550.803279] [125/133] (472s left) prime_mmap (test_userptr)
[550.861233] Starting subtest: test_userptr
[550.864093] Starting dynamic subtest: test_userptr-smem
[550.866607] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[550.868887] Subtest test_userptr: SUCCESS (0.001s)
[550.971087] [126/133] (472s left) kms_lease (implicit-plane-lease)
[551.070180] Starting subtest: implicit-plane-lease
[551.072602] Subtest implicit-plane-lease: SUCCESS (0.003s)
[551.170195] [127/133] (472s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[551.253261] Starting subtest: fbc-pr-sprite-mmap-gtt
[551.258614] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[551.325718] [128/133] (471s left) gem_exec_schedule (smoketest)
[551.500968] Starting subtest: smoketest
[551.503824] Starting dynamic subtest: rcs0
[557.067929] Dynamic subtest rcs0: SUCCESS (5.516s)
[557.079033] Starting dynamic subtest: bcs0
[562.620650] Dynamic subtest bcs0: SUCCESS (5.539s)
[562.632388] Starting dynamic subtest: vcs0
[568.135654] Dynamic subtest vcs0: SUCCESS (5.515s)
[568.147870] Starting dynamic subtest: vcs1
[573.659970] Dynamic subtest vcs1: SUCCESS (5.527s)
[573.671859] Starting dynamic subtest: vecs0
[579.173099] Dynamic subtest vecs0: SUCCESS (5.516s)
[579.183574] Starting dynamic subtest: ccs0
[584.725851] Dynamic subtest ccs0: SUCCESS (5.542s)
[584.728235] Subtest smoketest: SUCCESS (33.163s)
[584.909652] [129/133] (438s left) syncobj_wait (reset-during-wait-for-submit)
[584.963165] Starting subtest: reset-during-wait-for-submit
[585.064138] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[585.172122] [130/133] (438s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[585.226224] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[585.229002] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[585.327387] [131/133] (438s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[585.447842] Starting subtest: fbcpsr-modesetfrombusy
[591.608829] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.164s)
[591.738607] [132/133] (431s left) syncobj_eventfd (timeline-wait-before-signal)
[591.794867] Starting subtest: timeline-wait-before-signal
[591.825255] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[591.903414] [133/133] (431s left) gem_fence_thrash (bo-write-verify-threaded-none)
[591.943271] Starting subtest: bo-write-verify-threaded-none
[591.961109] Subtest bo-write-verify-threaded-none: SKIP (0.019s)
[592.023176] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_backlight
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_cs_tlb
results: parsing output: 3/ for test: kms_chamelium_audio
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: gen3_render_mixed_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_scaling_modes
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: testdisplay
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: gem_mmap
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_draw_crc
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_cursor_edge_walk
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: gem_wait
results: parsing output: 45/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_setmode
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: vgem_slow
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: i915_pm_rc6_residency
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_busy
results: parsing output: 73/ for test: drm_mm
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_vrr
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_dirtyfb
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: prime_self_import
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_flink_race
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_ppgtt
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_universal_plane
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_setmode
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_properties
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_plane_alpha_blend
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: intel_hwmon
results: parsing output: 123/ for test: gen7_exec_parse
results: parsing output: 124/ for test: prime_mmap
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: gem_fence_thrash
Done.