[50.892633] Initializing watchdogs [50.893089] /dev/watchdog0 [50.925985] [001/142] (960s left) gem_exec_schedule (promotion) [51.424919] Starting subtest: promotion [51.428662] Starting dynamic subtest: rcs0 [51.951591] Dynamic subtest rcs0: SUCCESS (0.525s) [51.980770] Starting dynamic subtest: bcs0 [52.348265] Dynamic subtest bcs0: SUCCESS (0.396s) [52.379330] Starting dynamic subtest: vcs0 [52.627130] Dynamic subtest vcs0: SUCCESS (0.277s) [52.663166] Starting dynamic subtest: vcs1 [52.952413] Dynamic subtest vcs1: SUCCESS (0.325s) [52.984453] Starting dynamic subtest: vecs0 [53.262801] Dynamic subtest vecs0: SUCCESS (0.309s) [53.296912] Starting dynamic subtest: ccs0 [53.688234] Dynamic subtest ccs0: SUCCESS (0.424s) [53.692407] Subtest promotion: SUCCESS (2.263s) [54.200808] [002/142] (957s left) gem_exec_fence (expired-history) [56.668367] Starting subtest: expired-history [62.530988] Subtest expired-history: SUCCESS (5.863s) [63.567739] [003/142] (947s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [64.127470] Starting subtest: short-flip-before-cursor-atomic-transitions [66.052414] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.925s) [66.965224] [004/142] (944s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [67.341805] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [67.349902] Starting dynamic subtest: pipe-A-eDP-1 [67.480642] Dynamic subtest pipe-A-eDP-1: SKIP (0.127s) [67.518820] Starting dynamic subtest: pipe-B-eDP-1 [67.741767] Dynamic subtest pipe-B-eDP-1: SKIP (0.252s) [67.769634] Starting dynamic subtest: pipe-C-eDP-1 [67.995715] Dynamic subtest pipe-C-eDP-1: SKIP (0.248s) [68.039123] Starting dynamic subtest: pipe-D-eDP-1 [68.256143] Dynamic subtest pipe-D-eDP-1: SKIP (0.249s) [68.262203] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.909s) [68.415767] [005/142] (943s left) kms_flip (2x-wf_vblank-ts-check) [68.818518] Starting subtest: 2x-wf_vblank-ts-check [68.980415] Subtest 2x-wf_vblank-ts-check: SKIP (0.159s) [69.165185] [006/142] (942s left) gem_mmap_wc (copy) [69.529381] Subtest copy: SKIP (0.000s) [69.641584] [007/142] (942s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [70.131429] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [70.140456] Starting dynamic subtest: pipe-A-default-mode [70.629936] Dynamic subtest pipe-A-default-mode: SKIP (0.486s) [70.637419] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.496s) [71.483082] [008/142] (940s left) i915_pm_rc6_residency (media-rc6-accuracy) [73.109670] Subtest media-rc6-accuracy: SKIP (0.000s) [73.235938] [009/142] (938s left) gem_exec_fence (basic-wait-all) [73.663879] Starting subtest: basic-wait-all [73.761103] Subtest basic-wait-all: SUCCESS (0.097s) [76.084767] [010/142] (935s left) perf (polling-small-buf) [77.054218] Starting subtest: polling-small-buf [77.175262] Subtest polling-small-buf: SUCCESS (0.124s) [77.267077] [011/142] (934s left) gem_reg_read (timestamp-monotonic) [77.641945] Starting subtest: timestamp-monotonic [81.791201] Subtest timestamp-monotonic: SUCCESS (4.148s) [81.957446] [012/142] (930s left) gen3_mixed_blits [82.450562] [013/142] (929s left) core_getstats [82.966533] [014/142] (929s left) kms_vblank (pipe-a-query-idle) [83.463855] Starting subtest: pipe-A-query-idle [85.408472] Subtest pipe-A-query-idle: SUCCESS (1.942s) [86.332305] [015/142] (926s left) gem_ctx_persistence (engines-mixed) [86.733947] Starting subtest: engines-mixed [86.737773] Starting dynamic subtest: rcs0 [86.808476] Dynamic subtest rcs0: SUCCESS (0.074s) [86.846403] Starting dynamic subtest: bcs0 [86.882587] Dynamic subtest bcs0: SUCCESS (0.074s) [86.920072] Starting dynamic subtest: vcs0 [86.952435] Dynamic subtest vcs0: SUCCESS (0.069s) [86.993530] Starting dynamic subtest: vcs1 [87.027359] Dynamic subtest vcs1: SUCCESS (0.074s) [87.062152] Starting dynamic subtest: vecs0 [87.097454] Dynamic subtest vecs0: SUCCESS (0.069s) [87.130584] Starting dynamic subtest: ccs0 [87.147805] Dynamic subtest ccs0: SUCCESS (0.049s) [87.151840] Subtest engines-mixed: SUCCESS (0.414s) [87.317992] [016/142] (925s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs) [88.618142] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs [88.631340] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.013s) [89.678437] [017/142] (922s left) gem_eio (in-flight-contexts-10ms) [91.616788] Starting subtest: in-flight-contexts-10ms [127.388700] Subtest in-flight-contexts-10ms: SUCCESS (35.775s) [128.639140] [018/142] (883s left) kms_big_joiner (invalid-modeset) [129.129174] Subtest invalid-modeset: SKIP (0.000s) [129.211518] [019/142] (883s left) gem_set_tiling_vs_gtt [129.733609] [020/142] (883s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [130.276816] Starting subtest: flip-vs-cursor-crc-legacy [131.452841] Subtest flip-vs-cursor-crc-legacy: SUCCESS (1.172s) [132.371398] [021/142] (880s left) kms_cursor_legacy (forked-move) [132.950361] Starting subtest: forked-move [132.954139] Starting dynamic subtest: pipe-A [139.053543] Dynamic subtest pipe-A: SUCCESS (6.101s) [139.086074] Starting dynamic subtest: pipe-B [145.071120] Dynamic subtest pipe-B: SUCCESS (6.021s) [145.110080] Starting dynamic subtest: pipe-C [151.117821] Dynamic subtest pipe-C: SUCCESS (6.046s) [151.149251] Starting dynamic subtest: pipe-D [157.126261] Dynamic subtest pipe-D: SUCCESS (6.007s) [157.168800] Starting dynamic subtest: all-pipes [163.113712] Dynamic subtest all-pipes: SUCCESS (5.985s) [163.116960] Subtest forked-move: SUCCESS (30.167s) [163.429465] [022/142] (849s left) v3d/v3d_create_bo (create-bo-4096) [163.926410] Subtest create-bo-4096: SKIP (0.000s) [164.058770] [023/142] (848s left) kms_atomic (plane-invalid-params-fence) [164.862930] Starting subtest: plane-invalid-params-fence [164.934478] Subtest plane-invalid-params-fence: SUCCESS (0.076s) [166.234406] [024/142] (846s left) kms_addfb_basic (bad-pitch-256) [166.412592] Starting subtest: bad-pitch-256 [166.415237] Subtest bad-pitch-256: SUCCESS (0.000s) [166.585385] [025/142] (846s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs) [167.785850] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs [169.057841] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.272s) [170.465755] [026/142] (842s left) vc4/vc4_perfmon (destroy-invalid-perfmon) [170.947354] Subtest destroy-invalid-perfmon: SKIP (0.000s) [171.075879] [027/142] (842s left) gem_exec_schedule (submit-late-slice) [171.518670] Starting subtest: submit-late-slice [171.522210] Starting dynamic subtest: rcs0 [171.664974] Dynamic subtest rcs0: SUCCESS (0.144s) [171.715870] Starting dynamic subtest: bcs0 [171.805607] Dynamic subtest bcs0: SUCCESS (0.138s) [171.844906] Starting dynamic subtest: vcs0 [171.935580] Dynamic subtest vcs0: SUCCESS (0.127s) [171.973378] Starting dynamic subtest: vcs1 [172.062520] Dynamic subtest vcs1: SUCCESS (0.124s) [172.101761] Starting dynamic subtest: vecs0 [172.191358] Dynamic subtest vecs0: SUCCESS (0.126s) [172.229624] Starting dynamic subtest: ccs0 [172.319059] Dynamic subtest ccs0: SUCCESS (0.125s) [172.322613] Subtest submit-late-slice: SUCCESS (0.802s) [172.778047] [028/142] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [173.281323] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [173.288289] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [173.426819] [029/142] (839s left) gem_ctx_isolation (preservation-s3) [173.848278] Starting subtest: preservation-S3 [173.851601] Starting dynamic subtest: rcs0 [191.633711] Dynamic subtest rcs0: SUCCESS (17.782s) [191.669544] Starting dynamic subtest: bcs0 [208.628242] Dynamic subtest bcs0: SUCCESS (16.992s) [208.670387] Starting dynamic subtest: vcs0 [225.638203] Dynamic subtest vcs0: SUCCESS (17.006s) [225.683909] Starting dynamic subtest: vcs1 [243.591887] Dynamic subtest vcs1: SUCCESS (17.950s) [243.636991] Starting dynamic subtest: vecs0 [261.632326] Dynamic subtest vecs0: SUCCESS (18.036s) [261.677357] Starting dynamic subtest: ccs0 [279.625391] Dynamic subtest ccs0: SUCCESS (17.989s) [279.629083] Subtest preservation-S3: SUCCESS (105.777s) [279.952206] [030/142] (733s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [280.507310] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [284.365108] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (3.857s) [284.875765] [031/142] (728s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [286.358310] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc [286.368292] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [287.278704] [032/142] (726s left) v3d/v3d_wait_bo (used-bo-0ns) [287.752061] Subtest used-bo-0ns: SKIP (0.000s) [287.890828] [033/142] (725s left) dmabuf_sync_file (import-multiple-read-only) [288.270325] Starting subtest: import-multiple-read-only [288.292149] Subtest import-multiple-read-only: SUCCESS (0.023s) [288.430365] [034/142] (725s left) kms_cursor_legacy (torture-bo) [288.988275] Starting subtest: torture-bo [288.991921] Starting dynamic subtest: pipe-A [295.220624] Dynamic subtest pipe-A: SUCCESS (6.228s) [295.258410] Starting dynamic subtest: pipe-B [301.684296] Dynamic subtest pipe-B: SUCCESS (6.461s) [301.732659] Starting dynamic subtest: pipe-C [308.410900] Dynamic subtest pipe-C: SUCCESS (6.722s) [308.452835] Starting dynamic subtest: pipe-D [314.699684] Dynamic subtest pipe-D: SUCCESS (6.284s) [314.738160] Starting dynamic subtest: all-pipes [321.154768] Dynamic subtest all-pipes: SUCCESS (6.448s) [321.158957] Subtest torture-bo: SUCCESS (32.169s) [321.480753] [035/142] (692s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [321.966396] Starting subtest: sprite-rotation-90-pos-100-0 [321.978222] Subtest sprite-rotation-90-pos-100-0: SKIP (0.007s) [322.128813] [036/142] (691s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b) [322.609144] Starting subtest: universal-plane-pageflip-windowed-pipe-B [324.672787] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (2.062s) [325.655290] [037/142] (688s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs) [327.335132] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs [327.341681] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s) [327.893749] [038/142] (686s left) gem_exec_store (cachelines) [328.318977] Starting subtest: cachelines [328.322044] Starting dynamic subtest: rcs0 [328.428514] Dynamic subtest rcs0: SUCCESS (0.107s) [328.474068] Starting dynamic subtest: bcs0 [328.519436] Dynamic subtest bcs0: SUCCESS (0.086s) [328.563933] Starting dynamic subtest: vcs0 [330.551764] Dynamic subtest vcs0: SUCCESS (2.027s) [330.596278] Starting dynamic subtest: vcs1 [332.536486] Dynamic subtest vcs1: SUCCESS (1.980s) [332.586429] Starting dynamic subtest: vecs0 [334.521070] Dynamic subtest vecs0: SUCCESS (1.979s) [334.567726] Starting dynamic subtest: ccs0 [334.626482] Dynamic subtest ccs0: SUCCESS (0.103s) [334.630503] Subtest cachelines: SUCCESS (6.309s) [334.942249] [039/142] (679s left) i915_pm_rpm (gem-mmap-type) [337.682464] Starting subtest: gem-mmap-type [337.686824] Starting dynamic subtest: gtt-smem0 [338.176395] Dynamic subtest gtt-smem0: SKIP (0.486s) [338.221937] Starting dynamic subtest: wb-smem0 [341.400203] Dynamic subtest wb-smem0: SUCCESS (3.224s) [341.440166] Starting dynamic subtest: wc-smem0 [348.218696] Dynamic subtest wc-smem0: SUCCESS (6.819s) [348.261227] Starting dynamic subtest: uc-smem0 [354.997019] Dynamic subtest uc-smem0: SUCCESS (6.773s) [355.000564] Subtest gem-mmap-type: SUCCESS (17.312s) [355.215158] [040/142] (659s left) gem_exec_create (madvise) [355.649346] Starting subtest: madvise [355.652743] Starting dynamic subtest: smem [377.604678] Dynamic subtest smem: SUCCESS (21.952s) [377.609170] Subtest madvise: SUCCESS (21.956s) [378.756958] [041/142] (635s left) gem_mmap_gtt (medium-copy-xy) [379.148357] Subtest medium-copy-XY: SKIP (0.000s) [379.283621] [042/142] (635s left) kms_color (ctm-red-to-blue) [379.799910] Starting subtest: ctm-red-to-blue [379.803672] Starting dynamic subtest: pipe-A [381.087682] Dynamic subtest pipe-A: SUCCESS (1.288s) [381.133398] Starting dynamic subtest: pipe-B [383.063949] Dynamic subtest pipe-B: SUCCESS (1.971s) [383.110778] Starting dynamic subtest: pipe-C [385.347799] Dynamic subtest pipe-C: SUCCESS (2.281s) [385.394208] Starting dynamic subtest: pipe-D [388.096774] Dynamic subtest pipe-D: SUCCESS (2.740s) [388.100897] Subtest ctm-red-to-blue: SUCCESS (8.298s) [389.040388] [043/142] (625s left) kms_frontbuffer_tracking (fbcpsr-suspend) [389.551749] Starting subtest: fbcpsr-suspend [434.147955] Subtest fbcpsr-suspend: SUCCESS (44.601s) [434.313396] [044/142] (580s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [434.567101] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [434.688656] [045/142] (580s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm) [435.178662] Starting subtest: pipe-D-ts-continuation-modeset-rpm [440.074137] Subtest pipe-D-ts-continuation-modeset-rpm: SUCCESS (4.897s) [441.045908] [046/142] (573s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [441.963505] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [441.968742] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [443.481461] [047/142] (571s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [444.005388] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [444.011910] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [444.188212] [048/142] (570s left) gem_exec_reloc (basic-concurrent0) [444.601730] Subtest basic-concurrent0: SKIP (0.000s) [444.746868] [049/142] (570s left) syncobj_wait (invalid-multi-wait-unsubmitted) [445.132256] Starting subtest: invalid-multi-wait-unsubmitted [445.135695] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s) [445.287870] [050/142] (569s left) syncobj_basic (bad-create-flags) [445.673136] Starting subtest: bad-create-flags [445.676542] Subtest bad-create-flags: SUCCESS (0.000s) [445.824300] [051/142] (569s left) gem_mmap_offset (open-flood) [446.214205] Starting subtest: open-flood [467.811283] Subtest open-flood: SUCCESS (21.601s) [468.005339] [052/142] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [468.538742] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [468.545731] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [468.717357] [053/142] (546s left) gem_ctx_shared (q-smoketest) [469.117554] Starting subtest: Q-smoketest [469.121431] Starting dynamic subtest: rcs0 [475.420205] Dynamic subtest rcs0: SUCCESS (6.232s) [475.465135] Starting dynamic subtest: bcs0 [481.374380] Dynamic subtest bcs0: SUCCESS (5.943s) [481.418727] Starting dynamic subtest: vcs0 [487.397112] Dynamic subtest vcs0: SUCCESS (6.020s) [487.442393] Starting dynamic subtest: vcs1 [493.408306] Dynamic subtest vcs1: SUCCESS (6.005s) [493.450303] Starting dynamic subtest: vecs0 [499.480614] Dynamic subtest vecs0: SUCCESS (6.076s) [499.526360] Starting dynamic subtest: ccs0 [505.609325] Dynamic subtest ccs0: SUCCESS (6.127s) [505.612718] Subtest Q-smoketest: SUCCESS (36.427s) [505.931685] [054/142] (509s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [506.453885] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [516.049305] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (9.596s) [516.341540] [055/142] (499s left) kms_cursor_crc (cursor-random-32x32) [516.991618] Starting subtest: cursor-random-32x32 [517.295957] Subtest cursor-random-32x32: SKIP (0.297s) [518.247581] [056/142] (497s left) sw_sync (sync_busy) [518.619814] Starting subtest: sync_busy [518.634370] Subtest sync_busy: SUCCESS (0.016s) [518.786627] [057/142] (497s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_mc_ccs) [520.084060] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs [520.089316] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s) [520.942435] [058/142] (495s left) kms_vblank (pipe-b-wait-forked-busy-hang) [521.425158] Starting subtest: pipe-B-wait-forked-busy-hang [536.601280] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (15.175s) [537.562282] [059/142] (478s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs) [538.525283] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs [538.532223] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.002s) [539.967832] [060/142] (476s left) kms_chamelium_edid (dp-edid-read) [540.833484] Subtest dp-edid-read: SKIP (0.000s) [541.732388] [061/142] (474s left) gem_bad_reloc (negative-reloc-lut) [542.127795] Subtest negative-reloc-lut: SKIP (0.000s) [542.280302] [062/142] (474s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [543.367372] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [543.384283] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.013s) [544.654345] [063/142] (471s left) kms_plane (pixel-format-source-clamping) [545.135458] Starting subtest: pixel-format-source-clamping [545.140730] Starting dynamic subtest: pipe-A-planes [564.555179] Dynamic subtest pipe-A-planes: SUCCESS (19.408s) [564.607053] Starting dynamic subtest: pipe-B-planes [585.429978] Dynamic subtest pipe-B-planes: SUCCESS (20.871s) [585.433667] Subtest pixel-format-source-clamping: SUCCESS (40.300s) [586.392133] [064/142] (430s left) perf (i915-ref-count) [586.924105] Starting subtest: i915-ref-count [587.065513] Subtest i915-ref-count: SUCCESS (0.142s) [587.280220] [065/142] (429s left) syncobj_timeline (reset-multiple-signaled) [587.661500] Starting subtest: reset-multiple-signaled [587.664996] Subtest reset-multiple-signaled: SUCCESS (0.003s) [587.821551] [066/142] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [588.326606] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [588.333770] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [588.496917] [067/142] (428s left) gem_exec_reloc (basic-cpu-wc) [588.898587] Subtest basic-cpu-wc: SKIP (0.000s) [589.033528] [068/142] (427s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [589.553527] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [589.560873] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [589.741501] [069/142] (427s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled) [590.128245] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled [590.132216] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.003s) [590.266468] [070/142] (426s left) i915_pm_rpm (universal-planes-dpms) [592.707814] Starting subtest: universal-planes-dpms [592.711802] Starting dynamic subtest: plane-31 [621.009987] Dynamic subtest plane-31: SUCCESS (28.299s) [621.074532] Starting dynamic subtest: plane-40 [645.704636] Dynamic subtest plane-40: SUCCESS (24.689s) [645.762431] Starting dynamic subtest: plane-49 [670.317134] Dynamic subtest plane-49: SUCCESS (24.608s) [670.357609] Starting dynamic subtest: plane-58 [695.061742] Dynamic subtest plane-58: SUCCESS (24.740s) [695.122727] Starting dynamic subtest: plane-67 [719.801296] Dynamic subtest plane-67: SUCCESS (24.734s) [719.852916] Starting dynamic subtest: plane-76 [748.286438] Dynamic subtest plane-76: SUCCESS (28.481s) [748.290699] Subtest universal-planes-dpms: SUCCESS (155.581s) [749.579196] [071/142] (267s left) gem_pxp (create-valid-protected-context) [752.493515] Subtest create-valid-protected-context: SKIP (0.000s) [752.677887] [072/142] (264s left) kms_cursor_crc (cursor-onscreen-32x10) [753.380186] Starting subtest: cursor-onscreen-32x10 [753.483993] Subtest cursor-onscreen-32x10: SKIP (0.092s) [754.075131] [073/142] (263s left) gem_readwrite (read-write) [754.455803] Subtest read-write: SKIP (0.000s) [754.592163] [074/142] (262s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [755.116374] Starting subtest: fbcpsr-rgb101010-draw-pwrite [763.228910] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (8.117s) [763.504772] [075/142] (254s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [764.011165] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [764.017978] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [764.186463] [076/142] (253s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [764.696602] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [764.703536] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [764.872436] [077/142] (252s left) gen9_exec_parse (batch-without-end) [765.276365] Subtest batch-without-end: SKIP (0.000s) [765.400085] [078/142] (252s left) kms_psr (cursor_blt) [765.888984] Starting subtest: cursor_blt [769.055300] Subtest cursor_blt: SUCCESS (3.164s) [770.005205] [079/142] (247s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [770.518284] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [786.034660] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (15.520s) [786.285753] [080/142] (231s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20) [786.760465] Starting subtest: plane-upscale-with-pixel-format-20x20 [786.764798] Starting dynamic subtest: pipe-A-eDP-1 [791.113201] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.349s) [791.174421] Starting dynamic subtest: pipe-B-eDP-1 [796.842318] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.715s) [796.901850] Starting dynamic subtest: pipe-C-eDP-1 [798.621179] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.771s) [798.680790] Starting dynamic subtest: pipe-D-eDP-1 [800.435555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.803s) [800.439281] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (13.682s) [801.991800] [081/142] (216s left) gem_userptr_blits (set-cache-level) [802.412209] Starting subtest: set-cache-level [802.418753] Subtest set-cache-level: SKIP (0.000s) [802.703759] [082/142] (215s left) api_intel_bb (simple-bb-ctx) [803.078215] Starting subtest: simple-bb-ctx [803.103957] Subtest simple-bb-ctx: SUCCESS (0.025s) [803.289178] [083/142] (215s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb) [810.629813] Starting subtest: primary-plane-update-sf-dmg-area-big-fb [810.635560] Starting dynamic subtest: pipe-A-eDP-1 [834.279657] Dynamic subtest pipe-A-eDP-1: SUCCESS (23.638s) [834.380980] Starting dynamic subtest: pipe-B-eDP-1 [857.943907] Dynamic subtest pipe-B-eDP-1: SUCCESS (23.655s) [857.947910] Subtest primary-plane-update-sf-dmg-area-big-fb: SUCCESS (47.317s) [859.124424] [084/142] (159s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [859.643902] Starting subtest: fbcpsr-farfromfence-mmap-gtt [859.650985] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [859.813083] [085/142] (158s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [860.208853] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [860.374379] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.164s) [860.580555] [086/142] (158s left) kms_flip (2x-flip-vs-rmfb-interruptible) [861.005272] Starting subtest: 2x-flip-vs-rmfb-interruptible [861.174175] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.164s) [861.352869] [087/142] (157s left) kms_panel_fitting (legacy) [861.839177] Starting subtest: legacy [861.842832] Starting dynamic subtest: pipe-A-eDP-1 [863.867906] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.027s) [863.982343] Starting dynamic subtest: pipe-B-eDP-1 [866.838106] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.907s) [866.947630] Starting dynamic subtest: pipe-C-eDP-1 [869.839820] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s) [869.952800] Starting dynamic subtest: pipe-D-eDP-1 [872.720714] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.820s) [872.724472] Subtest legacy: SUCCESS (10.885s) [874.324862] [088/142] (144s left) v3d/v3d_submit_cl (bad-multisync-out-sync) [874.808382] Subtest bad-multisync-out-sync: SKIP (0.000s) [874.946520] [089/142] (143s left) kms_legacy_colorkey (basic) [875.431609] Starting subtest: basic [875.435326] Starting dynamic subtest: pipe-A [875.473890] Dynamic subtest pipe-A: SUCCESS (0.046s) [875.534069] Starting dynamic subtest: pipe-B [875.537983] Dynamic subtest pipe-B: SUCCESS (0.002s) [875.592220] Starting dynamic subtest: pipe-C [875.595868] Dynamic subtest pipe-C: SUCCESS (0.002s) [875.646480] Starting dynamic subtest: pipe-D [875.649931] Dynamic subtest pipe-D: SUCCESS (0.002s) [875.653387] Subtest basic: SUCCESS (0.068s) [875.727230] [090/142] (143s left) kms_vblank (pipe-c-ts-continuation-modeset-hang) [876.211789] Starting subtest: pipe-C-ts-continuation-modeset-hang [892.838398] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (16.628s) [893.798538] [091/142] (125s left) api_intel_allocator (open-vm) [894.169690] Starting subtest: open-vm [894.179544] Subtest open-vm: SUCCESS (0.009s) [894.370975] [092/142] (124s left) api_intel_bb (destroy-bb) [894.744069] Starting subtest: destroy-bb [894.792705] Subtest destroy-bb: SUCCESS (0.047s) [894.984963] [093/142] (124s left) gem_softpin (allocator-nopin) [895.384968] Starting subtest: allocator-nopin [895.937458] Subtest allocator-nopin: SUCCESS (0.552s) [896.175525] [094/142] (123s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc) [897.419332] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc [897.423196] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s) [898.601116] [095/142] (120s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [899.114936] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [912.379266] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (13.266s) [912.689493] [096/142] (106s left) vc4/vc4_wait_seqno (bad-seqno-1ns) [913.161310] Subtest bad-seqno-1ns: SKIP (0.000s) [913.303291] [097/142] (106s left) syncobj_timeline (etime-multi-wait-all-submitted) [913.682993] Starting subtest: etime-multi-wait-all-submitted [913.781889] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s) [913.937602] [098/142] (105s left) kms_chamelium_edid (hdmi-mode-timings) [914.852822] Subtest hdmi-mode-timings: SKIP (0.000s) [915.738394] [099/142] (104s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc) [917.240739] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc [917.247146] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [918.128540] [100/142] (101s left) gem_exec_balancer (bonded-true-hang) [919.388732] Starting subtest: bonded-true-hang [919.394983] Subtest bonded-true-hang: SKIP (0.000s) [919.561754] [101/142] (100s left) gem_mmap_gtt (fault-concurrent-y) [919.946755] Subtest fault-concurrent-Y: SKIP (0.000s) [920.070492] [102/142] (100s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [920.454754] Starting subtest: invalid-single-wait-all-unsubmitted [920.458417] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.001s) [920.612511] [103/142] ( 99s left) i915_pciid [921.175504] [104/142] ( 99s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [921.703644] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [939.522081] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (17.819s) [939.800943] [105/142] ( 80s left) gem_wait (write-busy) [940.256559] Starting subtest: write-busy [940.260481] Starting dynamic subtest: all-engines [940.869754] Dynamic subtest all-engines: SUCCESS (0.610s) [940.948877] Starting dynamic subtest: rcs0 [941.447105] Dynamic subtest rcs0: SUCCESS (0.572s) [941.520897] Starting dynamic subtest: bcs0 [942.034130] Dynamic subtest bcs0: SUCCESS (0.583s) [942.110875] Starting dynamic subtest: vcs0 [943.543905] Dynamic subtest vcs0: SUCCESS (1.504s) [943.614665] Starting dynamic subtest: vcs1 [945.528237] Dynamic subtest vcs1: SUCCESS (1.979s) [945.597600] Starting dynamic subtest: vecs0 [947.511553] Dynamic subtest vecs0: SUCCESS (1.980s) [947.577870] Starting dynamic subtest: ccs0 [948.092103] Dynamic subtest ccs0: SUCCESS (0.577s) [948.095941] Subtest write-busy: SUCCESS (7.838s) [948.494190] [106/142] ( 71s left) kms_rotation_crc (multiplane-rotation-cropping-top) [948.987736] Starting subtest: multiplane-rotation-cropping-top [962.648417] Subtest multiplane-rotation-cropping-top: SUCCESS (13.665s) [962.851095] [107/142] ( 57s left) gem_partial_pwrite_pread (write-display) [963.255311] Subtest write-display: SKIP (0.000s) [963.395658] [108/142] ( 57s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [963.907489] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [974.417449] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (10.517s) [974.718107] [109/142] ( 46s left) gem_exec_balancer (individual) [975.152888] Starting subtest: individual [982.893514] Subtest individual: SUCCESS (7.740s) [983.909961] [110/142] ( 36s left) v3d/v3d_get_param (get-bad-flags) [984.406808] Subtest get-bad-flags: SKIP (0.000s) [984.561773] [111/142] ( 36s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [985.124053] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [985.130865] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [985.307529] [112/142] ( 35s left) kms_big_fb (linear-32bpp-rotate-90) [985.846279] Starting subtest: linear-32bpp-rotate-90 [985.914334] Subtest linear-32bpp-rotate-90: SKIP (0.059s) [986.110745] [113/142] ( 35s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [986.645173] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [986.653297] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [986.807654] [114/142] ( 34s left) kms_invalid_mode (bad-hsync-start) [987.293111] Starting subtest: bad-hsync-start [987.303522] Starting dynamic subtest: eDP-1-pipe-A [987.710594] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.411s) [987.775074] Starting dynamic subtest: eDP-1-pipe-B [987.778820] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.041s) [987.838073] Starting dynamic subtest: eDP-1-pipe-C [987.841885] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.040s) [987.898859] Starting dynamic subtest: eDP-1-pipe-D [987.902666] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.040s) [987.906385] Subtest bad-hsync-start: SUCCESS (0.570s) [988.645552] [115/142] ( 32s left) gem_lmem_swapping (parallel-random-verify-ccs) [989.049430] Subtest parallel-random-verify-ccs: SKIP (0.000s) [989.177770] [116/142] ( 32s left) perf (global-sseu-config) [989.794210] Subtest global-sseu-config: SKIP (0.000s) [989.911711] [117/142] ( 31s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [990.422382] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [995.933681] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (5.520s) [996.249407] [118/142] ( 25s left) kms_addfb_basic (small-bo) [996.736325] Starting subtest: small-bo [996.739855] Subtest small-bo: SUCCESS (0.000s) [996.916934] [119/142] ( 24s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs) [998.093287] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs [998.100479] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s) [998.715651] [120/142] ( 23s left) kms_plane_lowres (tiling-none) [999.223381] Starting subtest: tiling-none [999.226954] Starting dynamic subtest: pipe-A-eDP-1 [999.233309] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [999.710154] Starting dynamic subtest: pipe-B-eDP-1 [999.717249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [999.776945] Starting dynamic subtest: pipe-C-eDP-1 [999.785482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [999.842759] Starting dynamic subtest: pipe-D-eDP-1 [999.850846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [999.858915] Subtest tiling-none: SKIP (0.525s) [1000.603893] [121/142] ( 21s left) gem_create (create-ext-cpu-access-big) [1001.131190] Starting subtest: create-ext-cpu-access-big [1001.138823] Subtest create-ext-cpu-access-big: SKIP (0.002s) [1001.295790] [122/142] ( 20s left) gem_exec_fence (syncobj-unused-fence) [1003.350483] Starting subtest: syncobj-unused-fence [1003.369229] Subtest syncobj-unused-fence: SUCCESS (0.018s) [1003.870265] [123/142] ( 18s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [1005.502637] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [1005.509086] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [1006.289628] [124/142] ( 15s left) kms_async_flips (crc) [1006.767830] Starting subtest: crc [1009.041247] Starting dynamic subtest: pipe-A-eDP-1 [1013.370714] Dynamic subtest pipe-A-eDP-1: FAIL (3.625s) [1014.316799] Starting dynamic subtest: pipe-B-eDP-1 [1017.784333] Dynamic subtest pipe-B-eDP-1: FAIL (2.770s) [1018.886633] Starting dynamic subtest: pipe-C-eDP-1 [1022.575355] Dynamic subtest pipe-C-eDP-1: FAIL (2.994s) [1023.222733] Starting dynamic subtest: pipe-D-eDP-1 [1026.883514] Dynamic subtest pipe-D-eDP-1: FAIL (2.979s) [1026.886801] Subtest crc: FAIL (19.384s) [1027.658594] Overall timeout time exceeded, stopping. [1027.659786] Closing watchdogs Done.