[36.827445] Initializing watchdogs [36.827510] /dev/watchdog0 [36.833129] [001/142] (960s left) kms_busy (basic-hang) [38.797616] Starting subtest: basic-hang [38.800113] Starting dynamic subtest: flip-pipe-A [39.458988] Dynamic subtest flip-pipe-A: SUCCESS (0.660s) [39.463705] Starting dynamic subtest: modeset-pipe-A [40.078882] Dynamic subtest modeset-pipe-A: SUCCESS (0.619s) [40.086383] Starting dynamic subtest: flip-pipe-D [40.544552] Dynamic subtest flip-pipe-D: SUCCESS (0.462s) [40.549635] Starting dynamic subtest: modeset-pipe-D [41.098159] Dynamic subtest modeset-pipe-D: SUCCESS (0.554s) [41.098970] Subtest basic-hang: SUCCESS (2.302s) [41.223092] [002/142] (956s left) gem_partial_pwrite_pread (write-uncached) [41.274367] Subtest write-uncached: SKIP (0.000s) [41.315487] [003/142] (956s left) kms_atomic_interruptible (universal-setplane-primary) [43.270119] Starting subtest: universal-setplane-primary [43.272268] Starting dynamic subtest: HDMI-A-1-pipe-A [49.488541] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.217s) [49.489485] Subtest universal-setplane-primary: SUCCESS (6.218s) [49.589389] [004/142] (947s left) gem_mmap_gtt (basic-copy) [49.638530] Subtest basic-copy: SKIP (0.000s) [49.664709] [005/142] (947s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs) [51.712480] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs [51.714808] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s) [51.889143] [006/142] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [53.859747] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [53.861540] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [53.939658] [007/142] (943s left) kms_big_fb (y-tiled-16bpp-rotate-270) [55.978834] Starting subtest: y-tiled-16bpp-rotate-270 [57.740174] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.760s) [57.868957] [008/142] (939s left) gem_set_tiling_vs_blt (untiled-to-tiled) [57.940605] Subtest untiled-to-tiled: SKIP (0.000s) [57.961418] [009/142] (939s left) kms_plane_multiple (tiling-yf) [59.915013] Starting subtest: tiling-yf [59.916999] Subtest tiling-yf: SKIP (0.000s) [59.969137] [010/142] (937s left) gem_exec_reloc (basic-gtt-noreloc) [60.041727] Subtest basic-gtt-noreloc: SKIP (0.000s) [60.127234] [011/142] (937s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [62.123483] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [63.142356] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.019s) [63.266686] [012/142] (934s left) syncobj_wait (invalid-single-wait-unsubmitted) [63.315510] Starting subtest: invalid-single-wait-unsubmitted [63.316390] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [63.370265] [013/142] (934s left) gem_workarounds (reset-fd) [63.432847] Starting subtest: reset-fd [63.581169] Subtest reset-fd: SUCCESS (0.148s) [63.686611] [014/142] (933s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc) [65.771902] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc [66.097259] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.324s) [66.325395] [015/142] (931s left) syncobj_timeline (invalid-single-wait-available-unsubmitted) [66.374505] Starting subtest: invalid-single-wait-available-unsubmitted [66.375405] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s) [66.434355] [016/142] (931s left) syncobj_timeline (device-signal-unordered) [66.485122] Starting subtest: device-signal-unordered [66.485935] Subtest device-signal-unordered: SUCCESS (0.001s) [66.542675] [017/142] (931s left) gem_exec_balancer (bonded-true-hang) [66.836015] Starting subtest: bonded-true-hang [66.837727] Subtest bonded-true-hang: SKIP (0.000s) [66.895312] [018/142] (930s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [68.864644] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [68.866479] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [68.945118] [019/142] (928s left) perf (unprivileged-single-ctx-counters) [69.159466] Starting subtest: unprivileged-single-ctx-counters [69.161402] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [69.190797] [020/142] (928s left) gem_exec_store (pages) [69.243563] Starting subtest: pages [69.244538] Starting dynamic subtest: rcs0 [69.357963] Dynamic subtest rcs0: SUCCESS (0.114s) [69.363430] Starting dynamic subtest: bcs0 [69.452982] Dynamic subtest bcs0: SUCCESS (0.095s) [69.458624] Starting dynamic subtest: vcs0 [69.549161] Dynamic subtest vcs0: SUCCESS (0.096s) [69.554739] Starting dynamic subtest: vcs1 [69.643071] Dynamic subtest vcs1: SUCCESS (0.094s) [69.648777] Starting dynamic subtest: vecs0 [69.736217] Dynamic subtest vecs0: SUCCESS (0.093s) [69.737225] Subtest pages: SUCCESS (0.492s) [69.973511] [021/142] (927s left) syncobj_wait (signal) [70.049843] Starting subtest: signal [70.050730] Subtest signal: SUCCESS (0.000s) [70.109915] [022/142] (927s left) gem_ctx_persistence (saturated-hostile-nopreempt) [70.164267] Starting subtest: saturated-hostile-nopreempt [70.167499] Starting dynamic subtest: rcs0 [70.253515] Dynamic subtest rcs0: SUCCESS (0.089s) [70.263105] Starting dynamic subtest: bcs0 [70.335582] Dynamic subtest bcs0: SUCCESS (0.081s) [70.363924] Starting dynamic subtest: vcs0 [70.437652] Dynamic subtest vcs0: SUCCESS (0.102s) [70.451246] Starting dynamic subtest: vcs1 [70.533084] Dynamic subtest vcs1: SUCCESS (0.095s) [70.554402] Starting dynamic subtest: vecs0 [70.628531] Dynamic subtest vecs0: SUCCESS (0.095s) [70.630137] Subtest saturated-hostile-nopreempt: SUCCESS (0.464s) [70.754889] [023/142] (926s left) gem_exec_schedule (pi-shared-iova) [70.965104] Starting subtest: pi-shared-iova [70.965994] Starting dynamic subtest: rcs0 [71.116907] Dynamic subtest rcs0: SUCCESS (0.152s) [71.122744] Starting dynamic subtest: bcs0 [71.209123] Dynamic subtest bcs0: SUCCESS (0.095s) [71.214932] Starting dynamic subtest: vcs0 [71.322176] Dynamic subtest vcs0: SUCCESS (0.110s) [71.327928] Starting dynamic subtest: vcs1 [71.431841] Dynamic subtest vcs1: SUCCESS (0.111s) [71.437552] Starting dynamic subtest: vecs0 [71.541696] Dynamic subtest vecs0: SUCCESS (0.108s) [71.542800] Subtest pi-shared-iova: SUCCESS (0.577s) [71.800393] [024/142] (925s left) kms_cursor_crc (cursor-rapid-movement-128x128) [73.880230] Starting subtest: cursor-rapid-movement-128x128 [73.887142] Starting dynamic subtest: pipe-A-HDMI-A-1 [74.298296] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.412s) [74.321972] Starting dynamic subtest: pipe-D-HDMI-A-1 [74.574353] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.256s) [74.575190] Subtest cursor-rapid-movement-128x128: SUCCESS (0.693s) [74.924529] [025/142] (922s left) gem_lmem_swapping (parallel-multi) [78.628252] Starting subtest: parallel-multi [78.629059] Starting dynamic subtest: lmem0 [88.783054] Dynamic subtest lmem0: SUCCESS (10.151s) [88.783899] Subtest parallel-multi: SUCCESS (10.151s) [89.894671] [026/142] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [95.133952] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [95.135933] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [95.215668] [027/142] (902s left) kms_feature_discovery (display-3x) [97.246389] Starting subtest: display-3x [97.248189] Subtest display-3x: SKIP (0.000s) [97.315355] [028/142] (900s left) kms_vblank (pipe-d-ts-continuation-dpms-suspend) [99.307653] Starting subtest: pipe-D-ts-continuation-dpms-suspend [120.797866] Subtest pipe-D-ts-continuation-dpms-suspend: SUCCESS (9.275s) [126.916322] [029/142] (889s left) kms_flip (flip-vs-panning-interruptible) [127.934921] Starting subtest: flip-vs-panning-interruptible [127.942144] Starting dynamic subtest: A-HDMI-A1 [135.709854] Dynamic subtest A-HDMI-A1: SUCCESS (7.767s) [135.730261] Starting dynamic subtest: B-HDMI-A1 [143.416142] Dynamic subtest B-HDMI-A1: SUCCESS (7.703s) [143.439106] Starting dynamic subtest: C-HDMI-A1 [151.120523] Dynamic subtest C-HDMI-A1: SUCCESS (7.700s) [151.141545] Starting dynamic subtest: D-HDMI-A1 [158.825943] Dynamic subtest D-HDMI-A1: SUCCESS (7.701s) [158.840808] Subtest flip-vs-panning-interruptible: SUCCESS (30.905s) [159.028639] [030/142] (857s left) kms_addfb_basic (bad-pitch-256) [159.076607] Starting subtest: bad-pitch-256 [159.077579] Subtest bad-pitch-256: SUCCESS (0.000s) [161.064151] [031/142] (854s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [161.199036] Starting subtest: stress-mm-invalidate-close-overlap [163.381980] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.180s) [163.780285] [032/142] (852s left) gem_mmap_gtt (basic-short) [163.832773] Subtest basic-short: SKIP (0.000s) [163.854958] [033/142] (852s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [165.823928] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [165.825618] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [165.897604] [034/142] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [167.959206] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [167.961184] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [168.029304] [035/142] (848s left) kms_big_fb (4-tiled-8bpp-rotate-180) [170.036898] Starting subtest: 4-tiled-8bpp-rotate-180 [170.038796] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s) [170.135853] [036/142] (846s left) kms_big_fb (x-tiled-32bpp-rotate-270) [172.242269] Starting subtest: x-tiled-32bpp-rotate-270 [172.337276] Subtest x-tiled-32bpp-rotate-270: SKIP (0.093s) [172.425884] [037/142] (843s left) kms_vblank (pipe-c-ts-continuation-dpms-suspend) [174.380414] Starting subtest: pipe-C-ts-continuation-dpms-suspend [195.801442] Subtest pipe-C-ts-continuation-dpms-suspend: SUCCESS (9.236s) [201.249147] [038/142] (832s left) syncobj_wait (invalid-signal-one-illegal-handle) [201.300017] Starting subtest: invalid-signal-one-illegal-handle [201.300881] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [201.367574] [039/142] (832s left) gem_exec_flush (basic-wb-rw-default) [201.425241] Subtest basic-wb-rw-default: SKIP (0.000s) [201.485810] [040/142] (832s left) kms_addfb_basic (master-rmfb) [201.537568] Starting subtest: master-rmfb [201.538612] Subtest master-rmfb: SUCCESS (0.001s) [203.529992] [041/142] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [205.581962] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [205.584050] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [205.663266] [042/142] (828s left) gem_softpin (safe-alignment) [205.783975] Starting subtest: safe-alignment [205.834826] Subtest safe-alignment: SUCCESS (0.051s) [205.940894] [043/142] (827s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc) [207.993299] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc [210.052388] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (2.059s) [210.326590] [044/142] (823s left) gem_exec_schedule (implicit-read-write) [210.384276] Starting subtest: implicit-read-write [210.385125] Starting dynamic subtest: rcs0 [210.569523] Dynamic subtest rcs0: SUCCESS (0.182s) [210.576295] Starting dynamic subtest: bcs0 [210.690437] Dynamic subtest bcs0: SUCCESS (0.123s) [210.697313] Starting dynamic subtest: vcs0 [210.817314] Dynamic subtest vcs0: SUCCESS (0.126s) [210.824088] Starting dynamic subtest: vcs1 [210.943047] Dynamic subtest vcs1: SUCCESS (0.125s) [210.949883] Starting dynamic subtest: vecs0 [211.079957] Dynamic subtest vecs0: SUCCESS (0.136s) [211.080819] Subtest implicit-read-write: SUCCESS (0.696s) [211.503563] [045/142] (822s left) kms_vblank (pipe-d-query-busy) [213.478851] Starting subtest: pipe-D-query-busy [215.993501] Subtest pipe-D-query-busy: SUCCESS (2.514s) [216.096409] [046/142] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [218.063818] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [218.065552] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [218.152358] [047/142] (815s left) kms_vblank (pipe-a-wait-forked-busy-hang) [220.193019] Starting subtest: pipe-A-wait-forked-busy-hang [234.316109] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.123s) [234.419265] [048/142] (799s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [236.380738] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [236.382509] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [236.455441] [049/142] (797s left) gem_tiled_pread_basic [236.597493] [050/142] (797s left) v3d/v3d_wait_bo (bad-pad) [236.684984] Subtest bad-pad: SKIP (0.000s) [236.736185] [051/142] (797s left) i915_pm_rpm (debugfs-forcewake-user) [241.863306] Starting subtest: debugfs-forcewake-user [254.383774] Subtest debugfs-forcewake-user: SUCCESS (12.521s) [255.531408] [052/142] (778s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [255.590840] Starting subtest: etime-single-wait-all-for-submit-submitted [255.696444] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s) [255.786411] [053/142] (778s left) gem_exec_params (rel-constants-invalid-rel-gen5) [255.846416] Starting subtest: rel-constants-invalid-rel-gen5 [255.847238] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [255.941158] [054/142] (778s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [257.920870] Starting subtest: plane-scaler-with-clipping-clamping-rotation [257.923314] Starting dynamic subtest: pipe-A-HDMI-A-1 [258.042741] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.119s) [258.055775] Starting dynamic subtest: pipe-B-HDMI-A-1 [258.183813] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.136s) [258.191025] Starting dynamic subtest: pipe-C-HDMI-A-1 [258.298887] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.113s) [258.307834] Starting dynamic subtest: pipe-D-HDMI-A-1 [258.407832] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.106s) [258.409427] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.486s) [258.538605] [055/142] (775s left) vc4/vc4_tiling (get-bad-modifier) [258.605901] Subtest get-bad-modifier: SKIP (0.000s) [258.657876] [056/142] (775s left) kms_flip (busy-flip) [259.669012] Starting subtest: busy-flip [259.675007] Starting dynamic subtest: A-HDMI-A1 [260.395017] Dynamic subtest A-HDMI-A1: SUCCESS (0.720s) [260.405056] Starting dynamic subtest: B-HDMI-A1 [261.051008] Dynamic subtest B-HDMI-A1: SUCCESS (0.654s) [261.060329] Starting dynamic subtest: C-HDMI-A1 [261.706782] Dynamic subtest C-HDMI-A1: SUCCESS (0.654s) [261.716084] Starting dynamic subtest: D-HDMI-A1 [262.363959] Dynamic subtest D-HDMI-A1: SUCCESS (0.656s) [262.368910] Subtest busy-flip: SUCCESS (2.701s) [262.537437] [057/142] (771s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_mc_ccs) [264.558050] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs [264.560878] Subtest pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s) [264.770747] [058/142] (769s left) kms_chamelium_frames (hdmi-crc-single) [266.775897] Subtest hdmi-crc-single: SKIP (0.000s) [266.832521] [059/142] (767s left) gem_create (hog-create) [266.884254] Starting subtest: hog-create [266.885147] Starting dynamic subtest: lmem0 [299.147858] Dynamic subtest lmem0: SUCCESS (32.263s) [299.158049] Starting dynamic subtest: smem0 [331.401840] Dynamic subtest smem0: SUCCESS (32.253s) [331.402760] Subtest hog-create: SUCCESS (64.518s) [331.622148] [060/142] (702s left) syncobj_wait (invalid-wait-illegal-handle) [331.677414] Starting subtest: invalid-wait-illegal-handle [331.678412] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [331.752417] [061/142] (702s left) prime_mmap (test_map_unmap) [331.797875] Starting subtest: test_map_unmap [331.798776] Starting dynamic subtest: test_map_unmap-smem [331.868227] Dynamic subtest test_map_unmap-smem: SUCCESS (0.070s) [331.877351] Starting dynamic subtest: test_map_unmap-lmem0 [331.938475] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.068s) [331.939499] Subtest test_map_unmap: SUCCESS (0.141s) [332.039583] [062/142] (702s left) v3d/v3d_submit_csd (bad-in-sync) [332.111903] Subtest bad-in-sync: SKIP (0.000s) [332.164080] [063/142] (702s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [334.122241] Starting subtest: fbc-rgb565-draw-render [336.827967] Subtest fbc-rgb565-draw-render: SUCCESS (2.706s) [336.995431] [064/142] (697s left) kms_fbcon_fbt (psr-suspend) [337.057442] Starting subtest: psr-suspend [337.059213] Subtest psr-suspend: SKIP (0.000s) [337.161320] [065/142] (697s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [339.142028] Starting subtest: yf-tiled-32bpp-rotate-180 [339.143919] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [339.213969] [066/142] (695s left) kms_mmap_write_crc (main) [341.243210] Starting subtest: main [341.245567] Starting dynamic subtest: pipe-A-HDMI-A-1 [345.547988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.301s) [345.549082] Subtest main: SUCCESS (4.303s) [345.669838] [067/142] (688s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [347.784543] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [347.855542] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.073s) [348.042470] [068/142] (686s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [349.997587] Starting subtest: addfb25-yf-tiled-legacy [349.998409] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [350.079338] [069/142] (684s left) gem_exec_whisper (basic-contexts-priority-all) [350.200096] Starting subtest: basic-contexts-priority-all [374.108577] Subtest basic-contexts-priority-all: SUCCESS (23.904s) [374.309277] [070/142] (660s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs) [376.384175] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs [376.386355] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [376.539538] [071/142] (657s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [379.107216] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [379.179456] [072/142] (655s left) device_reset (cold-reset-bound) [379.271722] Subtest cold-reset-bound: SKIP (0.000s) [379.366704] [073/142] (655s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area) [379.445717] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s) [379.481773] [074/142] (655s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [379.530974] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [379.531864] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [379.591032] [075/142] (654s left) gem_exec_fence (submit-chain) [379.814115] Starting subtest: submit-chain [379.850534] Subtest submit-chain: SUCCESS (0.040s) [380.432650] [076/142] (654s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [382.393204] Starting subtest: fbc-rgb565-draw-blt [385.138902] Subtest fbc-rgb565-draw-blt: SUCCESS (2.746s) [385.310022] [077/142] (649s left) kms_frontbuffer_tracking (fbc-tiling-4) [387.314045] Starting subtest: fbc-tiling-4 [387.316017] Subtest fbc-tiling-4: SKIP (0.000s) [387.392004] [078/142] (647s left) kms_prime (basic-crc-vgem) [390.168795] Subtest basic-crc-vgem: SKIP (0.000s) [390.261428] [079/142] (644s left) gen9_exec_parse (allowed-all) [390.312050] Subtest allowed-all: SKIP (0.000s) [390.346360] [080/142] (644s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs_cc) [392.441814] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc [392.764820] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.324s) [392.988135] [081/142] (641s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs) [395.080874] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs [395.082742] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s) [395.220586] [082/142] (639s left) gem_exec_nop (basic-series) [395.277274] Starting subtest: basic-series [398.973792] Subtest basic-series: SUCCESS (3.695s) [399.219254] [083/142] (635s left) v3d/v3d_get_param (get-bad-param) [399.305364] Subtest get-bad-param: SKIP (0.000s) [399.354265] [084/142] (635s left) kms_psr (psr2_suspend) [399.402286] Subtest psr2_suspend: SKIP (0.000s) [399.428459] [085/142] (635s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs) [401.427807] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs [401.807038] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.378s) [402.113413] [086/142] (632s left) kms_chamelium_hpd (vga-hpd-without-ddc) [404.120005] Subtest vga-hpd-without-ddc: SKIP (0.000s) [404.173946] [087/142] (630s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [404.221842] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [404.256123] [088/142] (630s left) gem_exec_fence (syncobj-unused-fence) [404.704075] Starting subtest: syncobj-unused-fence [404.719689] Subtest syncobj-unused-fence: SUCCESS (0.015s) [405.066837] [089/142] (629s left) gem_userptr_blits (access-control) [405.137205] Starting subtest: access-control [405.139071] Subtest access-control: SKIP (0.000s) [405.252489] [090/142] (629s left) perf_pmu (semaphore-wait) [405.335480] Starting subtest: semaphore-wait [405.336453] Starting dynamic subtest: rcs0 [405.862742] Dynamic subtest rcs0: SUCCESS (0.522s) [405.871427] Starting dynamic subtest: bcs0 [406.376381] Dynamic subtest bcs0: SUCCESS (0.509s) [406.385008] Starting dynamic subtest: vcs0 [406.889963] Dynamic subtest vcs0: SUCCESS (0.508s) [406.898423] Starting dynamic subtest: vcs1 [407.403759] Dynamic subtest vcs1: SUCCESS (0.509s) [407.412498] Starting dynamic subtest: vecs0 [407.917543] Dynamic subtest vecs0: SUCCESS (0.509s) [407.918770] Subtest semaphore-wait: SUCCESS (2.581s) [408.035806] [091/142] (626s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [408.089517] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [408.090439] Starting dynamic subtest: smem [408.173574] Dynamic subtest smem: SUCCESS (0.083s) [408.182052] Starting dynamic subtest: lmem0 [409.110494] Dynamic subtest lmem0: SUCCESS (0.933s) [409.111496] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (1.018s) [409.323795] [092/142] (625s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [411.272050] Starting subtest: plane-upscale-factor-0-25-with-modifiers [411.274481] Starting dynamic subtest: pipe-A-HDMI-A-1 [412.093224] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.819s) [412.106408] Starting dynamic subtest: pipe-B-HDMI-A-1 [412.865754] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.769s) [412.879388] Starting dynamic subtest: pipe-C-HDMI-A-1 [413.621078] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.752s) [413.635975] Starting dynamic subtest: pipe-D-HDMI-A-1 [414.545081] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.920s) [414.546549] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (3.274s) [414.736131] [093/142] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [416.697201] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [416.698989] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [416.773139] [094/142] (618s left) kms_cursor_crc (cursor-sliding-512x512) [418.988457] Starting subtest: cursor-sliding-512x512 [418.991725] Subtest cursor-sliding-512x512: SKIP (0.002s) [419.202851] [095/142] (615s left) sysfs_timeslice_duration (idempotent) [419.271059] Starting subtest: idempotent [419.273243] Starting dynamic subtest: vecs0 [419.274037] Dynamic subtest vecs0: SUCCESS (0.000s) [419.282564] Starting dynamic subtest: vcs0 [419.283407] Dynamic subtest vcs0: SUCCESS (0.000s) [419.291594] Starting dynamic subtest: bcs0 [419.292440] Dynamic subtest bcs0: SUCCESS (0.000s) [419.300454] Starting dynamic subtest: rcs0 [419.301266] Dynamic subtest rcs0: SUCCESS (0.000s) [419.309432] Starting dynamic subtest: vcs1 [419.310568] Dynamic subtest vcs1: SUCCESS (0.000s) [419.311664] Subtest idempotent: SUCCESS (0.008s) [419.352148] [096/142] (615s left) i915_pm_rps (thresholds) [419.404010] Starting subtest: thresholds [419.404928] Starting dynamic subtest: gt0 [419.420180] Dynamic subtest gt0: SKIP (0.015s) [419.421959] Subtest thresholds: SKIP (0.016s) [419.542689] [097/142] (615s left) kms_cursor_legacy (cursor-vs-flip-atomic) [421.528129] Starting subtest: cursor-vs-flip-atomic [450.866318] Subtest cursor-vs-flip-atomic: SUCCESS (29.338s) [450.987966] [098/142] (584s left) gem_ctx_sseu (engines) [451.036964] Subtest engines: SKIP (0.000s) [451.062610] [099/142] (583s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [453.015059] Starting subtest: primary-yf-tiled-reflect-x-0 [453.118941] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.104s) [453.274027] [100/142] (581s left) vc4/vc4_perfmon (destroy-valid-perfmon) [453.402198] Subtest destroy-valid-perfmon: SKIP (0.000s) [453.455734] [101/142] (581s left) gem_userptr_blits (unsync-unmap-after-close) [453.518593] Subtest unsync-unmap-after-close: SKIP (0.000s) [453.677319] [102/142] (581s left) kms_lease (lease-uevent) [455.660484] Starting subtest: lease-uevent [456.679191] Subtest lease-uevent: SUCCESS (1.017s) [456.736694] [103/142] (578s left) kms_color (ctm-max) [458.698770] Starting subtest: ctm-max [458.699811] Starting dynamic subtest: pipe-A [459.371063] Dynamic subtest pipe-A: SUCCESS (0.671s) [459.379548] Starting dynamic subtest: pipe-B [459.858664] Dynamic subtest pipe-B: SUCCESS (0.485s) [459.869125] Starting dynamic subtest: pipe-C [460.352781] Dynamic subtest pipe-C: SUCCESS (0.493s) [460.363265] Starting dynamic subtest: pipe-D [460.849877] Dynamic subtest pipe-D: SUCCESS (0.496s) [460.850901] Subtest ctm-max: SUCCESS (2.151s) [460.978005] [104/142] (574s left) api_intel_bb (intel-bb-blit-none) [461.029078] Starting subtest: intel-bb-blit-none [461.798879] Subtest intel-bb-blit-none: SUCCESS (0.770s) [461.903799] [105/142] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [463.863661] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [463.865545] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [463.930390] [106/142] (571s left) gem_mmap_gtt (fault-concurrent-y) [464.016827] Subtest fault-concurrent-Y: SKIP (0.000s) [464.064150] [107/142] (571s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [466.043945] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [466.044829] Starting dynamic subtest: pipe-A-valid-mode [466.741394] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.695s) [466.742408] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.698s) [466.871117] [108/142] (568s left) kms_dsc (dsc-with-bpc-formats) [468.827017] Starting subtest: dsc-with-bpc-formats [468.830360] Subtest dsc-with-bpc-formats: SKIP (0.003s) [468.887771] [109/142] (566s left) gem_pread (self) [468.960086] Subtest self: SKIP (0.000s) [469.032263] [110/142] (566s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [471.105371] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc [471.212375] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.107s) [471.426742] [111/142] (563s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs) [473.552805] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs [473.555654] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [473.658264] [112/142] (561s left) kms_flip (2x-flip-vs-modeset-vs-hang) [474.663664] Starting subtest: 2x-flip-vs-modeset-vs-hang [474.694645] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.031s) [474.781109] [113/142] (560s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [476.801591] Starting subtest: psr-modesetfrombusy [476.803500] Subtest psr-modesetfrombusy: SKIP (0.000s) [476.879171] [114/142] (558s left) gem_ctx_exec (basic-norecovery) [476.990803] Starting subtest: basic-norecovery [477.289438] Subtest basic-norecovery: SUCCESS (0.299s) [477.402138] [115/142] (558s left) kms_atomic_transition (plane-toggle-modeset-transition) [479.361398] Starting subtest: plane-toggle-modeset-transition [479.364031] Starting dynamic subtest: pipe-A-HDMI-A-1 [480.808847] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.446s) [480.820019] Starting dynamic subtest: pipe-B-HDMI-A-1 [482.002295] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.190s) [482.003204] Subtest plane-toggle-modeset-transition: SUCCESS (2.643s) [482.113465] [116/142] (553s left) kms_big_fb (linear-16bpp-rotate-90) [484.086420] Starting subtest: linear-16bpp-rotate-90 [484.162835] Subtest linear-16bpp-rotate-90: SKIP (0.078s) [484.262389] [117/142] (551s left) gem_ccs (block-copy-compressed) [484.313392] Starting subtest: block-copy-compressed [484.314977] Subtest block-copy-compressed: SKIP (0.000s) [484.389956] [118/142] (551s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [486.461739] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [486.463673] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s) [486.647232] [119/142] (548s left) kms_vblank (pipe-a-query-busy) [488.604290] Starting subtest: pipe-A-query-busy [491.047915] Subtest pipe-A-query-busy: SUCCESS (2.444s) [491.150286] [120/142] (544s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [493.114080] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [493.115973] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [493.206271] [121/142] (542s left) core_getclient [493.418828] [122/142] (542s left) gem_spin_batch (resubmit) [493.480960] Starting subtest: resubmit [493.481787] Starting dynamic subtest: rcs0 [493.496500] Dynamic subtest rcs0: SUCCESS (0.015s) [493.507311] Starting dynamic subtest: bcs0 [493.508094] Dynamic subtest bcs0: SUCCESS (0.002s) [493.517176] Starting dynamic subtest: vcs0 [493.518004] Dynamic subtest vcs0: SUCCESS (0.002s) [493.526661] Starting dynamic subtest: vcs1 [493.527736] Dynamic subtest vcs1: SUCCESS (0.002s) [493.536509] Starting dynamic subtest: vecs0 [493.537605] Dynamic subtest vecs0: SUCCESS (0.003s) [493.538609] Subtest resubmit: SUCCESS (0.029s) [493.776050] [123/142] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [495.771906] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [495.773756] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [495.854074] [124/142] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [497.887435] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [499.847484] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.962s) [499.999836] [125/142] (535s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [501.967571] Starting subtest: cursorB-vs-flipB-legacy [501.971502] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s) [502.034892] [126/142] (533s left) syncobj_timeline (single-wait-all-available-submitted) [502.124787] Starting subtest: single-wait-all-available-submitted [502.127225] Subtest single-wait-all-available-submitted: SUCCESS (0.001s) [502.225081] [127/142] (533s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [504.215349] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [504.216336] Starting dynamic subtest: pipe-A-valid-mode [504.269027] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s) [504.271008] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.053s) [504.356960] [128/142] (531s left) drm_fdinfo (virtual-busy-all) [504.413210] Starting subtest: virtual-busy-all [504.415102] Subtest virtual-busy-all: SKIP (0.000s) [504.475574] [129/142] (531s left) i915_pm_rpm (dpms-mode-unset-non-lpsp) [508.898698] Starting subtest: dpms-mode-unset-non-lpsp [511.054039] Subtest dpms-mode-unset-non-lpsp: SKIP (2.155s) [512.179634] [130/142] (523s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [514.152890] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [514.154666] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [514.232056] [131/142] (521s left) perf (buffer-fill) [514.406016] Starting subtest: buffer-fill [514.406947] Starting dynamic subtest: 0-rcs0 [516.642117] Dynamic subtest 0-rcs0: SUCCESS (2.233s) [516.642976] Subtest buffer-fill: SUCCESS (2.235s) [516.678996] [132/142] (519s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs) [518.639142] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs [518.641078] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [518.953177] [133/142] (516s left) kms_cursor_crc (cursor-offscreen-512x170) [521.136808] Starting subtest: cursor-offscreen-512x170 [521.139976] Subtest cursor-offscreen-512x170: SKIP (0.002s) [521.274335] [134/142] (514s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs) [523.363521] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs [523.365561] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [523.560232] [135/142] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [525.520458] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [525.522394] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [525.598977] [136/142] (510s left) kms_vblank (pipe-a-ts-continuation-modeset) [527.638842] Starting subtest: pipe-A-ts-continuation-modeset [528.077990] Subtest pipe-A-ts-continuation-modeset: SUCCESS (0.439s) [528.181351] [137/142] (507s left) gen9_exec_parse (valid-registers) [528.232326] Subtest valid-registers: SKIP (0.000s) [528.255349] [138/142] (507s left) kms_properties (invalid-properties-atomic) [530.209990] Starting subtest: invalid-properties-atomic [531.010269] Subtest invalid-properties-atomic: SUCCESS (0.798s) [531.081848] [139/142] (504s left) gem_mmap_gtt (big-bo) [531.128567] Subtest big-bo: SKIP (0.000s) [531.155474] [140/142] (504s left) perf_pmu (busy-accuracy-98) [531.204537] Starting subtest: busy-accuracy-98 [531.205528] Starting dynamic subtest: rcs0 [534.251026] Dynamic subtest rcs0: SUCCESS (3.045s) [534.260067] Starting dynamic subtest: bcs0 [537.295097] Dynamic subtest bcs0: SUCCESS (3.043s) [537.304370] Starting dynamic subtest: vcs0 [540.338856] Dynamic subtest vcs0: SUCCESS (3.043s) [540.348122] Starting dynamic subtest: vcs1 [543.385024] Dynamic subtest vcs1: SUCCESS (3.045s) [543.394214] Starting dynamic subtest: vecs0 [546.426577] Dynamic subtest vecs0: SUCCESS (3.040s) [546.427650] Subtest busy-accuracy-98: SUCCESS (15.222s) [546.535547] [141/142] (489s left) gem_exec_capture (capture-recoverable) [546.586792] Starting subtest: capture-recoverable [546.589340] Subtest capture-recoverable: SUCCESS (0.003s) [546.719728] [142/142] (489s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs) [548.853999] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs [548.957787] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SUCCESS (0.107s) [549.097841] Closing watchdogs Done.