[51.254871] Initializing watchdogs [51.255415] /dev/watchdog0 [51.288692] [001/142] (960s left) fbdev (eof) [51.721453] Starting subtest: eof [51.725069] Subtest eof: SUCCESS (0.001s) [51.890420] [002/142] (959s left) kms_chamelium_hpd (vga-hpd) [52.810264] Subtest vga-hpd: SKIP (0.000s) [53.681643] [003/142] (958s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs) [54.552440] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs [54.559205] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s) [55.839201] [004/142] (956s left) gem_exec_params (sol-reset-invalid) [56.232525] Starting subtest: sol-reset-invalid [56.256944] Subtest sol-reset-invalid: SUCCESS (0.022s) [57.675809] [005/142] (954s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [59.166834] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs [59.173429] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.001s) [59.636809] [006/142] (952s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs) [61.006315] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs [61.015598] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [61.828813] [007/142] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [62.345597] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [62.352101] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [62.494324] [008/142] (949s left) kms_flip (flip-vs-absolute-wf_vblank) [62.877635] Starting subtest: flip-vs-absolute-wf_vblank [62.903126] Starting dynamic subtest: A-eDP1 [72.652226] Dynamic subtest A-eDP1: SUCCESS (9.748s) [72.687651] Starting dynamic subtest: B-eDP1 [81.991722] Dynamic subtest B-eDP1: SUCCESS (9.338s) [82.025816] Starting dynamic subtest: C-eDP1 [91.348454] Dynamic subtest C-eDP1: SUCCESS (9.355s) [91.373569] Starting dynamic subtest: D-eDP1 [100.677595] Dynamic subtest D-eDP1: SUCCESS (9.327s) [100.701161] Subtest flip-vs-absolute-wf_vblank: SUCCESS (37.827s) [102.233692] [009/142] (910s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [102.754107] Starting subtest: fbc-1p-pri-indfb-multidraw [126.858573] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (24.108s) [127.110112] [010/142] (885s left) v3d/v3d_submit_csd (bad-multisync-out-sync) [127.583247] Subtest bad-multisync-out-sync: SKIP (0.000s) [127.690585] [011/142] (884s left) gem_mmap_gtt (basic-read-write-distinct) [128.053439] Subtest basic-read-write-distinct: SKIP (0.000s) [128.148884] [012/142] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [128.655724] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [128.662637] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s) [128.821709] [013/142] (883s left) gem_exec_whisper (basic-contexts-forked) [129.247807] Starting subtest: basic-contexts-forked [167.039911] Subtest basic-contexts-forked: SUCCESS (37.787s) [167.315593] [014/142] (845s left) perf (invalid-create-userspace-config) [168.232879] Starting subtest: invalid-create-userspace-config [168.240867] Subtest invalid-create-userspace-config: SUCCESS (0.010s) [168.344534] [015/142] (844s left) sw_sync (sync_multi_producer_single_consumer) [168.696529] Starting subtest: sync_multi_producer_single_consumer [169.781880] Subtest sync_multi_producer_single_consumer: SUCCESS (1.084s) [169.924541] [016/142] (842s left) dmabuf_sync_file (import-multiple-read-only) [170.455515] Starting subtest: import-multiple-read-only [170.470893] Subtest import-multiple-read-only: SUCCESS (0.020s) [170.610651] [017/142] (842s left) kms_big_fb (linear-64bpp-rotate-90) [171.190785] Starting subtest: linear-64bpp-rotate-90 [171.253853] Subtest linear-64bpp-rotate-90: SKIP (0.058s) [171.431344] [018/142] (841s left) gem_mmap_gtt (hang-user) [171.810690] Subtest hang-user: SKIP (0.000s) [171.915856] [019/142] (841s left) gem_fenced_exec_thrash (no-spare-fences) [172.315604] Subtest no-spare-fences: SKIP (0.000s) [172.423236] [020/142] (840s left) v3d/v3d_get_param (get-bad-flags) [172.901953] Subtest get-bad-flags: SKIP (0.000s) [173.014608] [021/142] (840s left) gem_exec_balancer (bonded-dual) [173.450509] Starting subtest: bonded-dual [173.457322] Subtest bonded-dual: SKIP (0.001s) [174.445230] [022/142] (838s left) api_intel_bb (blit-reloc-purge-cache) [174.834119] Starting subtest: blit-reloc-purge-cache [174.840632] Subtest blit-reloc-purge-cache: SKIP (0.003s) [175.025812] [023/142] (838s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [176.436295] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [176.442424] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [177.445182] [024/142] (835s left) gem_spin_batch (user-each) [177.869882] Starting subtest: user-each [181.327055] Subtest user-each: SUCCESS (3.456s) [181.647077] [025/142] (831s left) syncobj_wait (multi-wait-all-for-submit-signaled) [182.025071] Starting subtest: multi-wait-all-for-submit-signaled [182.028425] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s) [182.192685] [026/142] (831s left) kms_flip (dpms-vs-vblank-race) [182.596522] Starting subtest: dpms-vs-vblank-race [182.625099] Starting dynamic subtest: A-eDP1 [187.422130] Dynamic subtest A-eDP1: SUCCESS (4.797s) [187.455422] Starting dynamic subtest: B-eDP1 [191.435740] Dynamic subtest B-eDP1: SUCCESS (4.010s) [191.465515] Starting dynamic subtest: C-eDP1 [195.252238] Dynamic subtest C-eDP1: SUCCESS (3.813s) [195.295369] Starting dynamic subtest: D-eDP1 [199.058068] Dynamic subtest D-eDP1: SUCCESS (3.804s) [199.066703] Subtest dpms-vs-vblank-race: SUCCESS (16.473s) [200.025853] [027/142] (813s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [200.501873] Starting subtest: primary-yf-tiled-reflect-x-270 [200.512375] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.006s) [200.642561] [028/142] (813s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [202.141324] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [202.157550] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.013s) [202.979603] [029/142] (810s left) i915_suspend (fence-restore-untiled) [203.360095] Starting subtest: fence-restore-untiled [203.367490] Subtest fence-restore-untiled: SKIP (0.000s) [203.504529] [030/142] (810s left) gem_exec_flush (basic-wb-pro-default) [203.929170] Starting subtest: basic-wb-pro-default [209.806854] Subtest basic-wb-pro-default: SUCCESS (5.877s) [210.103509] [031/142] (803s left) vc4/vc4_mmap (mmap-bo) [210.594111] Subtest mmap-bo: SKIP (0.000s) [210.713137] [032/142] (803s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [211.130472] Starting subtest: yf-tiled-ccs-to-x-tiled [211.136462] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [211.417655] [033/142] (802s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [211.928147] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [211.937723] Starting dynamic subtest: pipe-A-eDP-1 [214.156608] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.223s) [214.192277] Starting dynamic subtest: pipe-B-eDP-1 [217.558415] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.392s) [217.603701] Starting dynamic subtest: pipe-C-eDP-1 [221.061489] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.496s) [221.106730] Starting dynamic subtest: pipe-D-eDP-1 [224.479544] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.409s) [224.482746] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (12.555s) [226.022739] [034/142] (788s left) gem_render_tiled_blits (basic) [226.401791] Subtest basic: SKIP (0.000s) [226.526460] [035/142] (787s left) kms_addfb_basic (unused-pitches) [226.903991] Starting subtest: unused-pitches [226.907497] Subtest unused-pitches: SUCCESS (0.000s) [227.175300] [036/142] (787s left) kms_prop_blob (blob-prop-core) [227.554480] Starting subtest: blob-prop-core [227.559573] Subtest blob-prop-core: SUCCESS (0.000s) [227.686473] [037/142] (786s left) kms_vblank (pipe-b-wait-busy-hang) [228.167815] Starting subtest: pipe-B-wait-busy-hang [243.832823] Subtest pipe-B-wait-busy-hang: SUCCESS (15.664s) [244.779208] [038/142] (769s left) i915_pm_rpm (fences) [250.886106] Starting subtest: fences [250.894111] Subtest fences: SKIP (0.000s) [251.783098] [039/142] (762s left) gem_blits (basic) [252.186975] Starting subtest: basic [264.152304] Subtest basic: SUCCESS (11.963s) [264.353927] [040/142] (750s left) prime_busy (after) [264.748146] Starting subtest: after [264.779466] Starting dynamic subtest: rcs0 [264.801711] Dynamic subtest rcs0: SUCCESS (0.023s) [264.841682] Starting dynamic subtest: bcs0 [264.850867] Dynamic subtest bcs0: SUCCESS (0.045s) [264.890497] Starting dynamic subtest: vcs0 [264.899341] Dynamic subtest vcs0: SUCCESS (0.043s) [264.939278] Starting dynamic subtest: vcs1 [264.942853] Dynamic subtest vcs1: SUCCESS (0.028s) [264.981645] Starting dynamic subtest: vecs0 [264.985325] Dynamic subtest vecs0: SUCCESS (0.028s) [265.022734] Starting dynamic subtest: ccs0 [265.025820] Dynamic subtest ccs0: SUCCESS (0.029s) [265.117314] Subtest after: SUCCESS (0.370s) [265.295097] [041/142] (749s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a) [265.794831] Starting subtest: universal-plane-pageflip-windowed-pipe-A [266.734386] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.943s) [267.681922] [042/142] (747s left) kms_psr (psr2_primary_blt) [268.170948] Starting subtest: psr2_primary_blt [271.534866] Subtest psr2_primary_blt: SUCCESS (3.361s) [272.478958] [043/142] (742s left) vc4/vc4_wait_bo (unused-bo-1ns) [272.968606] Subtest unused-bo-1ns: SKIP (0.000s) [273.094326] [044/142] (741s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [273.624655] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [273.631721] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [273.798876] [045/142] (741s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [274.281996] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [274.293804] Starting dynamic subtest: pipe-A-default-mode [274.700367] Dynamic subtest pipe-A-default-mode: SKIP (0.401s) [274.708470] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.415s) [275.634186] [046/142] (739s left) kms_invalid_mode (bad-vsync-end) [276.132385] Starting subtest: bad-vsync-end [276.135420] Starting dynamic subtest: eDP-1-pipe-A [276.563173] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.425s) [276.609882] Starting dynamic subtest: eDP-1-pipe-B [276.613785] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.039s) [276.653207] Starting dynamic subtest: eDP-1-pipe-C [276.656882] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.039s) [276.708760] Starting dynamic subtest: eDP-1-pipe-D [276.712541] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.039s) [276.716120] Subtest bad-vsync-end: SUCCESS (0.576s) [277.479110] [047/142] (737s left) syncobj_timeline (wait-all-snapshot) [277.856340] Starting subtest: wait-all-snapshot [277.935868] Subtest wait-all-snapshot: SUCCESS (0.084s) [278.077922] [048/142] (737s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm) [278.548645] Starting subtest: pipe-A-ts-continuation-dpms-rpm [281.385182] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (2.837s) [282.342166] [049/142] (733s left) sysfs_timeslice_duration (invalid) [282.745820] Starting subtest: invalid [282.754522] Starting dynamic subtest: vecs0 [282.757861] Dynamic subtest vecs0: SUCCESS (0.002s) [282.796629] Starting dynamic subtest: ccs0 [282.799695] Dynamic subtest ccs0: SUCCESS (0.002s) [282.837465] Starting dynamic subtest: vcs0 [282.841160] Dynamic subtest vcs0: SUCCESS (0.002s) [282.878833] Starting dynamic subtest: bcs0 [282.882611] Dynamic subtest bcs0: SUCCESS (0.002s) [282.919987] Starting dynamic subtest: rcs0 [282.923690] Dynamic subtest rcs0: SUCCESS (0.002s) [282.961088] Starting dynamic subtest: vcs1 [282.964732] Dynamic subtest vcs1: SUCCESS (0.002s) [282.968270] Subtest invalid: SUCCESS (0.037s) [283.023687] [050/142] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [283.528143] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [283.534699] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [283.698509] [051/142] (731s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [285.422866] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc [285.432031] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [286.111675] [052/142] (729s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs) [287.880235] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs [287.895347] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.013s) [288.471374] [053/142] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [288.980944] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [302.173439] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (13.199s) [302.444246] [054/142] (713s left) gem_ctx_bad_destroy (double-destroy) [302.817483] Starting subtest: double-destroy [302.820959] Subtest double-destroy: SUCCESS (0.000s) [302.954141] [055/142] (712s left) debugfs_test (sysfs) [303.346835] Starting subtest: sysfs [304.990306] Subtest sysfs: SUCCESS (1.638s) [305.182112] [056/142] (710s left) gem_exec_reloc (basic-cpu-gtt-active) [305.582289] Subtest basic-cpu-gtt-active: SKIP (0.000s) [305.706958] [057/142] (710s left) kms_color (legacy-gamma-reset) [306.193119] Starting subtest: legacy-gamma-reset [306.196664] Starting dynamic subtest: pipe-A [308.445737] Dynamic subtest pipe-A: SUCCESS (2.250s) [308.487725] Starting dynamic subtest: pipe-B [310.352643] Dynamic subtest pipe-B: SUCCESS (1.903s) [310.393960] Starting dynamic subtest: pipe-C [312.245899] Dynamic subtest pipe-C: SUCCESS (1.889s) [312.287658] Starting dynamic subtest: pipe-D [313.508363] Dynamic subtest pipe-D: SUCCESS (1.258s) [313.510826] Subtest legacy-gamma-reset: SUCCESS (7.315s) [313.971183] [058/142] (702s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [314.454274] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [314.460300] Starting dynamic subtest: pipe-A-default-mode [314.879874] Dynamic subtest pipe-A-default-mode: SKIP (0.416s) [314.886935] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.429s) [315.809245] [059/142] (700s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [316.326937] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [316.333426] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [316.492689] [060/142] (699s left) perf_pmu (faulting-read) [316.890405] Starting subtest: faulting-read [316.894121] Starting dynamic subtest: gtt [316.900830] Dynamic subtest gtt: SKIP (0.000s) [316.941805] Starting dynamic subtest: wb [316.945881] Dynamic subtest wb: SUCCESS (0.005s) [316.986236] Starting dynamic subtest: wc [316.989988] Dynamic subtest wc: SUCCESS (0.002s) [317.027457] Starting dynamic subtest: uc [317.030994] Dynamic subtest uc: SUCCESS (0.002s) [317.034532] Subtest faulting-read: SUCCESS (0.027s) [317.095579] [061/142] (699s left) gem_mmap_gtt (hang) [317.459122] Subtest hang: SKIP (0.000s) [317.566347] [062/142] (698s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [317.964907] Subtest writes-after-reads-snoop: SKIP (0.000s) [318.111336] [063/142] (698s left) gem_exec_capture (userptr) [318.516161] Starting subtest: userptr [320.071882] Subtest userptr: SUCCESS (1.557s) [320.245194] [064/142] (696s left) kms_fence_pin_leak [320.761574] [065/142] (695s left) kms_big_fb (x-tiled-addfb) [321.308245] Starting subtest: x-tiled-addfb [321.311950] Subtest x-tiled-addfb: SUCCESS (0.003s) [321.482349] [066/142] (695s left) gem_ctx_persistence (engines-cleanup) [321.876490] Starting subtest: engines-cleanup [321.880320] Starting dynamic subtest: rcs0 [321.941500] Dynamic subtest rcs0: SUCCESS (0.063s) [321.994526] Starting dynamic subtest: bcs0 [321.997761] Dynamic subtest bcs0: SUCCESS (0.029s) [322.038419] Starting dynamic subtest: vcs0 [322.042311] Dynamic subtest vcs0: SUCCESS (0.054s) [322.082768] Starting dynamic subtest: vcs1 [322.101712] Dynamic subtest vcs1: SUCCESS (0.064s) [322.144382] Starting dynamic subtest: vecs0 [322.147382] Dynamic subtest vecs0: SUCCESS (0.027s) [322.187986] Starting dynamic subtest: ccs0 [322.191776] Dynamic subtest ccs0: SUCCESS (0.042s) [322.194725] Subtest engines-cleanup: SUCCESS (0.304s) [322.360765] [067/142] (694s left) kms_atomic (plane-immutable-zpos) [323.141306] Starting subtest: plane-immutable-zpos [323.904620] Subtest plane-immutable-zpos: SUCCESS (0.762s) [325.333380] [068/142] (691s left) gem_exec_reloc (basic-cpu-noreloc) [325.719936] Subtest basic-cpu-noreloc: SKIP (0.000s) [325.858257] [069/142] (691s left) kms_frontbuffer_tracking (basic) [326.366480] Starting subtest: basic [341.012592] Subtest basic: SUCCESS (14.653s) [341.199901] [070/142] (675s left) i915_pm_rps (thresholds-park) [341.593478] Starting subtest: thresholds-park [341.597127] Starting dynamic subtest: gt0 [341.609836] Dynamic subtest gt0: SKIP (0.011s) [341.651749] Starting dynamic subtest: gt1 [341.658102] Dynamic subtest gt1: SKIP (0.002s) [341.664140] Subtest thresholds-park: SKIP (0.023s) [341.773841] [071/142] (675s left) syncobj_wait (invalid-reset-one-illegal-handle) [342.153708] Starting subtest: invalid-reset-one-illegal-handle [342.157323] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s) [342.316716] [072/142] (674s left) kms_cursor_crc (cursor-onscreen-32x32) [342.934366] Starting subtest: cursor-onscreen-32x32 [343.249522] Subtest cursor-onscreen-32x32: SKIP (0.307s) [344.169923] [073/142] (673s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [344.680206] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [344.687233] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [344.848157] [074/142] (672s left) gem_mmap_offset (pf-nonblock) [345.215383] Starting subtest: pf-nonblock [345.240255] Subtest pf-nonblock: SUCCESS (0.025s) [345.426186] [075/142] (672s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [345.919705] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [345.923336] Starting dynamic subtest: pipe-A-eDP-1 [346.055483] Dynamic subtest pipe-A-eDP-1: SKIP (0.124s) [346.095666] Starting dynamic subtest: pipe-B-eDP-1 [346.292467] Dynamic subtest pipe-B-eDP-1: SKIP (0.230s) [346.338512] Starting dynamic subtest: pipe-C-eDP-1 [346.528795] Dynamic subtest pipe-C-eDP-1: SKIP (0.225s) [346.573933] Starting dynamic subtest: pipe-D-eDP-1 [346.765411] Dynamic subtest pipe-D-eDP-1: SKIP (0.223s) [346.772202] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.845s) [346.932696] [076/142] (670s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [347.351574] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [347.385739] Starting dynamic subtest: A-eDP1 [351.924923] Dynamic subtest A-eDP1: SUCCESS (4.539s) [351.966471] Starting dynamic subtest: B-eDP1 [355.474530] Dynamic subtest B-eDP1: SUCCESS (3.536s) [355.520282] Starting dynamic subtest: C-eDP1 [359.092888] Dynamic subtest C-eDP1: SUCCESS (3.619s) [359.127954] Starting dynamic subtest: D-eDP1 [362.674827] Dynamic subtest D-eDP1: SUCCESS (3.576s) [362.685183] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (15.330s) [363.606119] [077/142] (654s left) gem_exec_schedule (preempt-queue-contexts-chain) [364.054535] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [364.474478] [078/142] (653s left) gem_ctx_isolation (preservation-s3) [364.914321] Starting subtest: preservation-S3 [364.918210] Starting dynamic subtest: rcs0 [382.452530] Dynamic subtest rcs0: SUCCESS (17.535s) [382.488698] Starting dynamic subtest: bcs0 [399.406728] Dynamic subtest bcs0: SUCCESS (16.951s) [399.450814] Starting dynamic subtest: vcs0 [416.371111] Dynamic subtest vcs0: SUCCESS (16.959s) [416.409147] Starting dynamic subtest: vcs1 [434.347791] Dynamic subtest vcs1: SUCCESS (17.973s) [434.370853] Starting dynamic subtest: vecs0 [452.408309] Dynamic subtest vecs0: SUCCESS (18.057s) [452.450358] Starting dynamic subtest: ccs0 [470.432280] Dynamic subtest ccs0: SUCCESS (18.020s) [470.436082] Subtest preservation-S3: SUCCESS (105.519s) [470.774638] [079/142] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [471.288590] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [471.295931] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [471.443529] [080/142] (546s left) kms_getfb (getfb2-handle-zero) [471.822670] Starting subtest: getfb2-handle-zero [471.826451] Subtest getfb2-handle-zero: SUCCESS (0.000s) [471.998509] [081/142] (546s left) kms_addfb_basic (basic) [472.385788] Starting subtest: basic [472.389529] Subtest basic: SUCCESS (0.000s) [472.673499] [082/142] (545s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs) [473.922326] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs [473.925121] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SUCCESS (0.001s) [474.983360] [083/142] (543s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [477.901376] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [478.077098] [084/142] (540s left) gem_exec_reloc (basic-range) [478.482588] Subtest basic-range: SKIP (0.000s) [478.637996] [085/142] (539s left) prime_self_import (basic-llseek-bad) [479.010444] Starting subtest: basic-llseek-bad [479.027750] Subtest basic-llseek-bad: SUCCESS (0.011s) [479.216404] [086/142] (539s left) kms_busy (basic-hang) [479.718186] Starting subtest: basic-hang [479.726366] Starting dynamic subtest: flip-pipe-A [481.059260] Dynamic subtest flip-pipe-A: SUCCESS (1.331s) [481.096749] Starting dynamic subtest: modeset-pipe-A [485.731327] Dynamic subtest modeset-pipe-A: SUCCESS (4.671s) [485.796464] Starting dynamic subtest: flip-pipe-D [488.217813] Dynamic subtest flip-pipe-D: SUCCESS (2.464s) [488.265466] Starting dynamic subtest: modeset-pipe-D [493.295696] Dynamic subtest modeset-pipe-D: SUCCESS (5.073s) [493.299864] Subtest basic-hang: SUCCESS (13.581s) [494.255295] [087/142] (524s left) gem_exec_fence (syncobj-timeline-chain-engines) [496.304081] Starting subtest: syncobj-timeline-chain-engines [496.626932] Subtest syncobj-timeline-chain-engines: SUCCESS (0.322s) [498.712717] [088/142] (519s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [499.268634] Starting subtest: yf-tiled-16bpp-rotate-90 [499.275807] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [499.429485] [089/142] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [499.932319] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [514.676839] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (14.748s) [514.930250] [090/142] (503s left) kms_psr (dpms) [515.410125] Starting subtest: dpms [519.898166] Subtest dpms: SUCCESS (4.482s) [520.854596] [091/142] (498s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [521.396291] Starting subtest: y-tiled-addfb-size-offset-overflow [521.403303] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [521.575399] [092/142] (497s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [522.080604] Starting subtest: fbc-rgb101010-draw-render [527.517690] Subtest fbc-rgb101010-draw-render: SUCCESS (5.442s) [527.783413] [093/142] (491s left) i915_hangman (gt-engine-error) [528.218400] Starting subtest: gt-engine-error [528.222140] Starting dynamic subtest: rcs0 [529.513274] Dynamic subtest rcs0: SUCCESS (1.296s) [529.569516] Starting dynamic subtest: bcs0 [532.521590] Dynamic subtest bcs0: SUCCESS (3.003s) [532.571821] Starting dynamic subtest: vcs0 [543.138830] Dynamic subtest vcs0: FAIL (10.518s) [543.192995] Starting dynamic subtest: vcs1 [544.490132] Dynamic subtest vcs1: SUCCESS (1.439s) [544.543244] Starting dynamic subtest: vecs0 [546.472464] Dynamic subtest vecs0: SUCCESS (1.979s) [546.523752] Starting dynamic subtest: ccs0 [548.456873] Dynamic subtest ccs0: SUCCESS (1.980s) [548.460159] Subtest gt-engine-error: FAIL (20.245s) [548.709493] [094/142] (470s left) gem_pread (uncached) [549.092605] Subtest uncached: SKIP (0.000s) [549.242460] [095/142] (470s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done) [549.734451] Subtest poll-read-waits-until-write-done: SKIP (0.000s) [549.890700] [096/142] (469s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [550.307911] Starting subtest: y-tiled-to-vebox-x-tiled [550.313975] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [550.602403] [097/142] (468s left) gem_workarounds (basic-read-context) [551.061959] Starting subtest: basic-read-context [551.124770] Subtest basic-read-context: SUCCESS (0.064s) [551.335576] [098/142] (468s left) gem_ctx_shared (detached-shared-gtt) [551.763818] Starting subtest: detached-shared-gtt [553.921396] Subtest detached-shared-gtt: SUCCESS (2.155s) [554.365279] [099/142] (465s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [554.751629] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [554.854175] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [555.049595] [100/142] (464s left) syncobj_timeline (etime-single-wait-submitted) [555.437830] Starting subtest: etime-single-wait-submitted [555.542818] Subtest etime-single-wait-submitted: SUCCESS (0.106s) [555.726409] [101/142] (464s left) kms_cursor_edge_walk (128x128-top-edge) [556.219228] Starting subtest: 128x128-top-edge [556.228322] Starting dynamic subtest: pipe-A-eDP-1 [560.149434] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.918s) [560.209744] Starting dynamic subtest: pipe-D-eDP-1 [563.597881] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.440s) [563.601720] Subtest 128x128-top-edge: SUCCESS (7.380s) [564.554445] [102/142] (455s left) kms_addfb_basic (size-max) [565.046886] Starting subtest: size-max [565.050610] Subtest size-max: SUCCESS (0.000s) [565.225746] [103/142] (454s left) gen7_exec_parse (basic-offset) [565.631632] Subtest basic-offset: SKIP (0.000s) [565.761316] [104/142] (454s left) kms_chamelium_frames (hdmi-crc-single) [566.666810] Subtest hdmi-crc-single: SKIP (0.000s) [567.534397] [105/142] (452s left) kms_dp_aux_dev [568.168995] [106/142] (452s left) i915_pm_rpm (modeset-non-lpsp-stress) [570.773302] Starting subtest: modeset-non-lpsp-stress [574.331043] Subtest modeset-non-lpsp-stress: SKIP (3.555s) [575.292432] [107/142] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [575.794516] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [590.476387] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SUCCESS (14.689s) [590.767131] [108/142] (429s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_mc_ccs) [592.369294] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_mc_ccs [592.375534] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s) [593.144582] [109/142] (427s left) kms_vblank (pipe-a-wait-forked-busy) [593.632160] Starting subtest: pipe-A-wait-forked-busy [596.173180] Subtest pipe-A-wait-forked-busy: SUCCESS (2.541s) [597.130586] [110/142] (423s left) kms_lease (lease-uevent) [597.612597] Starting subtest: lease-uevent [598.656744] Subtest lease-uevent: SUCCESS (1.046s) [598.813517] [111/142] (422s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs) [599.792278] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs [601.000487] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (1.209s) [602.792903] [112/142] (418s left) kms_vblank (pipe-a-ts-continuation-modeset) [603.273602] Starting subtest: pipe-A-ts-continuation-modeset [605.189787] Subtest pipe-A-ts-continuation-modeset: SUCCESS (1.919s) [606.148761] [113/142] (414s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [606.662588] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [606.669092] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [606.851101] [114/142] (414s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [607.352448] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [607.359510] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [607.536462] [115/142] (413s left) syncobj_timeline (multi-wait-all-available-submitted) [607.914052] Starting subtest: multi-wait-all-available-submitted [607.917626] Subtest multi-wait-all-available-submitted: SUCCESS (0.003s) [608.078676] [116/142] (413s left) syncobj_timeline (invalid-query-illegal-handle) [608.454576] Starting subtest: invalid-query-illegal-handle [608.458258] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [608.610510] [117/142] (412s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [609.118877] Starting subtest: psr-indfb-scaledprimary [616.581041] Subtest psr-indfb-scaledprimary: SUCCESS (7.463s) [616.834969] [118/142] (404s left) prime_vgem (busy) [617.267549] Starting subtest: busy [617.271529] Starting dynamic subtest: rcs0 [617.334872] Dynamic subtest rcs0: SUCCESS (0.066s) [617.407954] Starting dynamic subtest: bcs0 [617.411846] Dynamic subtest bcs0: SUCCESS (0.058s) [617.496896] Starting dynamic subtest: vcs0 [617.500438] Dynamic subtest vcs0: SUCCESS (0.059s) [617.567239] Starting dynamic subtest: vcs1 [617.570748] Dynamic subtest vcs1: SUCCESS (0.041s) [617.637076] Starting dynamic subtest: vecs0 [617.640165] Dynamic subtest vecs0: SUCCESS (0.043s) [617.694864] Starting dynamic subtest: ccs0 [617.698950] Dynamic subtest ccs0: SUCCESS (0.050s) [617.703091] Subtest busy: SUCCESS (0.335s) [617.810489] [119/142] (403s left) kms_scaling_modes (scaling-mode-full) [618.299612] Starting subtest: scaling-mode-full [618.303433] Starting dynamic subtest: eDP-1-pipe-A [618.688854] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.386s) [618.746691] Starting dynamic subtest: eDP-1-pipe-B [620.322372] Dynamic subtest eDP-1-pipe-B: SUCCESS (1.625s) [620.382810] Starting dynamic subtest: eDP-1-pipe-C [622.021718] Dynamic subtest eDP-1-pipe-C: SUCCESS (1.690s) [622.080550] Starting dynamic subtest: eDP-1-pipe-D [623.695961] Dynamic subtest eDP-1-pipe-D: SUCCESS (1.665s) [623.700303] Subtest scaling-mode-full: SUCCESS (5.403s) [625.205163] [120/142] (396s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [625.754158] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [629.060695] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (3.306s) [629.432602] [121/142] (392s left) gem_exec_schedule (implicit-read-write) [629.871334] Starting subtest: implicit-read-write [629.874481] Starting dynamic subtest: rcs0 [630.265878] Dynamic subtest rcs0: SUCCESS (0.391s) [630.324495] Starting dynamic subtest: bcs0 [630.551213] Dynamic subtest bcs0: SUCCESS (0.281s) [630.609780] Starting dynamic subtest: vcs0 [630.843624] Dynamic subtest vcs0: SUCCESS (0.289s) [630.897142] Starting dynamic subtest: vcs1 [631.127661] Dynamic subtest vcs1: SUCCESS (0.280s) [631.186153] Starting dynamic subtest: vecs0 [631.418320] Dynamic subtest vecs0: SUCCESS (0.286s) [631.470524] Starting dynamic subtest: ccs0 [631.734095] Dynamic subtest ccs0: SUCCESS (0.312s) [631.737695] Subtest implicit-read-write: SUCCESS (1.863s) [632.804860] [122/142] (389s left) i915_getparams_basic (basic-eu-total) [633.180168] Starting subtest: basic-eu-total [633.187429] Subtest basic-eu-total: SUCCESS (0.000s) [633.369894] [123/142] (388s left) kms_force_connector_basic (force-edid) [633.771236] Starting subtest: force-edid [634.149867] Subtest force-edid: SUCCESS (0.377s) [634.410123] [124/142] (387s left) gem_lmem_swapping (massive) [634.811439] Subtest massive: SKIP (0.000s) [634.945894] [125/142] (387s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs) [636.159229] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs [640.297531] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SUCCESS (4.138s) [641.905816] [126/142] (380s left) kms_plane_alpha_blend (constant-alpha-max) [642.399315] Starting subtest: constant-alpha-max [644.170396] Starting dynamic subtest: pipe-A-eDP-1 [646.436146] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.260s) [646.497378] Starting dynamic subtest: pipe-D-eDP-1 [649.253772] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.807s) [649.257473] Subtest constant-alpha-max: SUCCESS (6.856s) [650.218321] [127/142] (372s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [651.748301] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs [651.928062] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.180s) [652.855314] [128/142] (369s left) kms_vblank (pipe-d-ts-continuation-suspend) [653.338117] Starting subtest: pipe-D-ts-continuation-suspend [672.559354] Subtest pipe-D-ts-continuation-suspend: SUCCESS (19.220s) [673.520241] [129/142] (349s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs) [674.549180] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs [674.555600] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s) [675.927030] [130/142] (346s left) kms_vblank (pipe-a-query-forked-busy-hang) [676.379693] Starting subtest: pipe-A-query-forked-busy-hang [690.871976] Subtest pipe-A-query-forked-busy-hang: SUCCESS (14.488s) [691.826169] [131/142] (330s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [692.820630] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc [692.829883] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [694.266910] [132/142] (328s left) gem_exec_fair (basic-none-vip) [694.684166] Subtest basic-none-vip: SKIP (0.000s) [694.826894] [133/142] (328s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc) [696.149198] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc [696.167106] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.015s) [697.251527] [134/142] (325s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [697.834294] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [704.614167] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (6.031s) [704.704760] [135/142] (318s left) gem_exec_basic (basic) [705.100786] Starting subtest: basic [705.104370] Starting dynamic subtest: rcs0-smem [705.112652] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [705.169601] Starting dynamic subtest: bcs0-smem [705.172922] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [705.227154] Starting dynamic subtest: vcs0-smem [705.230342] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [705.284510] Starting dynamic subtest: vcs1-smem [705.287974] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [705.341087] Starting dynamic subtest: vecs0-smem [705.344520] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [705.397234] Starting dynamic subtest: ccs0-smem [705.400763] Dynamic subtest ccs0-smem: SUCCESS (0.003s) [705.404228] Subtest basic: SUCCESS (0.043s) [706.627732] [136/142] (316s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu) [707.145868] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu [721.242331] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (14.104s) [721.533607] [137/142] (301s left) kms_atomic_transition (plane-all-modeset-transition) [722.015680] Starting subtest: plane-all-modeset-transition [722.022732] Subtest plane-all-modeset-transition: SKIP (0.000s) [722.182381] [138/142] (301s left) gem_exec_schedule (u-submit-late-slice) [722.617389] Starting subtest: u-submit-late-slice [722.621556] Starting dynamic subtest: rcs0 [722.760072] Dynamic subtest rcs0: SUCCESS (0.138s) [722.819940] Starting dynamic subtest: bcs0 [722.888206] Dynamic subtest bcs0: SUCCESS (0.125s) [722.950255] Starting dynamic subtest: vcs0 [723.016082] Dynamic subtest vcs0: SUCCESS (0.123s) [723.084404] Starting dynamic subtest: vcs1 [723.149541] Dynamic subtest vcs1: SUCCESS (0.130s) [723.210341] Starting dynamic subtest: vecs0 [723.276718] Dynamic subtest vecs0: SUCCESS (0.123s) [723.335583] Starting dynamic subtest: ccs0 [723.398919] Dynamic subtest ccs0: SUCCESS (0.118s) [723.402500] Subtest u-submit-late-slice: SUCCESS (0.784s) [724.718757] [139/142] (298s left) kms_cursor_crc (cursor-rapid-movement-32x32) [725.353563] Starting subtest: cursor-rapid-movement-32x32 [725.663636] Subtest cursor-rapid-movement-32x32: SKIP (0.300s) [726.637999] [140/142] (297s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [727.147812] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [737.218646] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (10.074s) [737.511747] [141/142] (286s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt) [738.016799] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt [752.428861] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (14.417s) [752.716648] [142/142] (271s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [753.230641] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [753.237568] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [753.411484] Closing watchdogs Done.