[43.625425] Initializing watchdogs
[43.625544]   /dev/watchdog0
[43.638640] [001/132] (960s left) kms_psr (fbc-psr-primary-page-flip)
[43.741355] Starting subtest: fbc-psr-primary-page-flip
[43.743878] Starting dynamic subtest: eDP-1
[43.748591] Dynamic subtest eDP-1: SKIP (0.000s)
[43.753168] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[43.804069] [002/132] (960s left) kms_plane_lowres (tiling-4)
[43.908324] Starting subtest: tiling-4
[43.910800] Starting dynamic subtest: pipe-A-eDP-1
[43.915512] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[44.211966] Starting dynamic subtest: pipe-B-eDP-1
[44.216998] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[44.228949] Starting dynamic subtest: pipe-C-eDP-1
[44.234341] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[44.245429] Starting dynamic subtest: pipe-D-eDP-1
[44.250177] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[44.254916] Subtest tiling-4: SKIP (0.301s)
[45.121253] [003/132] (959s left) v3d/v3d_wait_bo (unused-bo-1ns)
[45.224061] Subtest unused-bo-1ns: SKIP (0.000s)
[45.270403] [004/132] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[45.351714] Starting subtest: 256x256-top-bottom
[45.354130] Starting dynamic subtest: pipe-A-eDP-1
[48.897652] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.548s)
[48.909057] Starting dynamic subtest: pipe-D-eDP-1
[52.130664] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.229s)
[52.133348] Subtest 256x256-top-bottom: SUCCESS (6.780s)
[53.057642] [005/132] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[53.168401] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[53.173052] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[53.245464] [006/132] (951s left) kms_psr (fbc-pr-cursor-blt)
[53.325917] Starting subtest: fbc-pr-cursor-blt
[53.330341] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[53.383129] [007/132] (950s left) syncobj_basic (bad-handle-to-fd)
[53.439448] Starting subtest: bad-handle-to-fd
[53.442391] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[53.510805] [008/132] (950s left) core_setmaster_vs_auth
[53.675239] [009/132] (950s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[53.764737] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[53.769458] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[53.848121] [010/132] (950s left) sw_sync (sync_multi_consumer_producer)
[53.900921] Starting subtest: sync_multi_consumer_producer
[54.239871] Subtest sync_multi_consumer_producer: SUCCESS (0.341s)
[54.289522] [011/132] (950s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[54.386807] Subtest access-purged-bo-mem: SKIP (0.000s)
[54.433558] [012/132] (949s left) gem_linear_blits (basic)
[54.916625] Starting subtest: basic
[54.930078] Subtest basic: SUCCESS (0.014s)
[55.046578] [013/132] (949s left) gem_exec_fence (long-history)
[55.608512] Starting subtest: long-history
[63.120080] Subtest long-history: SUCCESS (7.513s)
[64.168425] [014/132] (940s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[64.257702] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[64.262060] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[64.340164] [015/132] (940s left) syncobj_basic (bad-flags-fd-to-handle)
[64.421071] Starting subtest: bad-flags-fd-to-handle
[64.423507] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[64.492838] [016/132] (940s left) gem_ctx_persistence (heartbeat-hang)
[64.580484] Starting subtest: heartbeat-hang
[64.585583] Subtest heartbeat-hang: SKIP (0.000s)
[64.671185] [017/132] (939s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[64.753624] Starting subtest: fbc-rgb101010-draw-mmap-wc
[68.387955] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.637s)
[68.495155] [018/132] (936s left) kms_psr (psr-sprite-render)
[68.597358] Starting subtest: psr-sprite-render
[68.599703] Starting dynamic subtest: eDP-1
[70.484288] Dynamic subtest eDP-1: SUCCESS (1.886s)
[70.486804] Subtest psr-sprite-render: SUCCESS (1.887s)
[71.364748] [019/132] (933s left) i915_hangman (gt-error-state-capture)
[71.465542] Starting subtest: gt-error-state-capture
[71.468056] Starting dynamic subtest: rcs0
[83.432535] Dynamic subtest rcs0: SUCCESS (11.966s)
[83.451409] Starting dynamic subtest: bcs0
[95.465201] Dynamic subtest bcs0: SUCCESS (12.032s)
[95.480354] Starting dynamic subtest: vcs0
[107.432389] Dynamic subtest vcs0: SUCCESS (11.967s)
[107.447705] Starting dynamic subtest: vcs1
[119.517956] Dynamic subtest vcs1: SUCCESS (12.032s)
[119.534238] Starting dynamic subtest: vecs0
[131.432718] Dynamic subtest vecs0: SUCCESS (11.968s)
[131.448547] Starting dynamic subtest: ccs0
[143.463793] Dynamic subtest ccs0: SUCCESS (12.031s)
[143.467312] Subtest gt-error-state-capture: SUCCESS (71.997s)
[143.540669] [020/132] (861s left) gem_eio (wait-10ms)
[143.748816] Starting subtest: wait-10ms
[144.043727] Subtest wait-10ms: SUCCESS (0.296s)
[144.157908] [021/132] (860s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[145.842918] Starting subtest: modeset-lpsp-stress-no-wait
[157.968530] Subtest modeset-lpsp-stress-no-wait: SUCCESS (12.128s)
[158.046755] [022/132] (846s left) gem_mmap_gtt (basic-small-bo-tiledx)
[158.102304] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[158.148968] [023/132] (846s left) kms_rotation_crc (bad-pixel-format)
[158.261633] Starting subtest: bad-pixel-format
[158.266894] Subtest bad-pixel-format: SKIP (0.002s)
[158.330234] [024/132] (846s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[158.444476] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[159.491238] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.048s)
[159.620074] [025/132] (845s left) kms_addfb_basic (small-bo)
[159.715393] Starting subtest: small-bo
[159.717491] Subtest small-bo: SUCCESS (0.000s)
[159.791331] [026/132] (845s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[159.861813] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[159.908245] [027/132] (844s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[159.999880] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[160.001978] Starting dynamic subtest: pipe-A-eDP-1
[160.005994] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[160.013069] Starting dynamic subtest: pipe-B-eDP-1
[160.016970] Dynamic subtest pipe-B-eDP-1: SKIP (0.012s)
[160.023745] Starting dynamic subtest: pipe-C-eDP-1
[160.030914] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s)
[160.038570] Starting dynamic subtest: pipe-D-eDP-1
[160.042743] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s)
[160.046541] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.043s)
[160.107272] [028/132] (844s left) kms_vrr (negative-basic)
[160.182248] Starting subtest: negative-basic
[160.187879] Starting dynamic subtest: pipe-A-eDP-1
[165.683943] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.439s)
[165.922900] Subtest negative-basic: SUCCESS (5.739s)
[166.856358] [029/132] (838s left) gem_mmap_gtt (isolation)
[166.936909] Subtest isolation: SKIP (0.000s)
[166.983831] [030/132] (837s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[167.082886] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[167.085378] Starting dynamic subtest: pipe-A-default-mode
[170.017927] Dynamic subtest pipe-A-default-mode: SUCCESS (2.932s)
[170.020609] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.935s)
[170.947850] [031/132] (833s left) vgem_basic (debugfs)
[171.017656] Starting subtest: debugfs
[171.019691] Subtest debugfs: SUCCESS (0.001s)
[171.068327] [032/132] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[171.158576] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[171.162962] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[171.229626] [033/132] (833s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[171.325816] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[175.874094] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.555s)
[175.980330] [034/132] (829s left) kms_psr (fbc-psr2-primary-render)
[176.087347] Starting subtest: fbc-psr2-primary-render
[176.090091] Starting dynamic subtest: eDP-1
[176.095167] Dynamic subtest eDP-1: SKIP (0.000s)
[176.100827] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[176.152589] [035/132] (828s left) gem_exec_params (invalid-ring2)
[176.234881] Starting subtest: invalid-ring2
[176.237709] Subtest invalid-ring2: SUCCESS (0.000s)
[176.323563] [036/132] (828s left) syncobj_timeline (invalid-wait-zero-handles)
[176.402682] Starting subtest: invalid-wait-zero-handles
[176.453108] Subtest invalid-wait-zero-handles: FAIL (0.027s)
[176.495403] [037/132] (828s left) gem_exec_params (no-blt)
[176.566279] Starting subtest: no-blt
[176.571697] Subtest no-blt: SUCCESS (0.005s)
[176.659648] [038/132] (828s left) kms_psr (pr-dpms)
[176.750431] Starting subtest: pr-dpms
[176.755698] Subtest pr-dpms: SKIP (0.000s)
[176.815979] [039/132] (828s left) prime_self_import (basic-with_one_bo_two_files)
[176.873725] Starting subtest: basic-with_one_bo_two_files
[176.888106] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[176.975353] [040/132] (828s left) gen7_exec_parse (batch-without-end)
[177.063067] Subtest batch-without-end: SKIP (0.000s)
[177.123874] [041/132] (828s left) prime_mmap (test_forked_cpu_write)
[177.192766] Starting subtest: test_forked_cpu_write
[177.194741] Starting dynamic subtest: test_forked_cpu_write-smem
[177.209076] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.020s)
[177.211348] Subtest test_forked_cpu_write: SUCCESS (0.021s)
[177.285805] [042/132] (827s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[177.382828] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[177.385082] Starting dynamic subtest: pipe-A-eDP-1
[177.621239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.238s)
[177.636354] Starting dynamic subtest: pipe-B-eDP-1
[178.989280] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[179.005481] Starting dynamic subtest: pipe-C-eDP-1
[180.375049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[180.388689] Starting dynamic subtest: pipe-D-eDP-1
[181.742175] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[181.744978] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.361s)
[182.993062] [043/132] (822s left) gem_mmap (bad-offset)
[183.083556] Subtest bad-offset: SKIP (0.000s)
[183.132462] [044/132] (822s left) syncobj_wait (wait-any-complex)
[183.199684] Starting subtest: wait-any-complex
[183.263079] Subtest wait-any-complex: SUCCESS (0.063s)
[183.333876] [045/132] (821s left) v3d/v3d_submit_cl (multiple-job-submission)
[183.406580] Subtest multiple-job-submission: SKIP (0.000s)
[183.451483] [046/132] (821s left) syncobj_timeline (wait-delayed-signal)
[183.530770] Starting subtest: wait-delayed-signal
[183.633835] Subtest wait-delayed-signal: SUCCESS (0.102s)
[183.703025] [047/132] (821s left) drm_mm (drm_mm)
[183.751312] Starting subtest: drm_mm
[183.759907] Starting dynamic subtest: drm_test_mm_init
[183.762443] Dynamic subtest drm_test_mm_init: SUCCESS (0.000s)
[183.774550] Starting dynamic subtest: drm_test_mm_debug
[183.776964] Dynamic subtest drm_test_mm_debug: SUCCESS (0.000s)
[183.785077] Starting dynamic subtest: drm_test_mm_align32
[183.787405] Dynamic subtest drm_test_mm_align32: SUCCESS (0.000s)
[183.795101] Starting dynamic subtest: drm_test_mm_align64
[183.797427] Dynamic subtest drm_test_mm_align64: SUCCESS (0.000s)
[183.804799] Starting dynamic subtest: drm_test_mm_lowest
[183.807145] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.000s)
[183.814188] Starting dynamic subtest: drm_test_mm_highest
[183.816501] Dynamic subtest drm_test_mm_highest: SUCCESS (0.000s)
[183.818964] Subtest drm_mm: SUCCESS (0.007s)
[183.896442] [048/132] (821s left) kms_flip (2x-plain-flip)
[184.002276] Starting subtest: 2x-plain-flip
[184.014763] Subtest 2x-plain-flip: SKIP (0.014s)
[184.088118] [049/132] (821s left) syncobj_timeline (device-submit-unordered)
[184.149597] Starting subtest: device-submit-unordered
[184.152152] Subtest device-submit-unordered: SUCCESS (0.000s)
[184.223710] [050/132] (821s left) kms_atomic_transition (plane-all-modeset-transition)
[184.306510] Starting subtest: plane-all-modeset-transition
[184.311161] Subtest plane-all-modeset-transition: SKIP (0.000s)
[184.368869] [051/132] (821s left) dmabuf_sync_file (import-basic)
[184.434633] Starting subtest: import-basic
[184.437405] Subtest import-basic: SUCCESS (0.003s)
[184.485325] [052/132] (821s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[184.564095] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[185.709451] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.147s)
[185.827109] [053/132] (819s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[185.948761] Starting subtest: y-tiled-addfb-size-offset-overflow
[185.952960] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[186.016847] [054/132] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[186.088762] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[191.332736] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.246s)
[191.451955] [055/132] (814s left) gem_exec_reloc (basic-write-read)
[191.525807] Subtest basic-write-read: SKIP (0.000s)
[191.563058] [056/132] (814s left) gem_softpin (allocator-basic-reserve)
[191.621901] Starting subtest: allocator-basic-reserve
[191.678896] Subtest allocator-basic-reserve: SUCCESS (0.057s)
[191.781876] [057/132] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[191.876741] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[195.205596] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.333s)
[195.336437] [058/132] (810s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[195.411392] Starting subtest: psr-dirtyfb-ioctl
[195.413502] Starting dynamic subtest: A-eDP-1
[197.121040] Dynamic subtest A-eDP-1: SUCCESS (1.708s)
[197.124226] Subtest psr-dirtyfb-ioctl: SUCCESS (1.709s)
[198.022135] [059/132] (807s left) v3d/v3d_get_param (base-params)
[198.094187] Subtest base-params: SKIP (0.000s)
[198.142259] [060/132] (807s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[198.248389] Starting subtest: modeset-transition-nonblocking-fencing
[198.250831] Starting dynamic subtest: 1x-outputs
[210.336178] Dynamic subtest 1x-outputs: SUCCESS (12.089s)
[210.650194] Subtest modeset-transition-nonblocking-fencing: SUCCESS (12.400s)
[211.524272] [061/132] (794s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[211.618840] Starting subtest: fbcpsr-suspend
[250.422972] Subtest fbcpsr-suspend: SUCCESS (8.816s)
[250.529942] [062/132] (785s left) kms_dsc (dsc-with-bpc-formats)
[250.612638] Starting subtest: dsc-with-bpc-formats
[250.620153] Subtest dsc-with-bpc-formats: SKIP (0.006s)
[250.689216] [063/132] (785s left) prime_vgem (sync)
[250.768411] Starting subtest: sync
[250.770971] Starting dynamic subtest: rcs0
[250.808195] Dynamic subtest rcs0: SUCCESS (0.039s)
[250.823643] Starting dynamic subtest: bcs0
[250.861462] Dynamic subtest bcs0: SUCCESS (0.053s)
[250.873651] Starting dynamic subtest: vcs0
[250.917562] Dynamic subtest vcs0: SUCCESS (0.055s)
[250.929059] Starting dynamic subtest: vcs1
[250.969251] Dynamic subtest vcs1: SUCCESS (0.051s)
[250.976763] Starting dynamic subtest: vecs0
[251.024361] Dynamic subtest vecs0: SUCCESS (0.053s)
[251.039477] Starting dynamic subtest: ccs0
[251.080000] Dynamic subtest ccs0: SUCCESS (0.055s)
[251.082535] Subtest sync: SUCCESS (0.312s)
[251.186991] [064/132] (784s left) syncobj_timeline (wait-all-for-submit-complex)
[251.263041] Starting subtest: wait-all-for-submit-complex
[251.479919] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[251.552933] [065/132] (784s left) kms_prop_blob (blob-prop-validate)
[251.620228] Starting subtest: blob-prop-validate
[251.622667] Subtest blob-prop-validate: SUCCESS (0.000s)
[251.695427] [066/132] (784s left) gem_caching (reads)
[251.769667] Subtest reads: SKIP (0.000s)
[251.809237] [067/132] (784s left) gem_ctx_shared (q-in-order)
[251.873113] Starting subtest: Q-in-order
[251.875729] Starting dynamic subtest: rcs0
[251.984331] Dynamic subtest rcs0: SUCCESS (0.109s)
[252.009321] Starting dynamic subtest: vcs0
[252.078060] Dynamic subtest vcs0: SUCCESS (0.093s)
[252.103082] Starting dynamic subtest: vcs1
[252.159488] Dynamic subtest vcs1: SUCCESS (0.080s)
[252.183626] Starting dynamic subtest: vecs0
[252.238187] Dynamic subtest vecs0: SUCCESS (0.078s)
[252.262086] Starting dynamic subtest: ccs0
[252.325875] Dynamic subtest ccs0: SUCCESS (0.087s)
[252.328503] Subtest Q-in-order: SUCCESS (0.453s)
[253.561797] [068/132] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[253.673132] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[253.677605] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[253.758007] [069/132] (782s left) kms_async_flips (alternate-sync-async-flip)
[253.846137] Starting subtest: alternate-sync-async-flip
[254.238514] Starting dynamic subtest: pipe-A-eDP-1
[257.050960] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.813s)
[257.451123] Starting dynamic subtest: pipe-B-eDP-1
[260.316823] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.881s)
[260.715688] Starting dynamic subtest: pipe-C-eDP-1
[263.581557] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.880s)
[263.974290] Starting dynamic subtest: pipe-D-eDP-1
[266.842610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[266.844914] Subtest alternate-sync-async-flip: SUCCESS (13.000s)
[268.146318] [070/132] (767s left) kms_lease (lease-unleased-connector)
[268.227873] Starting subtest: lease-unleased-connector
[268.230556] Starting dynamic subtest: pipe-A-eDP-1
[268.241115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[268.259588] Starting dynamic subtest: pipe-B-eDP-1
[268.262732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[268.272682] Starting dynamic subtest: pipe-C-eDP-1
[268.275033] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[268.283598] Starting dynamic subtest: pipe-D-eDP-1
[268.286003] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[268.288443] Subtest lease-unleased-connector: SUCCESS (0.038s)
[268.353505] [071/132] (767s left) kms_color (ctm-0-75)
[268.445379] Starting subtest: ctm-0-75
[268.447846] Starting dynamic subtest: pipe-A
[273.699790] Dynamic subtest pipe-A: SUCCESS (5.255s)
[273.714755] Starting dynamic subtest: pipe-B
[279.715303] Dynamic subtest pipe-B: SUCCESS (6.014s)
[279.731865] Starting dynamic subtest: pipe-C
[285.439405] Dynamic subtest pipe-C: SUCCESS (5.718s)
[285.457281] Starting dynamic subtest: pipe-D
[291.203166] Dynamic subtest pipe-D: SUCCESS (5.766s)
[291.205670] Subtest ctm-0-75: SUCCESS (22.759s)
[292.137490] [072/132] (743s left) kms_addfb_basic (clobberred-modifier)
[292.184696] Starting subtest: clobberred-modifier
[292.190108] Subtest clobberred-modifier: SKIP (0.000s)
[292.278766] [073/132] (743s left) kms_flip (2x-nonexisting-fb-interruptible)
[292.375177] Starting subtest: 2x-nonexisting-fb-interruptible
[292.391446] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.014s)
[292.467541] [074/132] (743s left) kms_busy (extended-modeset-hang-oldfb)
[292.541946] Starting subtest: extended-modeset-hang-oldfb
[292.544781] Starting dynamic subtest: pipe-A
[304.507376] Dynamic subtest pipe-A: SUCCESS (11.964s)
[304.526066] Starting dynamic subtest: pipe-D
[317.306762] Dynamic subtest pipe-D: SUCCESS (12.790s)
[317.309548] Subtest extended-modeset-hang-oldfb: SUCCESS (24.763s)
[318.195261] [075/132] (717s left) i915_query (engine-info-invalid)
[318.264300] Starting subtest: engine-info-invalid
[318.266998] Subtest engine-info-invalid: SUCCESS (0.000s)
[318.339631] [076/132] (717s left) tools_test (tools_test)
[318.409226] Starting subtest: tools_test
[318.493411] Subtest tools_test: SUCCESS (0.103s)
[318.552807] [077/132] (717s left) kms_chamelium_frames (hdmi-crc-fast)
[318.947780] Subtest hdmi-crc-fast: SKIP (0.000s)
[319.830359] [078/132] (716s left) kms_chamelium_color (ctm-negative)
[319.954959] Subtest ctm-negative: SKIP (0.000s)
[319.983531] [079/132] (716s left) kms_plane (plane-position-hole)
[320.080442] Starting subtest: plane-position-hole
[320.083198] Starting dynamic subtest: pipe-A
[326.249610] Dynamic subtest pipe-A: SUCCESS (6.169s)
[326.265639] Starting dynamic subtest: pipe-B
[333.155719] Dynamic subtest pipe-B: SUCCESS (6.905s)
[333.158526] Subtest plane-position-hole: SUCCESS (13.076s)
[334.011530] [080/132] (702s left) gem_exec_reloc (basic-gtt)
[334.089923] Subtest basic-gtt: SKIP (0.000s)
[334.146277] [081/132] (702s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[334.240796] Starting subtest: fbcpsr-tiling-linear
[338.870942] Subtest fbcpsr-tiling-linear: SUCCESS (4.633s)
[338.981458] [082/132] (697s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[339.085792] Starting subtest: psr-rgb101010-draw-mmap-wc
[343.971280] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.890s)
[344.079696] [083/132] (692s left) kms_rotation_crc (bad-tiling)
[344.181790] Starting subtest: bad-tiling
[344.186139] Subtest bad-tiling: SKIP (0.001s)
[344.239465] [084/132] (692s left) gem_barrier_race (remote-request)
[344.321872] Starting subtest: remote-request
[344.324336] Starting dynamic subtest: rcs0
[349.457016] Dynamic subtest rcs0: SUCCESS (5.136s)
[349.458884] Subtest remote-request: SUCCESS (5.136s)
[349.576813] [085/132] (686s left) perf_pmu (busy-idle)
[349.630141] Starting subtest: busy-idle
[349.632548] Starting dynamic subtest: rcs0
[350.327271] Dynamic subtest rcs0: SUCCESS (0.696s)
[350.346274] Starting dynamic subtest: bcs0
[350.997533] Dynamic subtest bcs0: SUCCESS (0.669s)
[351.016947] Starting dynamic subtest: vcs0
[352.434647] Dynamic subtest vcs0: SUCCESS (1.434s)
[352.453352] Starting dynamic subtest: vcs1
[354.482074] Dynamic subtest vcs1: SUCCESS (2.045s)
[354.501072] Starting dynamic subtest: vecs0
[356.466812] Dynamic subtest vecs0: SUCCESS (1.982s)
[356.486631] Starting dynamic subtest: ccs0
[357.140997] Dynamic subtest ccs0: SUCCESS (0.673s)
[357.144100] Subtest busy-idle: SUCCESS (7.511s)
[357.225991] [086/132] (679s left) kms_properties (plane-properties-legacy)
[357.316664] Starting subtest: plane-properties-legacy
[362.035336] Subtest plane-properties-legacy: SUCCESS (4.721s)
[362.931941] [087/132] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[363.020109] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[363.024532] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[363.103792] [088/132] (673s left) gem_mmap_wc (write-prefaulted)
[363.162826] Subtest write-prefaulted: SKIP (0.000s)
[363.203879] [089/132] (673s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[363.287185] Starting subtest: x-tiled-to-vebox-y-tiled
[363.292230] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[363.475536] [090/132] (673s left) gem_exec_basic (basic)
[363.541788] Starting subtest: basic
[363.544215] Starting dynamic subtest: rcs0-smem
[363.546641] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[363.565120] Starting dynamic subtest: bcs0-smem
[363.567315] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[363.578680] Starting dynamic subtest: vcs0-smem
[363.580790] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[363.589111] Starting dynamic subtest: vcs1-smem
[363.591195] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[363.598455] Starting dynamic subtest: vecs0-smem
[363.600677] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[363.607626] Starting dynamic subtest: ccs0-smem
[363.609779] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[363.611922] Subtest basic: SUCCESS (0.018s)
[365.528530] [091/132] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[365.622441] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[368.906180] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.288s)
[369.042985] [092/132] (667s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[369.117161] Starting subtest: y-tiled-to-vebox-x-tiled
[369.120831] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[369.303073] [093/132] (667s left) gem_exec_flush (basic-wb-ro-before-default)
[369.385836] Starting subtest: basic-wb-ro-before-default
[374.875826] Subtest basic-wb-ro-before-default: SUCCESS (5.490s)
[375.063615] [094/132] (661s left) gem_exec_schedule (preempt-queue-contexts)
[375.156635] Subtest preempt-queue-contexts: SKIP (0.000s)
[375.454444] [095/132] (661s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[375.548263] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[376.337400] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[376.498783] [096/132] (660s left) debugfs_test (read_all_entries_display_on)
[376.613579] Starting subtest: read_all_entries_display_on
[377.009103] Subtest read_all_entries_display_on: SUCCESS (0.395s)
[377.119166] [097/132] (659s left) gem_vm_create (invalid-destroy)
[377.193260] Starting subtest: invalid-destroy
[377.198718] Subtest invalid-destroy: SUCCESS (0.003s)
[377.294644] [098/132] (659s left) kms_vblank (ts-continuation-dpms-suspend)
[377.359663] Starting subtest: ts-continuation-dpms-suspend
[377.362107] Starting dynamic subtest: pipe-A-eDP-1
[394.374500] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[394.396711] Starting dynamic subtest: pipe-D-eDP-1
[412.338014] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.489s)
[412.340940] Subtest ts-continuation-dpms-suspend: SUCCESS (4.322s)
[413.242317] [099/132] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[413.331178] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[413.335415] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[413.419956] [100/132] (654s left) kms_psr (psr2-cursor-mmap-gtt)
[413.509062] Starting subtest: psr2-cursor-mmap-gtt
[413.511529] Starting dynamic subtest: eDP-1
[415.341240] Dynamic subtest eDP-1: SUCCESS (1.830s)
[415.343983] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.831s)
[416.248954] [101/132] (651s left) gem_exec_schedule (u-lateslice)
[416.351253] Starting subtest: u-lateslice
[416.353694] Starting dynamic subtest: rcs0
[416.377292] Dynamic subtest rcs0: SUCCESS (0.031s)
[416.397438] Starting dynamic subtest: bcs0
[416.404228] Dynamic subtest bcs0: SUCCESS (0.026s)
[416.420389] Starting dynamic subtest: vcs0
[416.427367] Dynamic subtest vcs0: SUCCESS (0.023s)
[416.439093] Starting dynamic subtest: vcs1
[416.450489] Dynamic subtest vcs1: SUCCESS (0.022s)
[416.461717] Starting dynamic subtest: vecs0
[416.473250] Dynamic subtest vecs0: SUCCESS (0.022s)
[416.485627] Starting dynamic subtest: ccs0
[416.494275] Dynamic subtest ccs0: SUCCESS (0.020s)
[416.496808] Subtest u-lateslice: SUCCESS (0.148s)
[418.141719] [102/132] (649s left) gem_exec_whisper (basic-sync-all)
[418.229368] Starting subtest: basic-sync-all
[429.356815] Subtest basic-sync-all: SUCCESS (11.124s)
[429.540164] [103/132] (638s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[429.622184] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[429.624753] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[429.712411] [104/132] (638s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[429.790616] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[429.793118] Starting dynamic subtest: pipe-A-default-mode
[430.079943] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[430.085370] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.287s)
[430.967060] [105/132] (636s left) kms_cursor_crc (cursor-random-256x256)
[431.181879] Starting subtest: cursor-random-256x256
[431.184621] Starting dynamic subtest: pipe-A-eDP-1
[435.121261] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.934s)
[435.158782] Starting dynamic subtest: pipe-D-eDP-1
[439.777490] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.636s)
[439.780144] Subtest cursor-random-256x256: SUCCESS (8.597s)
[440.660542] [106/132] (627s left) kms_pm_dc (dc6-dpms)
[441.755546] Starting subtest: dc6-dpms
[441.760172] Subtest dc6-dpms: SKIP (0.000s)
[441.830298] [107/132] (625s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[442.430923] Starting subtest: syncobj-timeline-multiple-ext-nodes
[442.437249] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s)
[444.237687] [108/132] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[444.343037] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[449.592522] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.253s)
[449.702587] [109/132] (618s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[451.315685] Starting subtest: gem-execbuf-stress-pc8
[451.371790] Subtest gem-execbuf-stress-pc8: SKIP (0.054s)
[452.255859] [110/132] (615s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[452.373222] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[452.378109] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[452.516285] [111/132] (615s left) gem_fence_thrash (bo-copy)
[452.567627] Starting subtest: bo-copy
[452.581724] Subtest bo-copy: SKIP (0.013s)
[452.613458] [112/132] (615s left) kms_cursor_crc (cursor-onscreen-256x256)
[452.836883] Starting subtest: cursor-onscreen-256x256
[452.842513] Starting dynamic subtest: pipe-A-eDP-1
[455.265520] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.424s)
[455.299354] Starting dynamic subtest: pipe-D-eDP-1
[458.457254] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.168s)
[458.459965] Subtest cursor-onscreen-256x256: SUCCESS (5.617s)
[459.329979] [113/132] (608s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[459.452925] Starting subtest: basic-flip-after-cursor-varying-size
[460.415595] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.963s)
[461.308688] [114/132] (606s left) kms_vblank (query-busy)
[461.384900] Starting subtest: query-busy
[461.387696] Starting dynamic subtest: pipe-A-eDP-1
[463.275291] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[463.291174] Starting dynamic subtest: pipe-D-eDP-1
[465.949202] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.664s)
[465.952397] Subtest query-busy: SUCCESS (4.564s)
[466.877814] [115/132] (601s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[466.943606] Starting subtest: etime-multi-wait-all-submitted-signaled
[467.051832] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[467.118805] [116/132] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[467.207035] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[472.147326] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.946s)
[472.255890] [117/132] (595s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[472.336880] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[475.355144] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.023s)
[475.475732] [118/132] (592s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[475.545713] Starting subtest: x-tiled-16bpp-rotate-180
[476.935267] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.392s)
[477.090924] [119/132] (591s left) perf (blocking)
[477.202079] Starting subtest: blocking
[477.204689] Starting dynamic subtest: 0-rcs0
[487.282250] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[487.297797] Starting dynamic subtest: 1-vecs0
[497.360741] Dynamic subtest 1-vecs0: SUCCESS (10.076s)
[497.363563] Subtest blocking: SUCCESS (20.106s)
[497.398736] [120/132] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[497.526826] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[497.531645] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[497.608834] [121/132] (570s left) gem_exec_balancer (full-pulse)
[497.689288] Starting subtest: full-pulse
[501.704502] Subtest full-pulse: SUCCESS (4.015s)
[501.975097] [122/132] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[502.077038] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[502.081287] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[502.156053] [123/132] (566s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[502.222409] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[502.225352] Starting dynamic subtest: pipe-A-eDP-1
[502.230968] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[502.242862] Starting dynamic subtest: pipe-B-eDP-1
[502.247212] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[502.254807] Starting dynamic subtest: pipe-C-eDP-1
[502.259720] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[502.274989] Starting dynamic subtest: pipe-D-eDP-1
[502.280799] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[502.286064] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[502.310297] [124/132] (565s left) gem_exec_schedule (noreorder-priority)
[502.506273] Starting subtest: noreorder-priority
[502.509848] Starting dynamic subtest: rcs0
[503.650296] Dynamic subtest rcs0: SUCCESS (1.145s)
[503.669631] Starting dynamic subtest: vcs0
[505.117691] Dynamic subtest vcs0: SUCCESS (1.465s)
[505.137947] Starting dynamic subtest: vcs1
[507.102750] Dynamic subtest vcs1: SUCCESS (1.983s)
[507.125168] Starting dynamic subtest: vecs0
[509.106859] Dynamic subtest vecs0: SUCCESS (2.003s)
[509.126121] Starting dynamic subtest: ccs0
[510.270505] Dynamic subtest ccs0: SUCCESS (1.164s)
[510.273143] Subtest noreorder-priority: SUCCESS (7.767s)
[510.463018] [125/132] (557s left) gem_ctx_exec (basic-nohangcheck)
[510.547029] Starting subtest: basic-nohangcheck
[510.925065] Subtest basic-nohangcheck: SUCCESS (0.378s)
[511.024431] [126/132] (557s left) kms_invalid_mode (uint-max-clock)
[511.111096] Starting subtest: uint-max-clock
[511.113815] Starting dynamic subtest: pipe-A-eDP-1
[511.391858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[511.401687] Starting dynamic subtest: pipe-B-eDP-1
[511.404184] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[511.411897] Starting dynamic subtest: pipe-C-eDP-1
[511.414410] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[511.429849] Starting dynamic subtest: pipe-D-eDP-1
[511.432640] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[511.435493] Subtest uint-max-clock: SUCCESS (0.297s)
[512.307971] [127/132] (556s left) gem_exec_suspend (basic-s4-devices)
[512.375589] Starting subtest: basic-S4-devices
[512.378099] Starting dynamic subtest: smem
[526.072133] Dynamic subtest smem: SUCCESS (13.694s)
[526.075982] Subtest basic-S4-devices: SUCCESS (13.695s)
[529.312726] [128/132] (542s left) api_intel_allocator (open-vm)
[529.403790] Starting subtest: open-vm
[529.409706] Subtest open-vm: SUCCESS (0.008s)
[529.510870] [129/132] (542s left) kms_color (ctm-negative)
[529.599324] Starting subtest: ctm-negative
[529.601713] Starting dynamic subtest: pipe-A
[530.355945] Dynamic subtest pipe-A: SUCCESS (0.755s)
[530.370762] Starting dynamic subtest: pipe-B
[531.873886] Dynamic subtest pipe-B: SUCCESS (1.518s)
[531.893522] Starting dynamic subtest: pipe-C
[533.346620] Dynamic subtest pipe-C: SUCCESS (1.471s)
[533.366992] Starting dynamic subtest: pipe-D
[534.819506] Dynamic subtest pipe-D: SUCCESS (1.471s)
[534.822505] Subtest ctm-negative: SUCCESS (5.219s)
[535.737531] [130/132] (535s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[535.819071] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[535.824175] Starting dynamic subtest: pipe-A-eDP-1
[535.826826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[535.846133] Starting dynamic subtest: pipe-B-eDP-1
[535.848750] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[535.861691] Starting dynamic subtest: pipe-C-eDP-1
[535.864146] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[535.873923] Starting dynamic subtest: pipe-D-eDP-1
[535.876028] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[535.878108] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[535.910442] [131/132] (535s left) gem_readwrite (beyond-eob)
[535.983169] Subtest beyond-EOB: SKIP (0.000s)
[536.037286] [132/132] (535s left) gem_eio (kms)
[536.289755] Starting subtest: kms
[559.584168] Subtest kms: SUCCESS (23.297s)
[559.676764] Closing watchdogs
Done.