[61.115681] Initializing watchdogs
[61.115740]   /dev/watchdog0
[61.120993] [001/130] (960s left) gem_exec_await (wide-contexts)
[61.219985] Starting subtest: wide-contexts
[83.072326] Subtest wide-contexts: SUCCESS (21.852s)
[83.275209] [002/130] (938s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[83.424939] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[83.425816] Starting dynamic subtest: pipe-A-valid-mode
[84.450190] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.025s)
[84.451054] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.025s)
[84.614858] [003/130] (937s left) kms_psr (psr2-sprite-plane-onoff)
[84.734516] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[84.748431] [004/130] (936s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[84.859795] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[87.474320] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.615s)
[87.670174] [005/130] (934s left) gem_mmap_gtt (basic-wc)
[87.713111] Starting subtest: basic-wc
[88.350879] Subtest basic-wc: SUCCESS (0.630s)
[88.448146] [006/130] (933s left) gem_mmap_gtt (fault-concurrent-x)
[88.481162] Starting subtest: fault-concurrent-X
[91.056899] Subtest fault-concurrent-X: SUCCESS (2.568s)
[91.185096] [007/130] (930s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[91.346326] Starting subtest: yf-tiled-addfb-size-offset-overflow
[91.347707] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[91.471195] [008/130] (930s left) syncobj_timeline (wait-any-snapshot)
[91.522007] Starting subtest: wait-any-snapshot
[91.603834] Subtest wait-any-snapshot: SUCCESS (0.081s)
[91.680804] [009/130] (930s left) kms_psr (psr-cursor-plane-move)
[91.797501] Subtest psr-cursor-plane-move: SKIP (0.000s)
[91.835594] [010/130] (930s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[91.950862] Starting subtest: plane-upscale-20x20-with-modifiers
[91.951531] Starting dynamic subtest: pipe-A
[92.597191] Dynamic subtest pipe-A: SUCCESS (0.646s)
[92.610534] Starting dynamic subtest: pipe-B
[93.237886] Dynamic subtest pipe-B: SUCCESS (0.640s)
[93.239032] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (1.287s)
[93.452394] [011/130] (928s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[93.566088] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[93.567593] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[93.643205] [012/130] (928s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[93.685225] Starting subtest: wait-all-for-submit-delayed-submit
[93.787655] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[93.876948] [013/130] (928s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[93.993468] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[93.994827] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[94.112478] [014/130] (927s left) gem_softpin (allocator-basic)
[94.156652] Starting subtest: allocator-basic
[94.217387] Subtest allocator-basic: SUCCESS (0.061s)
[94.364470] [015/130] (927s left) kms_flip (2x-flip-vs-suspend)
[94.480486] Starting subtest: 2x-flip-vs-suspend
[94.481883] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[94.588334] [016/130] (927s left) gem_mmap_offset (isolation)
[94.629501] Starting subtest: isolation
[94.636571] Subtest isolation: SUCCESS (0.004s)
[94.745547] [017/130] (927s left) kms_psr (fbc-psr2-sprite-plane-move)
[94.860606] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[94.899527] [018/130] (927s left) kms_cursor_crc (cursor-onscreen-128x42)
[95.017310] Starting subtest: cursor-onscreen-128x42
[95.019786] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.573784] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.553s)
[97.601037] Starting dynamic subtest: pipe-B-HDMI-A-1
[100.007707] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.411s)
[100.008459] Subtest cursor-onscreen-128x42: SUCCESS (4.991s)
[100.153745] [019/130] (921s left) kms_big_fb (linear-32bpp-rotate-90)
[100.273888] Starting subtest: linear-32bpp-rotate-90
[100.361977] Subtest linear-32bpp-rotate-90: SKIP (0.088s)
[100.499534] [020/130] (921s left) kms_hdr (bpc-switch-dpms)
[100.610843] Starting subtest: bpc-switch-dpms
[100.612923] Subtest bpc-switch-dpms: SKIP (0.000s)
[100.689497] [021/130] (921s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[100.727101] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[100.727811] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[100.796296] [022/130] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[100.916490] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[103.561061] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.645s)
[103.737693] [023/130] (918s left) gem_exec_suspend (basic-s0)
[103.789758] Starting subtest: basic-S0
[103.790458] Starting dynamic subtest: smem
[122.191305] Dynamic subtest smem: SUCCESS (18.401s)
[122.192503] Subtest basic-S0: SUCCESS (18.401s)
[128.403101] [024/130] (899s left) kms_chamelium_frames (dp-frame-dump)
[128.569452] Subtest dp-frame-dump: SKIP (0.000s)
[128.632743] [025/130] (899s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[128.753914] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[128.755294] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[128.867412] [026/130] (899s left) perf_pmu (enable-race)
[128.910396] Starting subtest: enable-race
[128.911119] Starting dynamic subtest: rcs0
[141.507092] Dynamic subtest rcs0: SUCCESS (12.596s)
[141.516491] Starting dynamic subtest: bcs0
[154.111919] Dynamic subtest bcs0: SUCCESS (12.590s)
[154.125950] Starting dynamic subtest: vcs0
[166.685378] Dynamic subtest vcs0: SUCCESS (12.588s)
[166.694039] Starting dynamic subtest: vecs0
[179.289432] Dynamic subtest vecs0: SUCCESS (12.594s)
[179.290182] Subtest enable-race: SUCCESS (50.370s)
[179.363190] [027/130] (848s left) kms_cursor_edge_walk (256x256-top-edge)
[179.470911] Starting subtest: 256x256-top-edge
[179.471625] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.181045] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.708s)
[183.190277] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.837011] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.655s)
[186.837748] Subtest 256x256-top-edge: SUCCESS (7.365s)
[186.948798] [028/130] (841s left) gem_softpin (noreloc-s3)
[186.992633] Starting subtest: noreloc-S3
[203.940380] Subtest noreloc-S3: SUCCESS (16.947s)
[207.138977] [029/130] (824s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[207.259825] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[207.261145] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[207.432950] [030/130] (823s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[207.558817] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[207.560118] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[207.688125] [031/130] (823s left) kms_flip (plain-flip-ts-check)
[207.798405] Starting subtest: plain-flip-ts-check
[207.799108] Starting dynamic subtest: A-HDMI-A1
[223.331392] Dynamic subtest A-HDMI-A1: SUCCESS (15.531s)
[223.341869] Starting dynamic subtest: B-HDMI-A1
[238.828520] Dynamic subtest B-HDMI-A1: SUCCESS (15.496s)
[238.829372] Subtest plain-flip-ts-check: SUCCESS (31.030s)
[239.000764] [032/130] (792s left) gem_eio (create-ext)
[239.048086] Starting subtest: create-ext
[239.066796] Subtest create-ext: SUCCESS (0.018s)
[239.218061] [033/130] (792s left) gem_exec_reloc (basic-wc-cpu)
[239.260755] Subtest basic-wc-cpu: SKIP (0.000s)
[239.357835] [034/130] (792s left) kms_pm_lpsp (screens-disabled)
[240.474475] Starting subtest: screens-disabled
[240.477144] Subtest screens-disabled: SKIP (0.000s)
[240.557887] [035/130] (790s left) gem_ctx_param (invalid-size-set)
[240.595729] Starting subtest: invalid-size-set
[240.596424] Subtest invalid-size-set: SUCCESS (0.000s)
[240.681096] [036/130] (790s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[240.790904] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[240.791630] Starting dynamic subtest: pipe-A-HDMI-A-1
[240.798458] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[240.804724] Starting dynamic subtest: pipe-B-HDMI-A-1
[240.811447] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[240.812816] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.002s)
[241.054099] [037/130] (790s left) drm_fdinfo (busy-check-all)
[241.093203] Starting subtest: busy-check-all
[241.093941] Starting dynamic subtest: rcs0
[241.665550] Dynamic subtest rcs0: SUCCESS (0.572s)
[241.675097] Starting dynamic subtest: bcs0
[242.196475] Dynamic subtest bcs0: SUCCESS (0.530s)
[242.206045] Starting dynamic subtest: vcs0
[242.723345] Dynamic subtest vcs0: SUCCESS (0.526s)
[242.733074] Starting dynamic subtest: vecs0
[243.256460] Dynamic subtest vecs0: SUCCESS (0.532s)
[243.257986] Subtest busy-check-all: SUCCESS (2.163s)
[243.342316] [038/130] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[243.454972] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[245.990876] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.537s)
[246.127190] [039/130] (785s left) gem_workarounds (basic-read-context)
[246.179918] Starting subtest: basic-read-context
[246.185368] Subtest basic-read-context: SUCCESS (0.005s)
[246.300783] [040/130] (785s left) kms_plane_scaling (intel-max-src-size)
[246.411853] Starting subtest: intel-max-src-size
[246.417700] Subtest intel-max-src-size: SKIP (0.005s)
[246.530315] [041/130] (785s left) gem_exec_await (wide-all)
[246.617994] Starting subtest: wide-all
[268.300474] Subtest wide-all: SUCCESS (21.672s)
[268.495018] [042/130] (763s left) syncobj_wait (multi-wait-submitted-signaled)
[268.572731] Starting subtest: multi-wait-submitted-signaled
[268.573440] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[268.651445] [043/130] (763s left) gem_exec_fence (parallel)
[268.832543] Starting subtest: parallel
[268.833432] Starting dynamic subtest: rcs0
[270.982402] Dynamic subtest rcs0: SUCCESS (2.150s)
[270.989176] Starting dynamic subtest: bcs0
[273.131467] Dynamic subtest bcs0: SUCCESS (2.149s)
[273.138208] Starting dynamic subtest: vcs0
[275.281009] Dynamic subtest vcs0: SUCCESS (2.149s)
[275.287873] Starting dynamic subtest: vecs0
[277.428952] Dynamic subtest vecs0: SUCCESS (2.148s)
[277.429717] Subtest parallel: SUCCESS (8.597s)
[277.898567] [044/130] (753s left) gen7_exec_parse (oacontrol-tracking)
[277.938288] Subtest oacontrol-tracking: SKIP (0.000s)
[277.982301] [045/130] (753s left) gem_close_race (multigpu-basic-threads)
[278.031344] Starting subtest: multigpu-basic-threads
[278.032755] Subtest multigpu-basic-threads: SKIP (0.000s)
[278.226760] [046/130] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[278.345701] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[278.347065] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[278.472534] [047/130] (753s left) api_intel_allocator (reopen)
[278.508724] Starting subtest: reopen
[278.509438] Subtest reopen: SUCCESS (0.001s)
[278.662490] [048/130] (753s left) kms_force_connector_basic (prune-stale-modes)
[278.845448] Starting subtest: prune-stale-modes
[279.068845] Subtest prune-stale-modes: SUCCESS (0.223s)
[279.296515] [049/130] (752s left) kms_psr (pr-primary-mmap-cpu)
[279.407496] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[279.450562] [050/130] (752s left) kms_cdclk (mode-transition)
[279.502288] Subtest mode-transition: SKIP (0.000s)
[279.535285] [051/130] (752s left) gem_eio (in-flight-internal-1us)
[279.579883] Starting subtest: in-flight-internal-1us
[279.829604] Subtest in-flight-internal-1us: SUCCESS (0.250s)
[279.982197] [052/130] (751s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[280.106928] Starting subtest: x-tiled-addfb-size-offset-overflow
[280.107689] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[280.228485] [053/130] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[280.343553] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[280.344919] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[280.465559] [054/130] (751s left) gem_ctx_shared (q-in-order)
[280.512868] Starting subtest: Q-in-order
[280.513582] Starting dynamic subtest: rcs0
[280.556772] Dynamic subtest rcs0: SUCCESS (0.043s)
[280.567081] Starting dynamic subtest: bcs0
[280.607759] Dynamic subtest bcs0: SUCCESS (0.043s)
[280.616427] Starting dynamic subtest: vcs0
[280.647776] Dynamic subtest vcs0: SUCCESS (0.046s)
[280.661565] Starting dynamic subtest: vecs0
[280.695434] Dynamic subtest vecs0: SUCCESS (0.047s)
[280.696702] Subtest Q-in-order: SUCCESS (0.183s)
[280.902412] [055/130] (751s left) gem_sync (basic-each)
[280.948596] Starting subtest: basic-each
[283.051075] Subtest basic-each: SUCCESS (2.102s)
[283.250390] [056/130] (748s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[283.379893] Starting subtest: y-tiled-8bpp-rotate-270
[283.447493] Subtest y-tiled-8bpp-rotate-270: SKIP (0.067s)
[283.594988] [057/130] (748s left) core_getversion (all-cards)
[283.635587] Starting subtest: all-cards
[285.928777] Subtest all-cards: SUCCESS (2.286s)
[285.943692] [058/130] (746s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[286.052008] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[286.052793] Starting dynamic subtest: pipe-A-valid-mode
[286.120494] Dynamic subtest pipe-A-valid-mode: SKIP (0.066s)
[286.122332] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.067s)
[286.229873] [059/130] (745s left) syncobj_timeline (reset-multiple-signaled)
[286.272881] Starting subtest: reset-multiple-signaled
[286.273621] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[286.351292] [060/130] (745s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[286.468361] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[290.495690] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (4.027s)
[290.658646] [061/130] (741s left) kms_selftest (drm_format_helper)
[290.699427] Starting subtest: drm_format_helper
[290.703813] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[290.818998] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.113s)
[290.838393] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[290.951099] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.132s)
[290.970840] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[291.105233] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.148s)
[291.125477] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[291.225144] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.122s)
[291.242889] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[291.331385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.105s)
[291.346483] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[291.454610] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.122s)
[291.474291] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[291.566255] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.111s)
[291.576668] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[291.680413] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.113s)
[291.699421] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[291.800153] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.118s)
[291.817946] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[291.944958] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.138s)
[291.965306] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[292.033077] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.092s)
[292.052573] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[292.156189] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.122s)
[292.174894] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[292.263346] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.106s)
[292.281748] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[292.372392] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.109s)
[292.385423] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[292.491691] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.117s)
[292.509729] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list
[292.608297] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.115s)
[292.615233] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[292.708612] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.100s)
[292.709760] Subtest drm_format_helper: SUCCESS (2.009s)
[292.882300] [062/130] (739s left) gem_close_race (basic-process)
[292.930519] Starting subtest: basic-process
[292.984578] Subtest basic-process: SUCCESS (0.054s)
[293.177395] [063/130] (739s left) gem_ctx_isolation (dirty-switch)
[293.226146] Starting subtest: dirty-switch
[293.226904] Starting dynamic subtest: rcs0
[293.360310] Dynamic subtest rcs0: SUCCESS (0.134s)
[293.367024] Starting dynamic subtest: bcs0
[293.534402] Dynamic subtest bcs0: SUCCESS (0.174s)
[293.541082] Starting dynamic subtest: vcs0
[293.701908] Dynamic subtest vcs0: SUCCESS (0.167s)
[293.708665] Starting dynamic subtest: vecs0
[293.892460] Dynamic subtest vecs0: SUCCESS (0.190s)
[293.893180] Subtest dirty-switch: SUCCESS (0.666s)
[294.069419] [064/130] (738s left) drm_fdinfo (memory-info-purgeable)
[294.109659] Starting subtest: memory-info-purgeable
[294.110360] Starting dynamic subtest: smem0
[296.378591] Dynamic subtest smem0: SUCCESS (2.269s)
[296.379338] Subtest memory-info-purgeable: SUCCESS (2.269s)
[296.458165] [065/130] (735s left) gem_exec_balancer (nohangcheck)
[296.622352] Starting subtest: nohangcheck
[297.680486] Subtest nohangcheck: SUCCESS (1.052s)
[297.748511] [066/130] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[297.861689] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[297.863035] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[297.967360] [067/130] (734s left) gem_exec_params (invalid-batch-start-offset)
[298.007588] Starting subtest: invalid-batch-start-offset
[298.010885] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[298.157927] [068/130] (734s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[298.327873] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[298.396976] [069/130] (733s left) syncobj_wait (multi-wait-for-submit-signaled)
[298.432930] Starting subtest: multi-wait-for-submit-signaled
[298.433624] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[298.498148] [070/130] (733s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[298.612901] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[298.642963] [071/130] (733s left) kms_plane_alpha_blend (alpha-basic)
[298.755944] Starting subtest: alpha-basic
[298.826107] Starting dynamic subtest: pipe-A-HDMI-A-1
[301.668633] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.842s)
[301.692757] Starting dynamic subtest: pipe-B-HDMI-A-1
[304.601099] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.914s)
[304.601935] Subtest alpha-basic: SUCCESS (5.844s)
[304.792335] [072/130] (727s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[304.906742] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[304.908098] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.039637] [073/130] (727s left) drm_read (invalid-buffer)
[305.192094] Starting subtest: invalid-buffer
[305.192823] Subtest invalid-buffer: SUCCESS (0.000s)
[305.352838] [074/130] (727s left) kms_psr (fbc-pr-sprite-render)
[305.462484] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[305.490511] [075/130] (727s left) gem_lmem_swapping (heavy-verify-random-ccs)
[305.531483] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[305.565217] [076/130] (726s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[305.677908] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[305.678606] Starting dynamic subtest: pipe-A-HDMI-A-1
[305.684727] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[305.691460] Starting dynamic subtest: pipe-B-HDMI-A-1
[305.697510] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[305.698218] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.002s)
[305.945692] [077/130] (726s left) gem_pxp (reject-modify-context-protection-off-1)
[426.035131] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[428.662707] Closing watchdogs
[428.664954] Initializing watchdogs
[428.664993]   /dev/watchdog0
[428.672850] [078/130] (603s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[428.784265] Starting subtest: cursor-rapid-movement-max-size
[428.786218] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[428.917886] [079/130] (603s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[428.959787] Starting subtest: tiled-to-tiled
[428.961142] Subtest tiled-to-tiled: SKIP (0.000s)
[429.108133] [080/130] (603s left) gem_vm_create (invalid-create)
[429.149182] Starting subtest: invalid-create
[429.149886] Subtest invalid-create: SUCCESS (0.000s)
[429.277980] [081/130] (603s left) kms_draw_crc (draw-method-render)
[429.392643] Starting subtest: draw-method-render
[429.393325] Starting dynamic subtest: xrgb8888-untiled
[429.715973] Dynamic subtest xrgb8888-untiled: SUCCESS (0.323s)
[429.737436] Starting dynamic subtest: rgb565-untiled
[430.057428] Dynamic subtest rgb565-untiled: SUCCESS (0.340s)
[430.078274] Starting dynamic subtest: xrgb2101010-untiled
[430.361090] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.302s)
[430.373979] Starting dynamic subtest: xrgb8888-xtiled
[430.532023] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.169s)
[430.543928] Starting dynamic subtest: rgb565-xtiled
[430.703708] Dynamic subtest rgb565-xtiled: SUCCESS (0.170s)
[430.724354] Starting dynamic subtest: xrgb2101010-xtiled
[430.854371] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[430.874299] Starting dynamic subtest: xrgb8888-ytiled
[431.025155] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.169s)
[431.046106] Starting dynamic subtest: rgb565-ytiled
[431.196126] Dynamic subtest rgb565-ytiled: SUCCESS (0.169s)
[431.217193] Starting dynamic subtest: xrgb2101010-ytiled
[431.347692] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.150s)
[431.348899] Subtest draw-method-render: SUCCESS (1.956s)
[431.517475] [082/130] (601s left) gem_exec_schedule (wide)
[431.684475] Starting subtest: wide
[431.685558] Starting dynamic subtest: rcs0
[450.285947] Dynamic subtest rcs0: SUCCESS (18.567s)
[450.293078] Starting dynamic subtest: bcs0
[459.323115] Dynamic subtest bcs0: SUCCESS (9.069s)
[459.330338] Starting dynamic subtest: vcs0
[467.840694] Dynamic subtest vcs0: SUCCESS (8.508s)
[467.850976] Starting dynamic subtest: vecs0
[476.515502] Dynamic subtest vecs0: SUCCESS (8.649s)
[476.516262] Subtest wide: SUCCESS (44.797s)
[478.234421] [083/130] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[478.348685] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[478.350024] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[478.479931] [084/130] (554s left) syncobj_eventfd (invalid-bad-pad)
[478.515698] Starting subtest: invalid-bad-pad
[478.516389] Subtest invalid-bad-pad: SUCCESS (0.000s)
[478.597993] [085/130] (554s left) perf (oa-formats)
[478.696889] Starting subtest: oa-formats
[478.697573] Starting dynamic subtest: 0-rcs0
[478.710865] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[478.711540] Subtest oa-formats: SUCCESS (0.015s)
[478.750272] [086/130] (554s left) kms_flip (absolute-wf_vblank-interruptible)
[478.865491] Starting subtest: absolute-wf_vblank-interruptible
[478.867069] Starting dynamic subtest: A-HDMI-A1
[494.230088] Dynamic subtest A-HDMI-A1: SUCCESS (15.363s)
[494.240749] Starting dynamic subtest: B-HDMI-A1
[509.554253] Dynamic subtest B-HDMI-A1: SUCCESS (15.304s)
[509.555325] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.672s)
[509.737365] [087/130] (523s left) syncobj_timeline (invalid-signal-bad-pad)
[509.774208] Starting subtest: invalid-signal-bad-pad
[509.774971] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[509.841019] [088/130] (523s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[509.953680] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[509.955070] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[510.081204] [089/130] (522s left) kms_content_protection (atomic-dpms)
[510.201629] Starting subtest: atomic-dpms
[510.377168] Subtest atomic-dpms: SKIP (0.172s)
[510.570464] [090/130] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[510.680557] Starting subtest: fbcpsr-2p-rte
[510.681861] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[510.818820] [091/130] (522s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[510.929537] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[513.722259] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.793s)
[513.870338] [092/130] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[513.981522] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[513.982825] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[514.121900] [093/130] (518s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[514.231684] Starting subtest: fbc-rgb565-draw-mmap-gtt
[516.720036] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.489s)
[516.870110] [094/130] (516s left) gem_ctx_persistence (engines-cleanup)
[516.908707] Starting subtest: engines-cleanup
[516.909379] Starting dynamic subtest: rcs0
[516.950396] Dynamic subtest rcs0: SUCCESS (0.041s)
[516.965032] Starting dynamic subtest: bcs0
[517.003348] Dynamic subtest bcs0: SUCCESS (0.051s)
[517.024600] Starting dynamic subtest: vcs0
[517.057257] Dynamic subtest vcs0: SUCCESS (0.052s)
[517.078308] Starting dynamic subtest: vecs0
[517.114253] Dynamic subtest vecs0: SUCCESS (0.055s)
[517.115375] Subtest engines-cleanup: SUCCESS (0.206s)
[517.202032] [095/130] (515s left) i915_pm_rps (min-max-config-idle)
[517.238683] Starting subtest: min-max-config-idle
[517.424680] Subtest min-max-config-idle: SUCCESS (0.186s)
[517.572554] [096/130] (515s left) kms_addfb_basic (basic-x-tiled-legacy)
[517.608312] Starting subtest: basic-x-tiled-legacy
[517.609012] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[517.820168] [097/130] (515s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[517.856901] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[517.900828] [098/130] (515s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[518.374332] Starting subtest: syncobj-timeline-invalid-wait
[518.375248] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[518.550854] [099/130] (514s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[518.665821] Starting subtest: 4-tiled-16bpp-rotate-270
[518.667157] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[518.799440] [100/130] (514s left) syncobj_wait (invalid-reset-bad-pad)
[518.838019] Starting subtest: invalid-reset-bad-pad
[518.838695] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[518.915701] [101/130] (514s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[519.030699] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[519.031991] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[519.167196] [102/130] (514s left) prime_mmap (test_forked)
[519.205661] Starting subtest: test_forked
[519.206336] Starting dynamic subtest: test_forked-smem
[519.261746] Dynamic subtest test_forked-smem: SUCCESS (0.056s)
[519.262422] Subtest test_forked: SUCCESS (0.057s)
[519.394664] [103/130] (513s left) kms_lease (empty-lease)
[519.507051] Starting subtest: empty-lease
[519.508735] Starting dynamic subtest: pipe-A-HDMI-A-1
[519.509411] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[519.516368] Starting dynamic subtest: pipe-B-HDMI-A-1
[519.517057] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[519.517719] Subtest empty-lease: SUCCESS (0.003s)
[519.601228] [104/130] (513s left) prime_vgem (basic-blt)
[519.673826] Starting subtest: basic-blt
[519.691266] Subtest basic-blt: SUCCESS (0.018s)
[519.830654] [105/130] (513s left) syncobj_wait (wait-all-for-submit-snapshot)
[519.864269] Starting subtest: wait-all-for-submit-snapshot
[519.946184] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[520.052822] [106/130] (513s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[520.105051] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[520.105765] Starting dynamic subtest: smem
[520.178154] Dynamic subtest smem: SUCCESS (0.073s)
[520.183555] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.073s)
[520.373406] [107/130] (512s left) kms_vblank (ts-continuation-idle)
[520.481999] Starting subtest: ts-continuation-idle
[520.483643] Starting dynamic subtest: pipe-A-HDMI-A-1
[520.757190] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.273s)
[520.768830] Starting dynamic subtest: pipe-B-HDMI-A-1
[520.937246] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.176s)
[520.938056] Subtest ts-continuation-idle: SUCCESS (0.454s)
[521.111455] [108/130] (512s left) kms_color (gamma)
[521.222028] Starting subtest: gamma
[521.222728] Starting dynamic subtest: pipe-A-HDMI-A-1
[521.773757] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.551s)
[521.784042] Starting dynamic subtest: pipe-B-HDMI-A-1
[522.221829] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.446s)
[522.223870] Subtest gamma: SUCCESS (0.999s)
[522.375491] [109/130] (511s left) gem_exec_flush (basic-uc-prw-default)
[522.422497] Starting subtest: basic-uc-prw-default
[527.888114] Subtest basic-uc-prw-default: SUCCESS (5.465s)
[528.099165] [110/130] (505s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[528.244580] Starting subtest: extended-modeset-hang-newfb-with-reset
[528.245276] Starting dynamic subtest: pipe-A
[531.125360] Dynamic subtest pipe-A: SUCCESS (2.880s)
[531.134514] Starting dynamic subtest: pipe-B
[533.975932] Dynamic subtest pipe-B: SUCCESS (2.848s)
[533.978531] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.733s)
[534.178380] [111/130] (499s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[534.292662] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[534.331809] [112/130] (499s left) gem_flink_basic (flink-lifetime)
[534.370301] Starting subtest: flink-lifetime
[534.370971] Subtest flink-lifetime: SUCCESS (0.001s)
[534.501927] [113/130] (499s left) vgem_basic (create)
[534.541163] Starting subtest: create
[534.541843] Subtest create: SUCCESS (0.000s)
[534.616252] [114/130] (498s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[534.727582] Starting subtest: fbcpsr-rgb101010-draw-blt
[534.728934] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[534.862901] [115/130] (498s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[534.897966] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[535.006347] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[535.080411] [116/130] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[535.194769] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[535.196088] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[535.317523] [117/130] (498s left) i915_pm_rc6_residency (media-rc6-accuracy)
[535.352647] Starting subtest: media-rc6-accuracy
[535.354012] Subtest media-rc6-accuracy: SKIP (0.000s)
[535.449296] [118/130] (498s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[535.561352] Starting subtest: cursorB-vs-flipB-varying-size
[535.562802] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[535.648978] [119/130] (498s left) i915_suspend (fence-restore-tiled2untiled)
[535.687401] Starting subtest: fence-restore-tiled2untiled
[556.110130] Subtest fence-restore-tiled2untiled: SUCCESS (20.414s)
[558.219558] [120/130] (477s left) perf (polling)
[558.319472] Starting subtest: polling
[558.320169] Starting dynamic subtest: 0-rcs0
[568.336689] Dynamic subtest 0-rcs0: SUCCESS (10.007s)
[568.337393] Subtest polling: SUCCESS (10.008s)
[568.373038] [121/130] (467s left) gem_exec_schedule (preempt-user)
[568.470828] Starting subtest: preempt-user
[568.471505] Starting dynamic subtest: rcs0
[568.488164] Dynamic subtest rcs0: SUCCESS (0.017s)
[568.495335] Starting dynamic subtest: bcs0
[568.503815] Dynamic subtest bcs0: SUCCESS (0.015s)
[568.510955] Starting dynamic subtest: vcs0
[568.518665] Dynamic subtest vcs0: SUCCESS (0.014s)
[568.525839] Starting dynamic subtest: vecs0
[568.533914] Dynamic subtest vecs0: SUCCESS (0.014s)
[568.534596] Subtest preempt-user: SUCCESS (0.063s)
[568.861867] [122/130] (466s left) kms_pm_rpm (universal-planes-dpms)
[570.317187] Starting subtest: universal-planes-dpms
[570.318331] Starting dynamic subtest: plane-32
[571.608321] Dynamic subtest plane-32: SUCCESS (1.290s)
[571.621848] Starting dynamic subtest: plane-41
[572.897407] Dynamic subtest plane-41: SUCCESS (1.287s)
[572.911823] Starting dynamic subtest: plane-50
[574.191791] Dynamic subtest plane-50: SUCCESS (1.292s)
[574.214348] Starting dynamic subtest: plane-59
[575.490231] Dynamic subtest plane-59: SUCCESS (1.296s)
[575.502559] Starting dynamic subtest: plane-68
[576.761328] Dynamic subtest plane-68: SUCCESS (1.269s)
[576.775840] Starting dynamic subtest: plane-77
[578.007135] Dynamic subtest plane-77: SUCCESS (1.244s)
[578.010750] Subtest universal-planes-dpms: SUCCESS (7.691s)
[578.212429] [123/130] (457s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[578.322122] Starting subtest: read-crc-frame-sequence
[578.323852] Starting dynamic subtest: pipe-A-HDMI-A-1
[578.909345] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.586s)
[578.919250] Starting dynamic subtest: pipe-B-HDMI-A-1
[579.391926] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.479s)
[579.392773] Subtest read-crc-frame-sequence: SUCCESS (1.069s)
[579.517479] [124/130] (456s left) gem_tiled_wc
[581.923704] [125/130] (453s left) kms_psr (fbc-pr-cursor-blt)
[582.029437] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[582.056192] [126/130] (453s left) perf (blocking-parameterized)
[582.140170] Starting subtest: blocking-parameterized
[602.185539] Subtest blocking-parameterized: SUCCESS (20.011s)
[602.216880] [127/130] (433s left) perf_pmu (invalid-init)
[602.317302] Starting subtest: invalid-init
[602.318009] Subtest invalid-init: SUCCESS (0.000s)
[602.398428] [128/130] (433s left) gem_exec_reloc (basic-cpu-gtt-active)
[602.440409] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[602.522349] [129/130] (433s left) gem_exec_params (rel-constants-invalid)
[602.560303] Starting subtest: rel-constants-invalid
[602.561008] Subtest rel-constants-invalid: SUCCESS (0.000s)
[602.687168] [130/130] (433s left) gem_spin_batch (engines)
[602.731161] Starting subtest: engines
[602.731861] Starting dynamic subtest: rcs0
[606.081333] Dynamic subtest rcs0: SUCCESS (3.314s)
[606.092828] Starting dynamic subtest: bcs0
[609.375086] Dynamic subtest bcs0: SUCCESS (3.315s)
[609.386167] Starting dynamic subtest: vcs0
[612.716798] Dynamic subtest vcs0: SUCCESS (3.315s)
[612.728119] Starting dynamic subtest: vecs0
[616.009803] Dynamic subtest vecs0: SUCCESS (3.315s)
[616.010944] Subtest engines: SUCCESS (13.269s)
[616.181812] Closing watchdogs
Done.