[53.575796] Initializing watchdogs
[53.576393]   /dev/watchdog0
[53.612503] [001/142] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[54.183946] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[59.851987] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (5.674s)
[60.138463] [002/142] (954s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[61.404168] Starting subtest: pipe-D-bad-pixel-format-yf_tiled_ccs
[61.411384] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[61.971302] [003/142] (952s left) drm_read (short-buffer-block)
[62.997645] Starting subtest: short-buffer-block
[63.000465] Subtest short-buffer-block: SUCCESS (0.001s)
[63.149682] [004/142] (951s left) kms_vblank (pipe-a-wait-busy-hang)
[63.326741] Starting subtest: pipe-A-wait-busy-hang
[77.842848] Subtest pipe-A-wait-busy-hang: SUCCESS (14.514s)
[78.777275] [005/142] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[79.278223] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[79.284758] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[79.436889] [006/142] (935s left) sw_sync (alloc_fence)
[79.801138] Starting subtest: alloc_fence
[79.804526] Subtest alloc_fence: SUCCESS (0.001s)
[79.908073] [007/142] (934s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[80.439711] Starting subtest: cursorA-vs-flipA-atomic
[92.073978] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.636s)
[92.993239] [008/142] (921s left) prime_busy (before-wait)
[93.380264] Starting subtest: before-wait
[93.409476] Starting dynamic subtest: rcs0
[93.434740] Dynamic subtest rcs0: SUCCESS (0.024s)
[93.465736] Starting dynamic subtest: bcs0
[93.482610] Dynamic subtest bcs0: SUCCESS (0.048s)
[93.512833] Starting dynamic subtest: vcs0
[93.530912] Dynamic subtest vcs0: SUCCESS (0.047s)
[93.564539] Starting dynamic subtest: vcs1
[93.567936] Dynamic subtest vcs1: SUCCESS (0.031s)
[93.598368] Starting dynamic subtest: vecs0
[93.601617] Dynamic subtest vecs0: SUCCESS (0.024s)
[93.633769] Starting dynamic subtest: ccs0
[93.637303] Dynamic subtest ccs0: SUCCESS (0.028s)
[93.741877] Subtest before-wait: SUCCESS (0.361s)
[93.874493] [009/142] (920s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[94.354196] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[94.360407] Starting dynamic subtest: pipe-A-default-mode
[94.778281] Dynamic subtest pipe-A-default-mode: SKIP (0.411s)
[94.785342] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.422s)
[95.695501] [010/142] (919s left) kms_plane_multiple (tiling-y)
[96.175572] Starting subtest: tiling-y
[96.182465] Subtest tiling-y: SKIP (0.000s)
[96.302412] [011/142] (918s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[96.810364] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[96.817169] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[96.955761] [012/142] (917s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[97.490550] Starting subtest: yf-tiled-16bpp-rotate-270
[97.497261] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[97.632177] [013/142] (917s left) syncobj_timeline (reset-unsignaled)
[98.004102] Starting subtest: reset-unsignaled
[98.007569] Subtest reset-unsignaled: SUCCESS (0.001s)
[98.133519] [014/142] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[98.632430] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[98.638780] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.783862] [015/142] (916s left) kms_vblank (pipe-b-query-idle-hang)
[99.251887] Starting subtest: pipe-B-query-idle-hang
[114.903854] Subtest pipe-B-query-idle-hang: SUCCESS (15.651s)
[115.839816] [016/142] (899s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[116.319361] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[120.198852] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (3.876s)
[121.131704] [017/142] (894s left) kms_lease (master-vs-lease)
[121.603082] Starting subtest: master-vs-lease
[121.606898] Subtest master-vs-lease: SUCCESS (0.006s)
[121.736858] [018/142] (893s left) kms_psr (sprite_plane_onoff)
[122.218760] Starting subtest: sprite_plane_onoff
[124.304511] Subtest sprite_plane_onoff: SUCCESS (2.079s)
[125.208940] [019/142] (890s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[126.543931] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[126.560436] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.014s)
[127.627527] [020/142] (887s left) kms_sequence (queue-busy)
[128.107173] Starting subtest: queue-busy
[128.110632] Starting dynamic subtest: eDP-1-pipe-A
[130.303924] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.190s)
[130.338142] Starting dynamic subtest: eDP-1-pipe-B
[133.235116] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.925s)
[133.270938] Starting dynamic subtest: eDP-1-pipe-C
[136.388314] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.148s)
[136.423870] Starting dynamic subtest: eDP-1-pipe-D
[139.846651] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.449s)
[139.850361] Subtest queue-busy: SUCCESS (11.740s)
[140.780904] [021/142] (874s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[141.149733] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[141.153333] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.003s)
[141.279505] [022/142] (874s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[141.772766] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[141.779168] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.921707] [023/142] (873s left) gem_exec_store (dword)
[142.336818] Starting subtest: dword
[142.340084] Starting dynamic subtest: rcs0
[142.393979] Dynamic subtest rcs0: SUCCESS (0.056s)
[142.425551] Starting dynamic subtest: bcs0
[142.446376] Dynamic subtest bcs0: SUCCESS (0.050s)
[142.479852] Starting dynamic subtest: vcs0
[143.569904] Dynamic subtest vcs0: SUCCESS (1.121s)
[143.600747] Starting dynamic subtest: vcs1
[145.552914] Dynamic subtest vcs1: SUCCESS (1.981s)
[145.584197] Starting dynamic subtest: vecs0
[147.536781] Dynamic subtest vecs0: SUCCESS (1.982s)
[147.567773] Starting dynamic subtest: ccs0
[147.590784] Dynamic subtest ccs0: SUCCESS (0.053s)
[147.594647] Subtest dword: SUCCESS (5.255s)
[147.884980] [024/142] (867s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[148.396697] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[163.182552] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (14.783s)
[163.422627] [025/142] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[163.932479] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[175.798349] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (11.871s)
[176.061394] [026/142] (839s left) kms_chamelium_color (ctm-limited-range)
[176.546482] Subtest ctm-limited-range: SKIP (0.000s)
[176.650585] [027/142] (839s left) gem_exec_reloc (basic-concurrent16)
[177.046158] Subtest basic-concurrent16: SKIP (0.000s)
[177.191404] [028/142] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[177.699956] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[177.706697] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[177.864189] [029/142] (838s left) kms_addfb_basic (bad-pitch-256)
[178.236475] Starting subtest: bad-pitch-256
[178.239906] Subtest bad-pitch-256: SUCCESS (0.000s)
[178.503356] [030/142] (837s left) gem_mmap_wc (pf-nonblock)
[178.871834] Subtest pf-nonblock: SKIP (0.000s)
[178.974517] [031/142] (837s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[179.340344] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[179.447954] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[179.584692] [032/142] (836s left) gem_eio (banned)
[180.724891] Starting subtest: banned
[183.145821] Subtest banned: SUCCESS (2.421s)
[183.640939] [033/142] (832s left) gem_exec_schedule (preemptive-hang)
[184.210907] Starting subtest: preemptive-hang
[184.214543] Starting dynamic subtest: rcs0
[194.160240] Dynamic subtest rcs0: SUCCESS (9.948s)
[194.196815] Starting dynamic subtest: bcs0
[204.229272] Dynamic subtest bcs0: SUCCESS (10.065s)
[204.266815] Starting dynamic subtest: vcs0
[220.170183] Dynamic subtest vcs0: FAIL (15.822s)
[220.205672] Starting dynamic subtest: vcs1
[230.213135] Dynamic subtest vcs1: SUCCESS (10.152s)
[230.253157] Starting dynamic subtest: vecs0
[240.167707] Dynamic subtest vecs0: SUCCESS (9.951s)
[240.205346] Starting dynamic subtest: ccs0
[250.207838] Dynamic subtest ccs0: SUCCESS (10.037s)
[250.212176] Subtest preemptive-hang: FAIL (65.997s)
[250.566399] [034/142] (765s left) kms_universal_plane (cursor-fb-leak-pipe-d)
[251.062133] Starting subtest: cursor-fb-leak-pipe-D
[253.857504] Subtest cursor-fb-leak-pipe-D: SUCCESS (2.801s)
[254.788627] [035/142] (761s left) kms_fbcon_fbt (psr)
[255.194571] Starting subtest: psr
[260.927906] Subtest psr: SUCCESS (5.735s)
[261.131220] [036/142] (755s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[262.654103] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[263.140442] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SUCCESS (0.491s)
[263.975409] [037/142] (752s left) kms_atomic (atomic-invalid-params)
[264.782319] Starting subtest: atomic-invalid-params
[264.878918] Subtest atomic-invalid-params: SUCCESS (0.102s)
[266.225885] [038/142] (750s left) kms_setmode (invalid-clone-single-crtc-stealing)
[266.603797] Starting subtest: invalid-clone-single-crtc-stealing
[266.613817] Subtest invalid-clone-single-crtc-stealing: SKIP (0.003s)
[266.734365] [039/142] (750s left) syncobj_wait (invalid-single-wait-unsubmitted)
[267.115815] Starting subtest: invalid-single-wait-unsubmitted
[267.119588] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[267.249859] [040/142] (749s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[267.723142] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[267.728164] Starting dynamic subtest: pipe-A-eDP-1
[267.926301] Dynamic subtest pipe-A-eDP-1: SKIP (0.193s)
[267.967200] Starting dynamic subtest: pipe-B-eDP-1
[268.219178] Dynamic subtest pipe-B-eDP-1: SKIP (0.281s)
[268.261850] Starting dynamic subtest: pipe-C-eDP-1
[268.512224] Dynamic subtest pipe-C-eDP-1: SKIP (0.283s)
[268.552605] Starting dynamic subtest: pipe-D-eDP-1
[268.805748] Dynamic subtest pipe-D-eDP-1: SKIP (0.279s)
[268.811866] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (1.080s)
[268.981978] [041/142] (747s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_ccs)
[270.788315] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_ccs
[270.804425] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.013s)
[271.391509] [042/142] (745s left) gem_tiled_pread_pwrite
[271.879120] [043/142] (745s left) fbdev (eof)
[272.259842] Starting subtest: eof
[272.263317] Subtest eof: SUCCESS (0.001s)
[272.410183] [044/142] (744s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[272.956134] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[276.274050] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: FAIL (2.609s)
[276.339858] [045/142] (740s left) debugfs_test (sysfs)
[276.729590] Starting subtest: sysfs
[277.920464] Subtest sysfs: SUCCESS (1.188s)
[278.152323] [046/142] (739s left) sysfs_heartbeat_interval (idempotent)
[278.541979] Starting subtest: idempotent
[278.545646] Starting dynamic subtest: vecs0
[278.549331] Dynamic subtest vecs0: SUCCESS (0.005s)
[278.588059] Starting dynamic subtest: ccs0
[278.591552] Dynamic subtest ccs0: SUCCESS (0.005s)
[278.629254] Starting dynamic subtest: vcs0
[278.632288] Dynamic subtest vcs0: SUCCESS (0.004s)
[278.668397] Starting dynamic subtest: bcs0
[278.671455] Dynamic subtest bcs0: SUCCESS (0.004s)
[278.707983] Starting dynamic subtest: rcs0
[278.711166] Dynamic subtest rcs0: SUCCESS (0.004s)
[278.747118] Starting dynamic subtest: vcs1
[278.750117] Dynamic subtest vcs1: SUCCESS (0.004s)
[278.752979] Subtest idempotent: SUCCESS (0.054s)
[278.811253] [047/142] (738s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs)
[280.172777] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs
[281.487496] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.315s)
[282.840614] [048/142] (734s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[284.597160] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[284.767308] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.170s)
[285.428079] [049/142] (732s left) perf (buffer-fill)
[286.339344] Starting subtest: buffer-fill
[286.342901] Starting dynamic subtest: 0-rcs0
[290.159785] Dynamic subtest 0-rcs0: SUCCESS (3.818s)
[290.199235] Starting dynamic subtest: 1-vecs0
[297.456327] Dynamic subtest 1-vecs0: SUCCESS (7.293s)
[297.460474] Subtest buffer-fill: SUCCESS (11.118s)
[297.571198] [050/142] (720s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[299.343903] Starting subtest: pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[299.523085] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.179s)
[300.166090] [051/142] (717s left) kms_cursor_edge_walk (128x128-top-edge)
[300.641560] Starting subtest: 128x128-top-edge
[300.650325] Starting dynamic subtest: pipe-A-eDP-1
[304.547844] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.898s)
[304.595133] Starting dynamic subtest: pipe-D-eDP-1
[308.007333] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.450s)
[308.010633] Subtest 128x128-top-edge: SUCCESS (7.369s)
[308.926972] [052/142] (708s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[309.451761] Starting subtest: 4-tiled-16bpp-rotate-0
[313.896998] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (4.443s)
[314.345906] [053/142] (703s left) i915_pm_backlight (bad-brightness)
[314.853515] Starting subtest: bad-brightness
[315.207333] Starting dynamic subtest: eDP-1
[315.712080] Dynamic subtest eDP-1: SUCCESS (0.508s)
[315.716065] Subtest bad-brightness: SUCCESS (0.863s)
[316.671707] [054/142] (701s left) gem_exec_flush (basic-wb-rw-before-default)
[317.090189] Starting subtest: basic-wb-rw-before-default
[322.985132] Subtest basic-wb-rw-before-default: SUCCESS (5.894s)
[323.278831] [055/142] (694s left) syncobj_timeline (wait-all-snapshot)
[323.647574] Starting subtest: wait-all-snapshot
[323.732188] Subtest wait-all-snapshot: SUCCESS (0.084s)
[323.893523] [056/142] (694s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[324.361062] Starting subtest: plane-upscale-with-pixel-format-20x20
[324.369419] Starting dynamic subtest: pipe-A-eDP-1
[328.517588] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.151s)
[328.566650] Starting dynamic subtest: pipe-B-eDP-1
[334.105347] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.575s)
[334.153756] Starting dynamic subtest: pipe-C-eDP-1
[336.070972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.954s)
[336.118886] Starting dynamic subtest: pipe-D-eDP-1
[337.826143] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.743s)
[337.829831] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (13.468s)
[339.330563] [057/142] (678s left) kms_rotation_crc (primary-rotation-90)
[339.793602] Starting subtest: primary-rotation-90
[339.806122] Subtest primary-rotation-90: SKIP (0.008s)
[339.947496] [058/142] (678s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[340.429094] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[340.435940] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[342.300757] [059/142] (676s left) core_setmaster_vs_auth
[342.821136] [060/142] (675s left) kms_cursor_crc (cursor-sliding-256x85)
[343.906405] Starting subtest: cursor-sliding-256x85
[343.937607] Starting dynamic subtest: pipe-A-eDP-1
[349.919290] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.980s)
[350.085125] Starting dynamic subtest: pipe-D-eDP-1
[356.510239] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.460s)
[356.513639] Subtest cursor-sliding-256x85: SUCCESS (12.602s)
[357.474663] [061/142] (661s left) i915_pm_rpm (gem-execbuf-stress)
[363.564362] Starting subtest: gem-execbuf-stress
[363.567922] Starting dynamic subtest: smem0
[405.831435] Dynamic subtest smem0: SUCCESS (42.269s)
[405.853673] Starting dynamic subtest: extra-wait-smem0
[493.966211] Dynamic subtest extra-wait-smem0: SUCCESS (88.128s)
[493.970313] Subtest gem-execbuf-stress: SUCCESS (130.409s)
[494.511283] [062/142] (524s left) gem_mmap_gtt (isolation)
[494.881635] Subtest isolation: SKIP (0.000s)
[494.996529] [063/142] (523s left) gem_exec_fence (syncobj-export)
[497.137354] Starting subtest: syncobj-export
[497.157319] Subtest syncobj-export: SUCCESS (0.019s)
[497.727494] [064/142] (521s left) gem_lmem_swapping (random)
[498.127200] Subtest random: SKIP (0.000s)
[498.255709] [065/142] (520s left) gem_ctx_persistence (heartbeat-hang)
[498.657833] Starting subtest: heartbeat-hang
[498.664321] Subtest heartbeat-hang: SKIP (0.001s)
[498.843444] [066/142] (520s left) gem_watchdog (default-physical)
[499.255501] Starting subtest: default-physical
[500.563617] Subtest default-physical: SUCCESS (1.315s)
[500.733717] [067/142] (518s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_ccs)
[501.776123] Starting subtest: pipe-A-bad-aux-stride-y_tiled_ccs
[501.782713] Subtest pipe-A-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[503.097685] [068/142] (515s left) gem_exec_schedule (u-fairslice-all)
[503.525754] Starting subtest: u-fairslice-all
[505.754759] Subtest u-fairslice-all: SUCCESS (2.228s)
[507.711778] [069/142] (511s left) kms_vblank (pipe-a-query-busy)
[508.172113] Starting subtest: pipe-A-query-busy
[510.221617] Subtest pipe-A-query-busy: SUCCESS (2.046s)
[511.168649] [070/142] (508s left) kms_vblank (pipe-c-ts-continuation-modeset-hang)
[511.653920] Starting subtest: pipe-C-ts-continuation-modeset-hang
[527.866447] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (16.215s)
[528.818135] [071/142] (490s left) gem_ctx_engines (execute-oneforall)
[529.241163] Starting subtest: execute-oneforall
[531.150800] Subtest execute-oneforall: SUCCESS (1.913s)
[531.756926] [072/142] (487s left) syncobj_wait (invalid-signal-zero-handles)
[532.145088] Starting subtest: invalid-signal-zero-handles
[532.149097] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[532.324125] [073/142] (487s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[535.229578] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[535.401357] [074/142] (484s left) syncobj_wait (invalid-reset-one-illegal-handle)
[535.788988] Starting subtest: invalid-reset-one-illegal-handle
[535.795618] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.002s)
[535.970569] [075/142] (483s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[536.514300] Starting subtest: x-tiled-64bpp-rotate-180
[542.888937] Subtest x-tiled-64bpp-rotate-180: SUCCESS (6.369s)
[543.605989] [076/142] (476s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[544.083172] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[544.090122] Starting dynamic subtest: pipe-A-default-mode
[544.493880] Dynamic subtest pipe-A-default-mode: SKIP (0.396s)
[544.500716] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.410s)
[545.423440] [077/142] (474s left) gem_ctx_shared (detached-shared-gtt)
[545.858749] Starting subtest: detached-shared-gtt
[548.014634] Subtest detached-shared-gtt: SUCCESS (2.154s)
[548.617412] [078/142] (471s left) gem_exec_gttfill (basic)
[549.049957] Starting subtest: basic
[561.554158] Subtest basic: SUCCESS (12.502s)
[561.857658] [079/142] (458s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[562.386859] Starting subtest: invalid-single-wait-all-unsubmitted
[562.390630] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[562.565600] [080/142] (457s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[563.135407] Starting subtest: y-tiled-32bpp-rotate-90
[563.142365] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[563.303114] [081/142] (456s left) perf (i915-ref-count)
[563.883740] Starting subtest: i915-ref-count
[564.017662] Subtest i915-ref-count: SUCCESS (0.137s)
[564.224217] [082/142] (456s left) kms_hdr (invalid-hdr)
[564.690788] Starting subtest: invalid-hdr
[565.910952] Starting dynamic subtest: pipe-A-eDP-1
[576.415525] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.505s)
[576.419246] Subtest invalid-hdr: SUCCESS (11.729s)
[576.613155] [083/142] (443s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[577.007832] Starting subtest: invalid-signal-one-illegal-handle
[577.011376] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.002s)
[577.155871] [084/142] (443s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[577.661914] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[577.669341] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[577.837953] [085/142] (442s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[578.348118] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[578.354860] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[578.520479] [086/142] (442s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[578.984324] Subtest get-values-invalid-pointer: SKIP (0.000s)
[579.117859] [087/142] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[579.617724] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[579.624266] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[579.784787] [088/142] (441s left) perf_pmu (busy)
[580.171076] Starting subtest: busy
[580.174899] Starting dynamic subtest: rcs0
[580.791166] Dynamic subtest rcs0: SUCCESS (0.618s)
[580.846138] Starting dynamic subtest: bcs0
[581.381827] Dynamic subtest bcs0: SUCCESS (0.587s)
[581.436151] Starting dynamic subtest: vcs0
[582.544327] Dynamic subtest vcs0: SUCCESS (1.157s)
[582.593162] Starting dynamic subtest: vcs1
[584.531285] Dynamic subtest vcs1: SUCCESS (1.980s)
[584.576460] Starting dynamic subtest: vecs0
[586.514112] Dynamic subtest vecs0: SUCCESS (1.979s)
[586.562421] Starting dynamic subtest: ccs0
[587.100332] Dynamic subtest ccs0: SUCCESS (0.585s)
[587.103960] Subtest busy: SUCCESS (6.932s)
[587.292806] [089/142] (433s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[587.873885] Starting subtest: x-tiled-16bpp-rotate-0
[593.516990] Subtest x-tiled-16bpp-rotate-0: SUCCESS (5.640s)
[593.915383] [090/142] (427s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[595.119375] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[595.125784] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[596.000935] [091/142] (425s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[596.788121] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[596.791731] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.003s)
[597.669477] [092/142] (423s left) gem_pxp (verify-pxp-stale-ctx-execution)
[600.589872] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[600.761563] [093/142] (420s left) kms_addfb_basic (bad-pitch-999)
[601.131946] Starting subtest: bad-pitch-999
[601.135493] Subtest bad-pitch-999: SUCCESS (0.000s)
[601.433666] [094/142] (419s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[602.016411] Starting subtest: basic-busy-flip-before-cursor-legacy
[602.023956] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[602.341105] [095/142] (419s left) perf (gen12-group-exclusive-stream-sample-oa)
[602.949408] Starting subtest: gen12-group-exclusive-stream-sample-oa
[603.020598] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.070s)
[603.140702] [096/142] (418s left) v3d/v3d_submit_cl (bad-multisync-in-sync)
[603.609263] Subtest bad-multisync-in-sync: SKIP (0.000s)
[603.742285] [097/142] (417s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[603.957688] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[603.961976] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[604.046784] [098/142] (417s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[604.432993] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[604.440360] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[604.588604] [099/142] (417s left) vgem_basic (bad-pad)
[604.964785] Starting subtest: bad-pad
[604.968359] Subtest bad-pad: SUCCESS (0.000s)
[605.101392] [100/142] (416s left) gem_render_copy_redux (normal)
[605.539266] Starting subtest: normal
[608.518086] Subtest normal: SUCCESS (2.980s)
[608.735499] [101/142] (413s left) kms_vblank (pipe-a-ts-continuation-modeset)
[609.226436] Starting subtest: pipe-A-ts-continuation-modeset
[611.130556] Subtest pipe-A-ts-continuation-modeset: SUCCESS (1.906s)
[612.088663] [102/142] (409s left) kms_cursor_crc (cursor-random-256x256)
[613.090608] Starting subtest: cursor-random-256x256
[613.126734] Starting dynamic subtest: pipe-A-eDP-1
[619.356947] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.228s)
[619.574307] Starting dynamic subtest: pipe-D-eDP-1
[625.984192] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.450s)
[625.987618] Subtest cursor-random-256x256: SUCCESS (12.887s)
[626.971668] [103/142] (395s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[627.385050] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[627.391416] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[627.664842] [104/142] (394s left) drm_read (short-buffer-wakeup)
[628.480299] Starting subtest: short-buffer-wakeup
[660.711691] Subtest short-buffer-wakeup: SUCCESS (32.235s)
[660.934341] [105/142] (361s left) kms_properties (crtc-properties-atomic)
[661.406231] Starting subtest: crtc-properties-atomic
[665.785595] Subtest crtc-properties-atomic: SUCCESS (4.380s)
[666.773190] [106/142] (355s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[667.260811] Starting subtest: pipe-D-ts-continuation-idle-hang
[682.738354] Subtest pipe-D-ts-continuation-idle-hang: SUCCESS (15.473s)
[683.679414] [107/142] (338s left) i915_pm_rps (fence-order)
[684.073732] Starting subtest: fence-order
[686.473671] Subtest fence-order: SUCCESS (2.397s)
[686.660627] [108/142] (335s left) gem_userptr_blits (userfault)
[687.083117] Starting subtest: userfault
[687.098527] Subtest userfault: SUCCESS (0.020s)
[687.435106] [109/142] (335s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[688.311185] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[689.189380] [110/142] (333s left) kms_vblank (pipe-b-query-idle)
[689.671063] Starting subtest: pipe-B-query-idle
[692.719173] Subtest pipe-B-query-idle: SUCCESS (3.049s)
[693.679432] [111/142] (329s left) kms_prop_blob (blob-prop-core)
[694.075051] Starting subtest: blob-prop-core
[694.078866] Subtest blob-prop-core: SUCCESS (0.000s)
[694.231504] [112/142] (328s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[694.732845] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[694.739863] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[694.891844] [113/142] (328s left) vc4/vc4_create_bo (create-bo-4096)
[695.350958] Subtest create-bo-4096: SKIP (0.000s)
[695.486096] [114/142] (327s left) gem_workarounds (basic-read-context)
[695.937647] Starting subtest: basic-read-context
[695.986935] Subtest basic-read-context: SUCCESS (0.050s)
[696.179913] [115/142] (326s left) gem_exec_fence (invalid-fence-array)
[698.486253] Starting subtest: invalid-fence-array
[698.496951] Subtest invalid-fence-array: SUCCESS (0.008s)
[698.993859] [116/142] (324s left) i915_pm_rpm (debugfs-read)
[701.746954] Starting subtest: debugfs-read
[822.645198] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[824.652842] Closing watchdogs
[824.661118] Initializing watchdogs
[824.661478]   /dev/watchdog0
[824.720510] [117/142] (198s left) kms_setmode (basic)
[825.097403] Starting subtest: basic
[825.833563] Starting dynamic subtest: pipe-A-eDP-1
[827.884850] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.047s)
[828.535914] Starting dynamic subtest: pipe-B-eDP-1
[830.516487] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.024s)
[830.929753] Subtest basic: SUCCESS (5.826s)
[831.882080] [118/142] (191s left) gem_busy (extended)
[832.480307] Starting subtest: extended
[832.484581] Starting dynamic subtest: rcs0
[832.571629] Dynamic subtest rcs0: SUCCESS (0.090s)
[832.627605] Starting dynamic subtest: bcs0
[832.631583] Dynamic subtest bcs0: SUCCESS (0.048s)
[832.679221] Starting dynamic subtest: vcs0
[834.577137] Dynamic subtest vcs0: SUCCESS (1.947s)
[834.626176] Starting dynamic subtest: vcs1
[836.560566] Dynamic subtest vcs1: SUCCESS (1.980s)
[836.608767] Starting dynamic subtest: vecs0
[838.545799] Dynamic subtest vecs0: SUCCESS (1.980s)
[838.596477] Starting dynamic subtest: ccs0
[838.600648] Dynamic subtest ccs0: SUCCESS (0.051s)
[838.604652] Subtest extended: SUCCESS (6.119s)
[838.943751] [119/142] (184s left) kms_chamelium_hpd (hdmi-hpd-storm)
[839.840521] Subtest hdmi-hpd-storm: SKIP (0.000s)
[840.717416] [120/142] (182s left) kms_dsc (dsc-with-bpc-formats)
[841.188155] Starting subtest: dsc-with-bpc-formats
[841.209795] Subtest dsc-with-bpc-formats: SKIP (0.020s)
[841.359409] [121/142] (182s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[842.518399] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[842.525764] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[843.815138] [122/142] (180s left) gem_sync (basic-store-each)
[844.245191] Starting subtest: basic-store-each
[847.253402] Subtest basic-store-each: SUCCESS (3.007s)
[847.566450] [123/142] (176s left) gen9_exec_parse (bb-large)
[847.970158] Subtest bb-large: SKIP (0.000s)
[848.109583] [124/142] (175s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[849.131230] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[849.134946] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s)
[850.537514] [125/142] (173s left) v3d/v3d_submit_csd (single-in-sync)
[851.015208] Subtest single-in-sync: SKIP (0.000s)
[851.154147] [126/142] (173s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[851.713741] Starting subtest: flip-vs-cursor-toggle
[859.786059] Subtest flip-vs-cursor-toggle: FAIL (7.345s)
[859.868880] [127/142] (164s left) syncobj_wait (single-wait-all-for-submit-submitted)
[860.246478] Starting subtest: single-wait-all-for-submit-submitted
[860.351757] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[860.508621] [128/142] (163s left) sw_sync (sync_busy_fork)
[860.869263] Starting subtest: sync_busy_fork
[861.931827] Subtest sync_busy_fork: SUCCESS (1.066s)
[862.078666] [129/142] (162s left) kms_addfb_basic (invalid-get-prop)
[862.464629] Starting subtest: invalid-get-prop
[862.468234] Subtest invalid-get-prop: SUCCESS (0.000s)
[862.755424] [130/142] (161s left) gem_exec_balancer (busy)
[863.180407] Starting subtest: busy
[866.927510] Subtest busy: SUCCESS (3.747s)
[867.953100] [131/142] (156s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[868.467354] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[868.474204] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[868.642508] [132/142] (156s left) gem_exec_balancer (persistence)
[869.893596] Starting subtest: persistence
[877.147485] Subtest persistence: SUCCESS (7.252s)
[877.334508] [133/142] (147s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[878.292243] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[878.299798] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.003s)
[879.769512] [134/142] (145s left) gem_request_retire (retire-vma-not-inactive)
[880.140966] Starting subtest: retire-vma-not-inactive
[880.219433] Subtest retire-vma-not-inactive: SUCCESS (0.073s)
[881.699328] [135/142] (143s left) kms_frontbuffer_tracking (psr-slowdraw)
[882.206243] Starting subtest: psr-slowdraw
[912.460833] Subtest psr-slowdraw: SUCCESS (30.257s)
[912.671088] [136/142] (112s left) kms_invalid_mode (bad-htotal)
[913.170961] Starting subtest: bad-htotal
[913.183898] Starting dynamic subtest: eDP-1-pipe-A
[913.582190] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.401s)
[913.634372] Starting dynamic subtest: eDP-1-pipe-B
[913.638331] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.028s)
[913.689461] Starting dynamic subtest: eDP-1-pipe-C
[913.693471] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.029s)
[913.748119] Starting dynamic subtest: eDP-1-pipe-D
[913.752260] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.029s)
[913.756214] Subtest bad-htotal: SUCCESS (0.525s)
[914.502555] [137/142] (110s left) gem_exec_params (rel-constants-invalid-ring)
[914.899656] Starting subtest: rel-constants-invalid-ring
[914.904233] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[915.062976] [138/142] (110s left) gem_mmap_gtt (basic-small-copy-xy)
[915.278373] Subtest basic-small-copy-XY: SKIP (0.000s)
[915.397883] [139/142] (110s left) kms_content_protection (mei_interface)
[916.076178] Starting subtest: mei_interface
[916.091306] Subtest mei_interface: SKIP (0.006s)
[916.284072] [140/142] (109s left) kms_psr2_su (page_flip-xrgb8888)
[916.657626] Subtest page_flip-XRGB8888: SKIP (0.000s)
[916.788982] [141/142] (108s left) api_intel_bb (object-noreloc-keep-cache-simple)
[917.170394] Starting subtest: object-noreloc-keep-cache-simple
[917.184523] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.022s)
[917.369845] [142/142] (108s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[918.908533] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[922.074825] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (3.166s)
[923.505422] Closing watchdogs
Done.