[54.866989] Initializing watchdogs [54.867524] /dev/watchdog0 [54.902374] [001/142] (960s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [55.857746] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [55.865077] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [57.376467] [002/142] (958s left) syncobj_wait (multi-wait-submitted) [57.749675] Starting subtest: multi-wait-submitted [57.852795] Subtest multi-wait-submitted: SUCCESS (0.102s) [57.977502] [003/142] (957s left) gem_pxp (create-valid-protected-context) [60.899444] Subtest create-valid-protected-context: SKIP (0.000s) [61.050998] [004/142] (954s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [61.603588] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [64.807635] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (3.201s) [65.123342] [005/142] (950s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [65.625577] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [77.216295] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (11.596s) [77.473788] [006/142] (938s left) dumb_buffer (map-uaf) [77.853913] Starting subtest: map-uaf [77.873579] Subtest map-uaf: SUCCESS (0.022s) [78.030917] [007/142] (937s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [78.501844] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [78.512575] Starting dynamic subtest: pipe-A-default-mode [78.916701] Dynamic subtest pipe-A-default-mode: SKIP (0.402s) [78.922135] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.413s) [79.835994] [008/142] (936s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted) [80.221698] Starting subtest: invalid-multi-wait-available-unsubmitted [80.224997] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.001s) [80.347186] [009/142] (935s left) gem_bad_reloc (negative-reloc-bltcopy) [80.735066] Subtest negative-reloc-bltcopy: SKIP (0.000s) [80.844990] [010/142] (935s left) gem_exec_balancer (bonded-chain) [81.272811] Starting subtest: bonded-chain [93.987438] Subtest bonded-chain: SUCCESS (12.714s) [94.999510] [011/142] (921s left) gem_mmap_wc (write-read) [95.361505] Subtest write-read: SKIP (0.000s) [95.467605] [012/142] (920s left) kms_psr (no_drrs) [95.957272] Starting subtest: no_drrs [99.021776] Subtest no_drrs: SUCCESS (3.065s) [99.960342] [013/142] (916s left) gem_exec_schedule (preempt-other-chain) [100.393254] Starting subtest: preempt-other-chain [100.396218] Starting dynamic subtest: rcs0 [100.858807] Dynamic subtest rcs0: SUCCESS (0.464s) [100.889322] Starting dynamic subtest: bcs0 [101.315481] Dynamic subtest bcs0: SUCCESS (0.455s) [101.346316] Starting dynamic subtest: vcs0 [101.774063] Dynamic subtest vcs0: SUCCESS (0.458s) [101.803914] Starting dynamic subtest: vcs1 [102.233271] Dynamic subtest vcs1: SUCCESS (0.457s) [102.265879] Starting dynamic subtest: vecs0 [102.690802] Dynamic subtest vecs0: SUCCESS (0.458s) [102.721612] Starting dynamic subtest: ccs0 [103.222940] Dynamic subtest ccs0: SUCCESS (0.532s) [103.225751] Subtest preempt-other-chain: SUCCESS (2.829s) [103.768440] [014/142] (912s left) gem_ctx_shared (q-in-order) [104.189721] Starting subtest: Q-in-order [104.193793] Starting dynamic subtest: rcs0 [104.750852] Dynamic subtest rcs0: SUCCESS (0.559s) [104.799510] Starting dynamic subtest: bcs0 [105.093343] Dynamic subtest bcs0: SUCCESS (0.342s) [105.143622] Starting dynamic subtest: vcs0 [105.364904] Dynamic subtest vcs0: SUCCESS (0.271s) [105.410184] Starting dynamic subtest: vcs1 [105.616663] Dynamic subtest vcs1: SUCCESS (0.250s) [105.659419] Starting dynamic subtest: vecs0 [105.867085] Dynamic subtest vecs0: SUCCESS (0.249s) [105.919551] Starting dynamic subtest: ccs0 [106.218323] Dynamic subtest ccs0: SUCCESS (0.350s) [106.222425] Subtest Q-in-order: SUCCESS (2.028s) [107.741134] [015/142] (908s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs) [109.435106] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs [109.441191] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.002s) [110.140713] [016/142] (906s left) gem_exec_whisper (basic-contexts-priority-all) [110.566065] Starting subtest: basic-contexts-priority-all [230.639936] Subtest basic-contexts-priority-all: SUCCESS (120.069s) [230.907109] Per-test timeout exceeded. Killing the current test with SIGQUIT. [231.638706] Closing watchdogs [231.655682] Initializing watchdogs [231.656519] /dev/watchdog0 [231.702686] [017/142] (785s left) vc4/vc4_tiling (set-bad-handle) [232.208863] Subtest set-bad-handle: SKIP (0.000s) [232.341770] [018/142] (784s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs) [233.436252] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs [233.439971] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.004s) [234.506090] [019/142] (782s left) drm_fdinfo (most-busy-idle-check-all) [234.904645] Starting subtest: most-busy-idle-check-all [234.908317] Starting dynamic subtest: rcs0 [234.919623] Dynamic subtest rcs0: SKIP (0.012s) [234.954304] Starting dynamic subtest: bcs0 [234.960950] Dynamic subtest bcs0: SKIP (0.002s) [234.992454] Starting dynamic subtest: vcs0 [234.998357] Dynamic subtest vcs0: SKIP (0.002s) [235.029479] Starting dynamic subtest: vcs1 [235.035072] Dynamic subtest vcs1: SKIP (0.002s) [235.069182] Starting dynamic subtest: vecs0 [235.075773] Dynamic subtest vecs0: SKIP (0.002s) [235.122174] Starting dynamic subtest: ccs0 [235.128302] Dynamic subtest ccs0: SKIP (0.002s) [235.134437] Subtest most-busy-idle-check-all: SKIP (0.031s) [235.206574] [020/142] (782s left) kms_universal_plane (universal-plane-pipe-c-sanity) [235.730936] Starting subtest: universal-plane-pipe-C-sanity [238.055842] Subtest universal-plane-pipe-C-sanity: SUCCESS (2.323s) [239.001757] [021/142] (778s left) v3d/v3d_submit_cl (bad-multisync-in-sync) [239.481374] Subtest bad-multisync-in-sync: SKIP (0.000s) [239.597257] [022/142] (778s left) gem_exec_schedule (u-fairslice-all) [240.030871] Starting subtest: u-fairslice-all [242.287960] Subtest u-fairslice-all: SUCCESS (2.254s) [243.685514] [023/142] (774s left) kms_dither (fb-8bpc-vs-panel-8bpc) [244.198811] Starting subtest: FB-8BPC-Vs-Panel-8BPC [244.202313] Starting dynamic subtest: pipe-A-eDP-1 [245.893113] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.693s) [245.896899] Subtest FB-8BPC-Vs-Panel-8BPC: SUCCESS (1.696s) [246.763237] [024/142] (771s left) prime_busy (before) [246.909468] Starting subtest: before [246.923801] Starting dynamic subtest: rcs0 [246.945555] Dynamic subtest rcs0: SUCCESS (0.022s) [246.963383] Starting dynamic subtest: bcs0 [246.987451] Dynamic subtest bcs0: SUCCESS (0.039s) [247.027206] Starting dynamic subtest: vcs0 [247.030492] Dynamic subtest vcs0: SUCCESS (0.042s) [247.070230] Starting dynamic subtest: vcs1 [247.073396] Dynamic subtest vcs1: SUCCESS (0.018s) [247.113347] Starting dynamic subtest: vecs0 [247.116345] Dynamic subtest vecs0: SUCCESS (0.020s) [247.138446] Starting dynamic subtest: ccs0 [247.141173] Dynamic subtest ccs0: SUCCESS (0.023s) [247.221466] Subtest before: SUCCESS (0.310s) [247.363612] [025/142] (770s left) kms_atomic_interruptible (legacy-cursor) [247.843756] Starting subtest: legacy-cursor [247.851961] Starting dynamic subtest: eDP-1-pipe-A [255.650727] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.797s) [255.653881] Subtest legacy-cursor: SUCCESS (7.806s) [256.595856] [026/142] (761s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs) [258.106121] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs [258.111586] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [258.967799] [027/142] (759s left) i915_suspend (sysfs-reader) [259.345124] Starting subtest: sysfs-reader [278.409887] Subtest sysfs-reader: SUCCESS (19.066s) [278.729198] [028/142] (739s left) gem_exec_params (invalid-ring2) [279.138065] Starting subtest: invalid-ring2 [279.141302] Subtest invalid-ring2: SUCCESS (0.001s) [279.302396] [029/142] (739s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [280.195111] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [281.065674] [030/142] (737s left) i915_pm_rpm (modeset-non-lpsp-stress-no-wait) [283.744131] Starting subtest: modeset-non-lpsp-stress-no-wait [284.214628] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.464s) [284.778199] [031/142] (733s left) v3d/v3d_get_param (base-params) [285.252919] Subtest base-params: SKIP (0.000s) [285.381905] [032/142] (733s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [286.563638] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc [286.569651] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s) [287.792084] [033/142] (730s left) perf (create-destroy-userspace-config) [288.722272] Starting subtest: create-destroy-userspace-config [288.835933] Subtest create-destroy-userspace-config: SUCCESS (0.114s) [288.945870] [034/142] (729s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [289.464277] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [289.470749] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [289.639168] [035/142] (729s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [290.185647] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [290.192945] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [290.355270] [036/142] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [290.869737] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [290.876924] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [291.044272] [037/142] (728s left) kms_flip (bo-too-big) [291.443358] Starting subtest: bo-too-big [291.475638] Starting dynamic subtest: A-eDP1 [294.184984] Dynamic subtest A-eDP1: SUCCESS (2.713s) [294.235141] Starting dynamic subtest: B-eDP1 [296.526381] Dynamic subtest B-eDP1: SUCCESS (2.337s) [296.569823] Starting dynamic subtest: C-eDP1 [298.842502] Dynamic subtest C-eDP1: SUCCESS (2.312s) [298.909324] Starting dynamic subtest: D-eDP1 [301.292351] Dynamic subtest D-eDP1: SUCCESS (2.445s) [301.319396] Subtest bo-too-big: SUCCESS (9.880s) [302.996744] [038/142] (716s left) i915_pm_rpm (dpms-lpsp) [305.731291] Starting subtest: dpms-lpsp [306.216954] Subtest dpms-lpsp: SUCCESS (0.483s) [306.410584] [039/142] (712s left) i915_query (query-regions-unallocated) [306.778324] Starting subtest: query-regions-unallocated [306.781839] Subtest query-regions-unallocated: SUCCESS (0.000s) [306.925686] [040/142] (712s left) kms_hdr (bpc-switch-dpms) [307.418169] Starting subtest: bpc-switch-dpms [308.681886] Starting dynamic subtest: pipe-A-eDP-1 [314.186363] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.503s) [314.190093] Subtest bpc-switch-dpms: SUCCESS (6.772s) [314.406643] [041/142] (705s left) gem_lmem_swapping (massive-random) [314.798440] Subtest massive-random: SKIP (0.000s) [314.914639] [042/142] (704s left) syncobj_wait (invalid-wait-bad-flags) [315.296429] Starting subtest: invalid-wait-bad-flags [315.299946] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [315.441155] [043/142] (704s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [315.915607] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [315.925597] Starting dynamic subtest: pipe-A-eDP-1 [315.963919] Dynamic subtest pipe-A-eDP-1: SKIP (0.038s) [316.020244] Starting dynamic subtest: pipe-B-eDP-1 [316.122500] Dynamic subtest pipe-B-eDP-1: SKIP (0.144s) [316.169313] Starting dynamic subtest: pipe-C-eDP-1 [316.277966] Dynamic subtest pipe-C-eDP-1: SKIP (0.147s) [316.334696] Starting dynamic subtest: pipe-D-eDP-1 [316.430320] Dynamic subtest pipe-D-eDP-1: SKIP (0.143s) [316.437411] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.516s) [316.612753] [044/142] (703s left) kms_busy (extended-pageflip-hang-newfb) [317.107598] Starting subtest: extended-pageflip-hang-newfb [317.116286] Starting dynamic subtest: pipe-A [331.939320] Dynamic subtest pipe-A: SUCCESS (14.816s) [332.011918] Starting dynamic subtest: pipe-D [346.956832] Dynamic subtest pipe-D: SUCCESS (14.998s) [346.960955] Subtest extended-pageflip-hang-newfb: SUCCESS (29.852s) [347.917550] [045/142] (671s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [348.291087] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [348.294581] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [348.442582] [046/142] (671s left) gem_userptr_blits (unsync-unmap) [348.842964] Subtest unsync-unmap: SKIP (0.000s) [349.121688] [047/142] (670s left) kms_addfb_basic (bad-pitch-63) [349.493191] Starting subtest: bad-pitch-63 [349.496591] Subtest bad-pitch-63: SUCCESS (0.000s) [349.783237] [048/142] (670s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs) [351.173192] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs [354.224859] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (3.051s) [355.633631] [049/142] (664s left) syncobj_timeline (single-wait-signaled) [356.004470] Starting subtest: single-wait-signaled [356.008118] Subtest single-wait-signaled: SUCCESS (0.003s) [356.150366] [050/142] (664s left) core_auth (getclient-master-drop) [356.505775] Starting subtest: getclient-master-drop [356.519586] Subtest getclient-master-drop: SUCCESS (0.012s) [356.662296] [051/142] (663s left) i915_fb_tiling [357.162282] [052/142] (663s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs) [358.786340] Starting subtest: pipe-D-bad-rotation-90-yf_tiled_ccs [358.792725] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [359.574819] [053/142] (660s left) gen7_exec_parse (oacontrol-tracking) [359.971989] Subtest oacontrol-tracking: SKIP (0.000s) [360.088969] [054/142] (660s left) gem_mmap_wc (pf-nonblock) [360.459733] Subtest pf-nonblock: SKIP (0.000s) [360.583218] [055/142] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [361.088071] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [361.094900] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [361.257605] [056/142] (659s left) gem_userptr_blits (vma-merge) [361.763615] Starting subtest: vma-merge [382.549331] Subtest vma-merge: FAIL (20.735s) [382.685494] [057/142] (638s left) gem_mmap_wc (write) [383.077309] Subtest write: SKIP (0.000s) [383.215231] [058/142] (637s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs) [384.446309] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs [385.654980] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (1.209s) [387.210325] [059/142] (633s left) gem_ctx_param (invalid-size-get) [387.595901] Starting subtest: invalid-size-get [387.599543] Subtest invalid-size-get: SUCCESS (0.001s) [387.746629] [060/142] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [388.269283] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [388.276131] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [388.436174] [061/142] (632s left) kms_cursor_crc (cursor-onscreen-256x256) [389.465281] Starting subtest: cursor-onscreen-256x256 [389.499236] Starting dynamic subtest: pipe-A-eDP-1 [393.493757] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.995s) [393.696460] Starting dynamic subtest: pipe-D-eDP-1 [398.695174] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.046s) [398.699056] Subtest cursor-onscreen-256x256: SUCCESS (9.229s) [399.657259] [062/142] (621s left) gem_exec_fair (basic-pace-solo) [400.059855] Subtest basic-pace-solo: SKIP (0.000s) [400.200765] [063/142] (621s left) gem_exec_fence (nb-await) [400.791908] Starting subtest: nb-await [400.795578] Starting dynamic subtest: rcs0 [400.902417] Dynamic subtest rcs0: SUCCESS (0.108s) [400.954161] Starting dynamic subtest: bcs0 [400.991368] Dynamic subtest bcs0: SUCCESS (0.085s) [401.044674] Starting dynamic subtest: vcs0 [401.084155] Dynamic subtest vcs0: SUCCESS (0.089s) [401.138804] Starting dynamic subtest: vcs1 [401.173784] Dynamic subtest vcs1: SUCCESS (0.085s) [401.222302] Starting dynamic subtest: vecs0 [401.260819] Dynamic subtest vecs0: SUCCESS (0.083s) [401.312386] Starting dynamic subtest: ccs0 [401.348573] Dynamic subtest ccs0: SUCCESS (0.084s) [401.352165] Subtest nb-await: SUCCESS (0.560s) [403.737576] [064/142] (617s left) gem_softpin (noreloc) [404.141720] Starting subtest: noreloc [410.001096] Subtest noreloc: SUCCESS (5.857s) [410.231746] [065/142] (611s left) sysfs_heartbeat_interval (idempotent) [410.643918] Starting subtest: idempotent [410.647373] Starting dynamic subtest: vecs0 [410.650793] Dynamic subtest vecs0: SUCCESS (0.005s) [410.700697] Starting dynamic subtest: ccs0 [410.704972] Dynamic subtest ccs0: SUCCESS (0.010s) [410.760633] Starting dynamic subtest: vcs0 [410.764284] Dynamic subtest vcs0: SUCCESS (0.005s) [410.811181] Starting dynamic subtest: bcs0 [410.814396] Dynamic subtest bcs0: SUCCESS (0.009s) [410.859440] Starting dynamic subtest: rcs0 [410.862441] Dynamic subtest rcs0: SUCCESS (0.007s) [410.906922] Starting dynamic subtest: vcs1 [410.910154] Dynamic subtest vcs1: SUCCESS (0.005s) [410.913138] Subtest idempotent: SUCCESS (0.069s) [410.982905] [066/142] (610s left) i915_hwmon (hwmon-read) [411.351423] Subtest hwmon-read: SKIP (0.000s) [411.490725] [067/142] (610s left) v3d/v3d_wait_bo (bad-pad) [411.988115] Subtest bad-pad: SKIP (0.000s) [412.133233] [068/142] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [412.667170] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [412.674331] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [412.833154] [069/142] (609s left) kms_psr (psr2_no_drrs) [413.324226] Starting subtest: psr2_no_drrs [416.585274] Subtest psr2_no_drrs: SUCCESS (3.259s) [417.545649] [070/142] (604s left) gen3_render_tiledx_blits [418.040166] [071/142] (604s left) syncobj_timeline (invalid-signal-one-illegal-handle) [418.411294] Starting subtest: invalid-signal-one-illegal-handle [418.414400] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s) [418.559894] [072/142] (603s left) gem_exec_capture (capture-invisible) [418.953147] Starting subtest: capture-invisible [418.956364] Starting dynamic subtest: smem0 [418.962461] Dynamic subtest smem0: SKIP (0.000s) [418.968757] Subtest capture-invisible: SKIP (0.005s) [419.135453] [073/142] (603s left) kms_lease (lease_invalid_crtc) [419.629409] Starting subtest: lease_invalid_crtc [419.633151] Starting dynamic subtest: pipe-A-eDP-1 [419.636119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [419.689186] Starting dynamic subtest: pipe-B-eDP-1 [419.692241] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [419.739760] Starting dynamic subtest: pipe-C-eDP-1 [419.742446] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [419.788486] Starting dynamic subtest: pipe-D-eDP-1 [419.791672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [419.794958] Subtest lease_invalid_crtc: SUCCESS (0.037s) [419.863472] [074/142] (602s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [420.281960] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [420.445370] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.164s) [420.617938] [075/142] (601s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [421.160720] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [424.485356] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (3.319s) [424.845475] [076/142] (597s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs) [426.157112] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs [426.173057] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.013s) [427.237308] [077/142] (595s left) gem_ctx_persistence (engines-hostile) [427.645375] Starting subtest: engines-hostile [427.648868] Starting dynamic subtest: rcs0 [427.709730] Dynamic subtest rcs0: SUCCESS (0.062s) [427.766500] Starting dynamic subtest: bcs0 [427.770342] Dynamic subtest bcs0: SUCCESS (0.045s) [427.822608] Starting dynamic subtest: vcs0 [427.826053] Dynamic subtest vcs0: SUCCESS (0.048s) [427.872715] Starting dynamic subtest: vcs1 [427.876606] Dynamic subtest vcs1: SUCCESS (0.026s) [427.927233] Starting dynamic subtest: vecs0 [427.930756] Dynamic subtest vecs0: SUCCESS (0.044s) [427.977799] Starting dynamic subtest: ccs0 [428.004186] Dynamic subtest ccs0: SUCCESS (0.108s) [428.008181] Subtest engines-hostile: SUCCESS (0.361s) [428.162907] [078/142] (594s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [428.667436] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [433.999755] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (5.341s) [434.283790] [079/142] (588s left) kms_flip (2x-absolute-wf_vblank) [434.691335] Starting subtest: 2x-absolute-wf_vblank [434.852883] Subtest 2x-absolute-wf_vblank: SKIP (0.161s) [435.027277] [080/142] (587s left) gem_ccs (block-multicopy-inplace) [435.424311] Starting subtest: block-multicopy-inplace [435.431173] Subtest block-multicopy-inplace: SKIP (0.000s) [435.567981] [081/142] (587s left) kms_psr (psr2_sprite_render) [436.040488] Starting subtest: psr2_sprite_render [439.161130] Subtest psr2_sprite_render: SUCCESS (3.121s) [440.110952] [082/142] (582s left) kms_flip (flip-vs-dpms-off-vs-modeset) [440.504909] Starting subtest: flip-vs-dpms-off-vs-modeset [440.537142] Starting dynamic subtest: A-eDP1 [445.122246] Dynamic subtest A-eDP1: SUCCESS (4.589s) [445.177676] Starting dynamic subtest: B-eDP1 [448.792346] Dynamic subtest B-eDP1: SUCCESS (3.665s) [448.839150] Starting dynamic subtest: C-eDP1 [452.419343] Dynamic subtest C-eDP1: SUCCESS (3.621s) [452.469763] Starting dynamic subtest: D-eDP1 [456.091411] Dynamic subtest D-eDP1: SUCCESS (3.667s) [456.115543] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (15.615s) [457.047756] [083/142] (566s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [457.568421] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [457.575286] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [457.744509] [084/142] (565s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [458.230798] Starting subtest: plane-all-modeset-transition-fencing [458.237649] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [458.385556] [085/142] (564s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc) [459.316453] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc [459.323256] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s) [460.749268] [086/142] (562s left) gem_eio (in-flight-suspend) [462.421601] Starting subtest: in-flight-suspend [509.250562] Subtest in-flight-suspend: SUCCESS (46.832s) [510.698575] [087/142] (512s left) kms_plane_scaling (plane-upscale-with-modifiers-factor-0-25) [511.194479] Starting subtest: plane-upscale-with-modifiers-factor-0-25 [511.198105] Starting dynamic subtest: pipe-A-eDP-1 [512.662341] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.465s) [512.723277] Starting dynamic subtest: pipe-B-eDP-1 [515.434655] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s) [515.497103] Starting dynamic subtest: pipe-C-eDP-1 [518.204248] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s) [518.264834] Starting dynamic subtest: pipe-D-eDP-1 [520.982900] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s) [520.986739] Subtest plane-upscale-with-modifiers-factor-0-25: SUCCESS (9.797s) [522.591736] [088/142] (501s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [523.122413] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [531.157290] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (8.038s) [531.421290] [089/142] (492s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs) [533.169343] Starting subtest: pipe-D-missing-ccs-buffer-yf_tiled_ccs [533.176145] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s) [533.854960] [090/142] (490s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc) [535.426374] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc [535.429931] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.001s) [536.230771] [091/142] (487s left) prime_busy (hang) [536.630084] Starting subtest: hang [536.633808] Starting dynamic subtest: rcs0 [550.166667] Dynamic subtest rcs0: SUCCESS (13.536s) [550.186420] Starting dynamic subtest: bcs0 [557.605792] Dynamic subtest bcs0: SUCCESS (7.435s) [557.658524] Starting dynamic subtest: vcs0 [572.608897] Dynamic subtest vcs0: SUCCESS (15.004s) [572.630649] Starting dynamic subtest: vcs1 [579.597654] Dynamic subtest vcs1: SUCCESS (6.980s) [579.653508] Starting dynamic subtest: vecs0 [586.532371] Dynamic subtest vecs0: SUCCESS (6.930s) [586.585938] Starting dynamic subtest: ccs0 [600.365304] Dynamic subtest ccs0: SUCCESS (13.832s) [600.369125] Subtest hang: SUCCESS (63.738s) [600.579891] [092/142] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [601.098331] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [601.104932] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s) [601.279547] [093/142] (422s left) api_intel_allocator (two-level-inception) [601.669279] Starting subtest: two-level-inception [607.282439] Subtest two-level-inception: SUCCESS (5.612s) [607.458126] [094/142] (416s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [607.838070] Starting subtest: multi-wait-for-submit-available-submitted [607.841312] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.003s) [608.014427] [095/142] (416s left) prime_self_import (basic-with_one_bo) [608.376764] Starting subtest: basic-with_one_bo [608.396309] Subtest basic-with_one_bo: SUCCESS (0.020s) [608.587485] [096/142] (415s left) sw_sync (alloc_merge_fence) [608.950277] Starting subtest: alloc_merge_fence [608.953770] Subtest alloc_merge_fence: SUCCESS (0.001s) [609.098678] [097/142] (415s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [609.610311] Starting subtest: plane-use-after-nonblocking-unbind [609.615388] Starting dynamic subtest: pipe-A-eDP-1 [609.858183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.243s) [610.270651] Starting dynamic subtest: pipe-B-eDP-1 [611.120813] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.883s) [611.487069] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.875s) [612.411445] [098/142] (412s left) kms_vblank (pipe-a-query-busy-hang) [612.693747] Starting subtest: pipe-A-query-busy-hang [626.860904] Subtest pipe-A-query-busy-hang: SUCCESS (14.170s) [627.825776] [099/142] (396s left) kms_vblank (pipe-d-wait-forked-hang) [628.306324] Starting subtest: pipe-D-wait-forked-hang [644.714283] Subtest pipe-D-wait-forked-hang: SUCCESS (16.408s) [645.663375] [100/142] (379s left) gem_exec_gttfill (multigpu-basic) [646.227785] Starting subtest: multigpu-basic [646.235789] Subtest multigpu-basic: SKIP (0.000s) [646.397434] [101/142] (378s left) gem_fence_thrash (bo-write-verify-x) [646.772073] Starting subtest: bo-write-verify-x [646.790180] Subtest bo-write-verify-x: SKIP (0.010s) [646.924642] [102/142] (378s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [647.410884] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [653.471809] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (6.062s) [653.780845] [103/142] (371s left) gem_mmap_wc (read-write) [654.155414] Subtest read-write: SKIP (0.000s) [654.285596] [104/142] (370s left) gem_render_copy (linear-to-vebox-y-tiled) [654.703147] Starting subtest: linear-to-vebox-y-tiled [654.709742] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [654.984339] [105/142] (370s left) gem_softpin (allocator-basic-reserve) [655.382353] Starting subtest: allocator-basic-reserve [655.945758] Subtest allocator-basic-reserve: SUCCESS (0.562s) [656.216392] [106/142] (369s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [656.712492] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [674.077659] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (17.373s) [674.240647] [107/142] (351s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [674.433998] Starting subtest: psr-rgb101010-draw-mmap-gtt [674.438734] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [674.535157] [108/142] (350s left) kms_chamelium_edid (hdmi-edid-read) [675.396387] Subtest hdmi-edid-read: SKIP (0.000s) [676.277554] [109/142] (349s left) api_intel_allocator (fork-simple-once) [676.649316] Starting subtest: fork-simple-once [676.726640] Subtest fork-simple-once: SUCCESS (0.082s) [676.935434] [110/142] (348s left) core_setmaster_vs_auth [677.446107] [111/142] (348s left) gem_ctx_bad_destroy (invalid-pad) [677.814648] Starting subtest: invalid-pad [677.818170] Subtest invalid-pad: SUCCESS (0.000s) [677.936444] [112/142] (347s left) vc4/vc4_purgeable_bo (mark-willneed) [678.416772] Subtest mark-willneed: SKIP (0.000s) [678.555485] [113/142] (347s left) kms_invalid_mode (int-max-clock) [679.045704] Starting subtest: int-max-clock [679.055400] Starting dynamic subtest: eDP-1-pipe-A [679.479388] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.429s) [679.538089] Starting dynamic subtest: eDP-1-pipe-B [679.541689] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.041s) [679.593852] Starting dynamic subtest: eDP-1-pipe-C [679.597876] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.041s) [679.649772] Starting dynamic subtest: eDP-1-pipe-D [679.653238] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.041s) [679.656535] Subtest int-max-clock: SUCCESS (0.589s) [680.410361] [114/142] (345s left) kms_vblank (pipe-d-query-busy-hang) [680.885202] Starting subtest: pipe-D-query-busy-hang [697.856917] Subtest pipe-D-query-busy-hang: SUCCESS (16.969s) [698.812153] [115/142] (327s left) kms_plane (plane-panning-top-left) [699.297134] Starting subtest: plane-panning-top-left [699.306792] Starting dynamic subtest: pipe-A-planes [701.648239] Dynamic subtest pipe-A-planes: SUCCESS (2.344s) [701.701057] Starting dynamic subtest: pipe-B-planes [704.462434] Dynamic subtest pipe-B-planes: SUCCESS (2.803s) [704.465938] Subtest plane-panning-top-left: SUCCESS (5.168s) [705.417411] [116/142] (320s left) kms_vblank (pipe-a-query-forked-busy) [705.897847] Starting subtest: pipe-A-query-forked-busy [708.311956] Subtest pipe-A-query-forked-busy: SUCCESS (2.414s) [709.280463] [117/142] (317s left) kms_atomic_transition (modeset-transition-fencing) [709.769574] Starting subtest: modeset-transition-fencing [709.773243] Starting dynamic subtest: 1x-outputs [741.553777] Dynamic subtest 1x-outputs: SUCCESS (31.788s) [742.065750] Subtest modeset-transition-fencing: SUCCESS (32.299s) [743.020394] [118/142] (283s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [743.551557] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [756.988164] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (13.439s) [757.277988] [119/142] (269s left) gem_ctx_create (basic-files) [757.699094] Starting subtest: basic-files [759.769817] Subtest basic-files: SUCCESS (2.070s) [761.713952] [120/142] (264s left) gem_mmap_gtt (basic-write-read-distinct) [762.107138] Subtest basic-write-read-distinct: SKIP (0.000s) [762.257777] [121/142] (264s left) kms_big_fb (linear-32bpp-rotate-270) [762.809232] Starting subtest: linear-32bpp-rotate-270 [762.863367] Subtest linear-32bpp-rotate-270: SKIP (0.052s) [763.066633] [122/142] (263s left) gem_mmap (bad-size) [763.440978] Subtest bad-size: SKIP (0.000s) [763.569892] [123/142] (263s left) kms_cursor_crc (cursor-random-64x21) [764.357607] Starting subtest: cursor-random-64x21 [764.393524] Starting dynamic subtest: pipe-A-eDP-1 [770.560520] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.166s) [770.763500] Starting dynamic subtest: pipe-D-eDP-1 [777.917413] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.205s) [777.920998] Subtest cursor-random-64x21: SUCCESS (13.558s) [779.096845] [124/142] (247s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [779.582296] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [779.590529] Starting dynamic subtest: pipe-A-default-mode [782.812284] Dynamic subtest pipe-A-default-mode: SUCCESS (3.218s) [782.815760] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (3.230s) [783.785321] [125/142] (243s left) prime_vgem (coherency-gtt) [784.224776] Starting subtest: coherency-gtt [784.231137] Subtest coherency-gtt: SKIP (0.000s) [784.383155] [126/142] (242s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [784.804045] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [784.809948] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [784.929362] [127/142] (242s left) perf (gen12-oa-tlb-invalidate) [785.187527] Starting subtest: gen12-oa-tlb-invalidate [785.191222] Starting dynamic subtest: 0-rcs0 [795.297989] Dynamic subtest 0-rcs0: SUCCESS (10.105s) [795.349772] Starting dynamic subtest: 1-vecs0 [805.348123] Dynamic subtest 1-vecs0: SUCCESS (10.047s) [805.351523] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.158s) [805.471580] [128/142] (221s left) sw_sync (sync_expired_merge) [805.848321] Starting subtest: sync_expired_merge [806.925077] Subtest sync_expired_merge: SUCCESS (1.075s) [807.105633] [129/142] (220s left) kms_chamelium_color (ctm-0-50) [807.607120] Subtest ctm-0-50: SKIP (0.000s) [807.734466] [130/142] (219s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [808.275391] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [808.282173] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [808.463177] [131/142] (219s left) kms_cursor_crc (cursor-alpha-opaque) [808.907864] Starting subtest: cursor-alpha-opaque [808.916475] Starting dynamic subtest: pipe-A-eDP-1 [810.239592] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.323s) [810.300264] Starting dynamic subtest: pipe-D-eDP-1 [812.902707] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.651s) [812.906259] Subtest cursor-alpha-opaque: SUCCESS (3.996s) [814.440431] [132/142] (213s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [815.019366] Starting subtest: cursorA-vs-flipA-toggle [826.858179] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.837s) [827.830495] [133/142] (200s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs) [829.327972] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs [829.334250] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s) [830.261215] [134/142] (197s left) kms_cursor_legacy (forked-move) [830.828580] Starting subtest: forked-move [830.832352] Starting dynamic subtest: pipe-A [836.511774] Dynamic subtest pipe-A: SUCCESS (5.679s) [836.567222] Starting dynamic subtest: pipe-B [842.615333] Dynamic subtest pipe-B: SUCCESS (6.102s) [842.659035] Starting dynamic subtest: pipe-C [848.634428] Dynamic subtest pipe-C: SUCCESS (6.015s) [848.678463] Starting dynamic subtest: pipe-D [854.621319] Dynamic subtest pipe-D: SUCCESS (5.983s) [854.667866] Starting dynamic subtest: all-pipes [860.616640] Dynamic subtest all-pipes: SUCCESS (5.991s) [860.619651] Subtest forked-move: SUCCESS (29.792s) [860.954398] [135/142] (167s left) kms_ccs (pipe-a-missing-ccs-buffer-yf_tiled_ccs) [861.961635] Starting subtest: pipe-A-missing-ccs-buffer-yf_tiled_ccs [861.967779] Subtest pipe-A-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s) [862.994806] [136/142] (165s left) gem_ctx_freq (sysfs) [863.240691] Starting subtest: sysfs [863.244213] Starting dynamic subtest: gt0 [868.816663] Dynamic subtest gt0: SUCCESS (5.574s) [868.841441] Starting dynamic subtest: gt1 [910.470771] Dynamic subtest gt1: SUCCESS (41.648s) [910.474560] Subtest sysfs: SUCCESS (47.230s) [910.611676] [137/142] (117s left) kms_plane_multiple (tiling-y) [911.096867] Starting subtest: tiling-y [911.103129] Subtest tiling-y: SKIP (0.000s) [911.257193] [138/142] (117s left) gem_exec_suspend (basic) [911.688680] Starting subtest: basic [911.691881] Starting dynamic subtest: smem [916.486482] Dynamic subtest smem: SUCCESS (4.799s) [916.490167] Subtest basic: SUCCESS (4.802s) [916.803360] [139/142] (111s left) kms_setmode (invalid-clone-single-crtc) [917.186211] Starting subtest: invalid-clone-single-crtc [917.196268] Subtest invalid-clone-single-crtc: SKIP (0.002s) [917.378642] [140/142] (111s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [917.886608] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [935.059274] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (17.176s) [935.320524] [141/142] ( 93s left) gem_exec_reloc (basic-cpu-active) [935.716677] Subtest basic-cpu-active: SKIP (0.000s) [935.876608] [142/142] ( 92s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [936.413342] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [940.331209] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (3.916s) [940.850199] Closing watchdogs Done.