[54.381172] Initializing watchdogs [54.381252] /dev/watchdog0 [54.387848] [001/141] (960s left) kms_selftest (all-tests) [54.562310] Starting subtest: all-tests [54.565452] Subtest all-tests: SKIP (0.000s) [54.608160] [002/141] (960s left) drm_fdinfo (busy) [54.687803] Subtest busy: SKIP (0.000s) [54.713873] [003/141] (960s left) gem_ctx_isolation (dirty-create) [54.791772] Starting subtest: dirty-create [54.793514] Starting dynamic subtest: rcs0 [55.418804] Dynamic subtest rcs0: SUCCESS (0.627s) [55.424111] Starting dynamic subtest: bcs0 [56.112887] Dynamic subtest bcs0: SUCCESS (0.694s) [56.118065] Starting dynamic subtest: vcs0 [56.857578] Dynamic subtest vcs0: SUCCESS (0.745s) [56.862717] Starting dynamic subtest: vcs1 [57.607222] Dynamic subtest vcs1: SUCCESS (0.749s) [57.612186] Starting dynamic subtest: vecs0 [58.335665] Dynamic subtest vecs0: SUCCESS (0.728s) [58.337218] Subtest dirty-create: SUCCESS (3.544s) [58.625455] [004/141] (956s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs) [60.980939] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs [60.982446] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [61.109685] [005/141] (953s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75) [63.085188] Starting subtest: plane-downscale-with-pixel-format-factor-0-75 [63.087296] Starting dynamic subtest: pipe-A-HDMI-A-4 [85.058625] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (21.973s) [85.064159] Starting dynamic subtest: pipe-B-HDMI-A-4 [106.827829] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (21.767s) [106.833382] Starting dynamic subtest: pipe-C-HDMI-A-4 [107.116746] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.287s) [107.122302] Starting dynamic subtest: pipe-D-HDMI-A-4 [107.405171] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.287s) [107.406800] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (44.321s) [107.543514] [006/141] (907s left) perf (invalid-oa-metric-set-id) [107.672723] Starting subtest: invalid-oa-metric-set-id [107.689597] Subtest invalid-oa-metric-set-id: SUCCESS (0.018s) [107.706381] [007/141] (907s left) gem_exec_reloc (basic-write-read-active) [107.780094] Subtest basic-write-read-active: SKIP (0.000s) [107.832846] [008/141] (907s left) gem_exec_whisper (basic-forked-all) [107.911489] Starting subtest: basic-forked-all [119.585597] Subtest basic-forked-all: SUCCESS (11.672s) [119.803539] [009/141] (895s left) kms_universal_plane (universal-plane-pipe-a-sanity) [121.810602] Starting subtest: universal-plane-pipe-A-sanity [122.383340] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.572s) [122.514737] [010/141] (892s left) syncobj_wait (invalid-single-wait-unsubmitted) [122.586921] Starting subtest: invalid-single-wait-unsubmitted [122.588280] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [122.646802] [011/141] (892s left) kms_prop_blob (invalid-get-prop-any) [122.714781] Starting subtest: invalid-get-prop-any [122.716193] Subtest invalid-get-prop-any: SUCCESS (0.000s) [122.784583] [012/141] (892s left) gem_mmap_wc (pf-nonblock) [122.859743] Subtest pf-nonblock: SKIP (0.000s) [122.889860] [013/141] (892s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs) [124.950582] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs [124.955149] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s) [125.372148] [014/141] (889s left) kms_cursor_legacy (forked-bo) [127.344954] Starting subtest: forked-bo [127.346674] Starting dynamic subtest: pipe-A [148.871803] Dynamic subtest pipe-A: SUCCESS (21.523s) [148.879945] Starting dynamic subtest: pipe-B [170.410860] Dynamic subtest pipe-B: SUCCESS (21.538s) [170.420695] Starting dynamic subtest: pipe-C [191.960223] Dynamic subtest pipe-C: SUCCESS (21.554s) [191.968985] Starting dynamic subtest: pipe-D [213.516918] Dynamic subtest pipe-D: SUCCESS (21.554s) [213.525738] Starting dynamic subtest: all-pipes [235.051450] Dynamic subtest all-pipes: SUCCESS (21.534s) [235.052312] Subtest forked-bo: SUCCESS (107.705s) [235.114588] [015/141] (779s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [237.110915] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [237.111798] Starting dynamic subtest: pipe-A-valid-mode [237.151067] Dynamic subtest pipe-A-valid-mode: SKIP (0.039s) [237.152664] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.041s) [237.235805] [016/141] (777s left) kms_psr (dpms) [237.305978] Subtest dpms: SKIP (0.000s) [237.327709] [017/141] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [239.309040] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [239.310998] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [239.368775] [018/141] (775s left) gem_spin_batch (resubmit-new) [239.451051] Starting subtest: resubmit-new [239.452160] Starting dynamic subtest: rcs0 [239.472849] Dynamic subtest rcs0: SUCCESS (0.022s) [239.478292] Starting dynamic subtest: bcs0 [239.479276] Dynamic subtest bcs0: SUCCESS (0.004s) [239.484361] Starting dynamic subtest: vcs0 [239.485256] Dynamic subtest vcs0: SUCCESS (0.004s) [239.490285] Starting dynamic subtest: vcs1 [239.491211] Dynamic subtest vcs1: SUCCESS (0.004s) [239.496591] Starting dynamic subtest: vecs0 [239.497857] Dynamic subtest vecs0: SUCCESS (0.004s) [239.499164] Subtest resubmit-new: SUCCESS (0.036s) [239.756911] [019/141] (775s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [241.896235] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [241.897131] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s) [242.278502] [020/141] (772s left) gem_softpin (noreloc-interruptible) [242.351581] Starting subtest: noreloc-interruptible [247.797263] Subtest noreloc-interruptible: SUCCESS (5.443s) [247.880499] [021/141] (767s left) kms_lease (lease_unleased_crtc) [249.854473] Starting subtest: lease_unleased_crtc [249.855533] Starting dynamic subtest: pipe-A-HDMI-A-4 [249.918973] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.064s) [249.927975] Starting dynamic subtest: pipe-B-HDMI-A-4 [249.984841] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.062s) [249.996893] Starting dynamic subtest: pipe-C-HDMI-A-4 [250.047672] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.061s) [250.054988] Starting dynamic subtest: pipe-D-HDMI-A-4 [250.112473] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.062s) [250.113388] Subtest lease_unleased_crtc: SUCCESS (0.259s) [250.198381] [022/141] (765s left) syncobj_wait (single-wait-all-for-submit-signaled) [250.266995] Starting subtest: single-wait-all-for-submit-signaled [250.267862] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [250.331256] [023/141] (764s left) vgem_basic (bad-fence) [250.434500] Starting subtest: bad-fence [250.435341] Subtest bad-fence: SUCCESS (0.000s) [250.481343] [024/141] (764s left) kms_big_joiner (2x-modeset) [252.453463] Subtest 2x-modeset: SKIP (0.000s) [252.473715] [025/141] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [254.451244] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [254.453213] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [254.514887] [026/141] (760s left) gen9_exec_parse (valid-registers) [254.594208] Subtest valid-registers: SKIP (0.000s) [254.623270] [027/141] (760s left) gem_mmap_gtt (close-race) [254.692930] Subtest close-race: SKIP (0.000s) [254.723956] [028/141] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [256.705518] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [256.707675] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [256.764913] [029/141] (758s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [258.757796] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [259.864413] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.106s) [259.984849] [030/141] (755s left) gem_mmap_gtt (basic-small-copy-odd) [260.054360] Subtest basic-small-copy-odd: SKIP (0.000s) [260.076050] [031/141] (755s left) kms_vblank (pipe-b-query-forked-hang) [262.048579] Starting subtest: pipe-B-query-forked-hang [275.870511] Subtest pipe-B-query-forked-hang: SUCCESS (13.820s) [275.978203] [032/141] (739s left) perf (invalid-create-userspace-config) [276.105172] Starting subtest: invalid-create-userspace-config [276.107053] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [276.126880] [033/141] (739s left) perf (mi-rpc) [276.252691] Starting subtest: mi-rpc [276.254615] Subtest mi-rpc: SKIP (0.000s) [276.276080] [034/141] (739s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [278.357944] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc [278.359760] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [278.763748] [035/141] (736s left) gem_ccs (block-multicopy-compressed) [278.836441] Starting subtest: block-multicopy-compressed [278.838102] Subtest block-multicopy-compressed: SKIP (0.000s) [278.897451] [036/141] (736s left) kms_big_fb (y-tiled-8bpp-rotate-0) [280.885498] Starting subtest: y-tiled-8bpp-rotate-0 [282.486623] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.597s) [282.582957] [037/141] (732s left) feature_discovery (display-4x) [284.577111] Starting subtest: display-4x [284.579089] Subtest display-4x: SKIP (0.000s) [284.630248] [038/141] (730s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [286.609892] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [289.466055] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.859s) [289.597513] [039/141] (725s left) api_intel_bb (reset-flags) [289.666047] Starting subtest: reset-flags [289.685934] Subtest reset-flags: SUCCESS (0.020s) [289.781286] [040/141] (725s left) v3d/v3d_submit_cl (single-in-sync) [289.882270] Subtest single-in-sync: SKIP (0.000s) [289.932490] [041/141] (725s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [291.924045] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [291.926193] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [291.996508] [042/141] (723s left) kms_properties (invalid-properties-legacy) [293.993181] Starting subtest: invalid-properties-legacy [294.495376] Subtest invalid-properties-legacy: SUCCESS (0.500s) [294.545656] [043/141] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [296.523093] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [296.525086] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [296.613733] [044/141] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [298.618121] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [298.620045] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [298.695304] [045/141] (716s left) gem_exec_schedule (u-fairslice-all) [298.794309] Starting subtest: u-fairslice-all [300.858131] Subtest u-fairslice-all: SUCCESS (2.064s) [301.250254] [046/141] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [303.268593] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [303.270578] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [303.344999] [047/141] (712s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [305.335283] Starting subtest: primary-y-tiled-reflect-x-0 [315.724926] Subtest primary-y-tiled-reflect-x-0: SUCCESS (10.390s) [315.887275] [048/141] (699s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [317.898009] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [317.953392] [049/141] (697s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [319.934089] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [322.911277] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.978s) [323.024627] [050/141] (692s left) gem_exec_big (single) [323.097824] Starting subtest: single [329.840279] Subtest single: SUCCESS (6.739s) [330.885946] [051/141] (684s left) kms_flip (2x-flip-vs-panning) [331.957253] Starting subtest: 2x-flip-vs-panning [331.982521] Subtest 2x-flip-vs-panning: SKIP (0.025s) [332.057583] [052/141] (683s left) kms_cursor_crc (cursor-random-128x42) [334.172284] Starting subtest: cursor-random-128x42 [334.179804] Starting dynamic subtest: pipe-A-HDMI-A-4 [338.864998] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.686s) [338.890461] Starting dynamic subtest: pipe-D-HDMI-A-4 [344.257759] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.374s) [344.258846] Subtest cursor-random-128x42: SUCCESS (10.086s) [344.565987] [053/141] (671s left) gem_exec_fence (invalid-timeline-fence-array) [345.142088] Starting subtest: invalid-timeline-fence-array [345.151863] Subtest invalid-timeline-fence-array: SUCCESS (0.012s) [345.384077] [054/141] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [347.374487] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [347.376634] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [347.448616] [055/141] (668s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [349.491668] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [349.551788] [056/141] (666s left) gem_ctx_shared (q-promotion) [349.630443] Starting subtest: Q-promotion [349.631439] Starting dynamic subtest: rcs0 [349.799921] Dynamic subtest rcs0: SUCCESS (0.166s) [349.805427] Starting dynamic subtest: bcs0 [349.909398] Dynamic subtest bcs0: SUCCESS (0.112s) [349.915076] Starting dynamic subtest: vcs0 [350.027245] Dynamic subtest vcs0: SUCCESS (0.115s) [350.032837] Starting dynamic subtest: vcs1 [350.143126] Dynamic subtest vcs1: SUCCESS (0.115s) [350.148689] Starting dynamic subtest: vecs0 [350.270012] Dynamic subtest vecs0: SUCCESS (0.127s) [350.270864] Subtest Q-promotion: SUCCESS (0.637s) [350.571190] [057/141] (665s left) i915_module_load (reload-no-display) [350.673852] Starting subtest: reload-no-display [353.646737] Subtest reload-no-display: SUCCESS (2.968s) [353.683099] [058/141] (662s left) kms_draw_crc (draw-method-mmap-gtt) [359.000160] Starting subtest: draw-method-mmap-gtt [359.002519] Subtest draw-method-mmap-gtt: SKIP (0.000s) [359.101411] [059/141] (656s left) i915_pm_rpm (universal-planes) [363.501223] Starting subtest: universal-planes [363.508216] Starting dynamic subtest: plane-31 [377.153557] Dynamic subtest plane-31: SUCCESS (13.651s) [377.159192] Starting dynamic subtest: plane-40 [394.049266] Dynamic subtest plane-40: SUCCESS (16.895s) [394.055159] Starting dynamic subtest: plane-49 [409.058713] Dynamic subtest plane-49: SUCCESS (15.006s) [409.070026] Starting dynamic subtest: plane-58 [423.035687] Dynamic subtest plane-58: SUCCESS (13.976s) [423.045724] Starting dynamic subtest: plane-67 [440.006472] Dynamic subtest plane-67: SUCCESS (16.970s) [440.016354] Starting dynamic subtest: plane-76 [455.894658] Dynamic subtest plane-76: SUCCESS (15.889s) [455.907444] Starting dynamic subtest: plane-85 [469.924486] Dynamic subtest plane-85: SUCCESS (14.027s) [469.937812] Starting dynamic subtest: plane-94 [486.977034] Dynamic subtest plane-94: SUCCESS (17.054s) [486.978386] Subtest universal-planes: SUCCESS (123.477s) [488.132846] [060/141] (527s left) sw_sync (timeline_closed) [488.201940] Starting subtest: timeline_closed [488.202955] Subtest timeline_closed: SUCCESS (0.000s) [488.249329] [061/141] (527s left) gem_exec_suspend (basic-s3-devices) [488.331748] Starting subtest: basic-S3-devices [488.332739] Starting dynamic subtest: smem [498.004459] Dynamic subtest smem: SUCCESS (9.672s) [498.011133] Starting dynamic subtest: lmem0 [507.274617] Dynamic subtest lmem0: SUCCESS (9.269s) [507.275884] Subtest basic-S3-devices: SUCCESS (18.943s) [510.554211] [062/141] (508s left) gem_wait (busy) [510.662631] Starting subtest: busy [510.663615] Starting dynamic subtest: all-engines [511.221374] Dynamic subtest all-engines: SUCCESS (0.558s) [511.228115] Starting dynamic subtest: rcs0 [511.759778] Dynamic subtest rcs0: SUCCESS (0.538s) [511.766381] Starting dynamic subtest: bcs0 [512.303097] Dynamic subtest bcs0: SUCCESS (0.542s) [512.312527] Starting dynamic subtest: vcs0 [512.842608] Dynamic subtest vcs0: SUCCESS (0.539s) [512.849167] Starting dynamic subtest: vcs1 [513.381367] Dynamic subtest vcs1: SUCCESS (0.538s) [513.391122] Starting dynamic subtest: vecs0 [513.922083] Dynamic subtest vecs0: SUCCESS (0.539s) [513.923316] Subtest busy: SUCCESS (3.259s) [514.187506] [063/141] (504s left) kms_writeback (writeback-fb-id) [518.098850] Subtest writeback-fb-id: SKIP (0.000s) [518.130033] [064/141] (500s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [518.203971] Starting subtest: legacy-engines-hostile-preempt [518.205192] Starting dynamic subtest: render [518.257642] Dynamic subtest render: SUCCESS (0.053s) [518.267633] Starting dynamic subtest: bsd1 [518.300163] Dynamic subtest bsd1: SUCCESS (0.041s) [518.330122] Starting dynamic subtest: bsd2 [518.360781] Dynamic subtest bsd2: SUCCESS (0.058s) [518.394703] Starting dynamic subtest: blt [518.423043] Dynamic subtest blt: SUCCESS (0.059s) [518.440656] Starting dynamic subtest: vebox [518.478152] Dynamic subtest vebox: SUCCESS (0.053s) [518.479997] Subtest legacy-engines-hostile-preempt: SUCCESS (0.273s) [518.613114] [065/141] (500s left) kms_rotation_crc (sprite-rotation-180) [520.625763] Starting subtest: sprite-rotation-180 [528.278305] Subtest sprite-rotation-180: SUCCESS (7.658s) [528.431346] [066/141] (490s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs) [530.710555] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs [530.712716] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [530.935803] [067/141] (488s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [532.926177] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [532.928258] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [533.000494] [068/141] (485s left) gem_pwrite (basic-exhaustion) [533.097549] Subtest basic-exhaustion: SKIP (0.000s) [533.141822] [069/141] (485s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs) [535.455139] Starting subtest: pipe-D-bad-pixel-format-y_tiled_ccs [535.457047] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [535.639441] [070/141] (483s left) kms_big_fb (x-tiled-32bpp-rotate-0) [537.623012] Starting subtest: x-tiled-32bpp-rotate-0 [539.476858] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.850s) [539.613332] [071/141] (479s left) gem_workarounds (reset-context) [539.698149] Starting subtest: reset-context [539.860968] Subtest reset-context: SUCCESS (0.162s) [539.982239] [072/141] (479s left) kms_setmode (basic-clone-single-crtc) [540.050488] Starting subtest: basic-clone-single-crtc [540.053038] Subtest basic-clone-single-crtc: SKIP (0.000s) [540.110651] [073/141] (478s left) gem_exec_schedule (pi-common) [540.316714] Starting subtest: pi-common [540.317735] Starting dynamic subtest: rcs0 [540.402167] Dynamic subtest rcs0: SUCCESS (0.087s) [540.419156] Starting dynamic subtest: bcs0 [540.502488] Dynamic subtest bcs0: SUCCESS (0.098s) [540.533368] Starting dynamic subtest: vcs0 [540.600636] Dynamic subtest vcs0: SUCCESS (0.097s) [540.609498] Starting dynamic subtest: vcs1 [540.676835] Dynamic subtest vcs1: SUCCESS (0.075s) [540.690061] Starting dynamic subtest: vecs0 [540.769553] Dynamic subtest vecs0: SUCCESS (0.092s) [540.770835] Subtest pi-common: SUCCESS (0.456s) [541.006493] [074/141] (478s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [543.010841] Starting subtest: cursorB-vs-flipB-legacy [543.012781] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s) [543.072476] [075/141] (476s left) kms_vblank (pipe-d-wait-forked) [545.058452] Starting subtest: pipe-D-wait-forked [548.467564] Subtest pipe-D-wait-forked: SUCCESS (3.410s) [548.583717] [076/141] (470s left) sysfs_heartbeat_interval (precise) [548.659156] Starting subtest: precise [548.660110] Starting dynamic subtest: vecs0 [549.959645] Dynamic subtest vecs0: SUCCESS (1.299s) [549.970044] Starting dynamic subtest: vcs0 [551.243110] Dynamic subtest vcs0: SUCCESS (1.282s) [551.250674] Starting dynamic subtest: bcs0 [554.332443] Dynamic subtest bcs0: SUCCESS (3.089s) [554.340248] Starting dynamic subtest: rcs0 [557.321786] Dynamic subtest rcs0: SUCCESS (2.988s) [557.331434] Starting dynamic subtest: vcs1 [558.513151] Dynamic subtest vcs1: SUCCESS (1.190s) [558.514094] Subtest precise: SUCCESS (9.853s) [558.623778] [077/141] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [560.603174] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [560.605133] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [560.683330] [078/141] (458s left) vc4/vc4_perfmon (create-single-perfmon) [560.816073] Subtest create-single-perfmon: SKIP (0.000s) [560.900374] [079/141] (458s left) kms_content_protection (type1) [562.936516] Starting subtest: type1 [563.205206] Subtest type1: SKIP (0.265s) [563.356373] [080/141] (455s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [565.336410] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [565.338329] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [565.423744] [081/141] (453s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs) [565.529100] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs [565.530107] Starting dynamic subtest: smem [565.619851] Dynamic subtest smem: SUCCESS (0.090s) [565.629455] Starting dynamic subtest: lmem0 [566.734338] Dynamic subtest lmem0: SUCCESS (1.111s) [566.735314] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (1.202s) [566.968380] [082/141] (452s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend) [568.940959] Starting subtest: pipe-A-ts-continuation-dpms-suspend [589.149028] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (9.184s) [593.265822] [083/141] (441s left) kms_atomic_interruptible (legacy-dpms) [595.244766] Starting subtest: legacy-dpms [595.245978] Starting dynamic subtest: HDMI-A-4-pipe-A [601.430451] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (6.185s) [601.431355] Subtest legacy-dpms: SUCCESS (6.187s) [601.552194] [084/141] (432s left) kms_chamelium_color (gamma) [603.531839] Subtest gamma: SKIP (0.000s) [603.560303] [085/141] (430s left) syncobj_timeline (reset-multiple-signaled) [603.632832] Starting subtest: reset-multiple-signaled [603.633991] Subtest reset-multiple-signaled: SUCCESS (0.001s) [603.745974] [086/141] (430s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [603.829519] Starting subtest: invalid-multi-wait-unsubmitted-submitted [603.830664] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [603.885919] [087/141] (430s left) perf_pmu (busy-hang) [603.961342] Starting subtest: busy-hang [603.962467] Starting dynamic subtest: rcs0 [605.165834] Dynamic subtest rcs0: SUCCESS (1.204s) [605.175068] Starting dynamic subtest: bcs0 [606.348195] Dynamic subtest bcs0: SUCCESS (1.180s) [606.358950] Starting dynamic subtest: vcs0 [607.522775] Dynamic subtest vcs0: SUCCESS (1.173s) [607.531912] Starting dynamic subtest: vcs1 [608.702760] Dynamic subtest vcs1: SUCCESS (1.179s) [608.712389] Starting dynamic subtest: vecs0 [609.877682] Dynamic subtest vecs0: SUCCESS (1.174s) [609.878506] Subtest busy-hang: SUCCESS (5.917s) [609.936679] [088/141] (424s left) prime_vgem (wait) [610.036765] Starting subtest: wait [610.037667] Starting dynamic subtest: rcs0 [610.077266] Dynamic subtest rcs0: SUCCESS (0.040s) [610.087203] Starting dynamic subtest: bcs0 [610.122766] Dynamic subtest bcs0: SUCCESS (0.045s) [610.138569] Starting dynamic subtest: vcs0 [610.164446] Dynamic subtest vcs0: SUCCESS (0.040s) [610.186723] Starting dynamic subtest: vcs1 [610.207248] Dynamic subtest vcs1: SUCCESS (0.041s) [610.228764] Starting dynamic subtest: vecs0 [610.247806] Dynamic subtest vecs0: SUCCESS (0.039s) [610.249034] Subtest wait: SUCCESS (0.211s) [610.367808] [089/141] (424s left) kms_addfb_basic (basic) [610.436365] Starting subtest: basic [610.437204] Subtest basic: SUCCESS (0.000s) [612.454486] [090/141] (421s left) syncobj_wait (single-wait-for-submit-unsubmitted) [612.563835] Starting subtest: single-wait-for-submit-unsubmitted [612.672268] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s) [612.770833] [091/141] (421s left) gem_wait (invalid-buf) [612.880023] Starting subtest: invalid-buf [612.880927] Subtest invalid-buf: SUCCESS (0.000s) [613.139677] [092/141] (421s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [615.118802] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [615.120690] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [615.201444] [093/141] (419s left) perf (disabled-read-error) [615.363551] Starting subtest: disabled-read-error [615.397830] Subtest disabled-read-error: SUCCESS (0.036s) [615.433030] [094/141] (419s left) gem_linear_blits (basic) [615.851224] Starting subtest: basic [615.869603] Subtest basic: SUCCESS (0.019s) [616.013027] [095/141] (418s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [618.362401] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc [618.366536] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.003s) [618.569263] [096/141] (415s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [620.725383] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc [620.831999] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.109s) [621.200668] [097/141] (413s left) kms_big_fb (x-tiled-64bpp-rotate-270) [623.193994] Starting subtest: x-tiled-64bpp-rotate-270 [623.243201] Subtest x-tiled-64bpp-rotate-270: SKIP (0.047s) [623.333973] [098/141] (411s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs) [625.469689] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs [625.914972] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.445s) [626.353363] [099/141] (408s left) kms_addfb_basic (basic-x-tiled-legacy) [626.423151] Starting subtest: basic-x-tiled-legacy [626.424959] Subtest basic-x-tiled-legacy: SKIP (0.000s) [628.403624] [100/141] (406s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc) [630.484667] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc [630.486581] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [630.937129] [101/141] (403s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs) [632.961964] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs [632.964008] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SKIP (0.000s) [633.441541] [102/141] (401s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [635.427253] Starting subtest: psr-farfromfence-mmap-gtt [635.429387] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [635.492188] [103/141] (399s left) i915_pm_freq_api (freq-basic-api) [635.579526] Starting subtest: freq-basic-api [635.580720] Starting dynamic subtest: gt0 [635.585021] Dynamic subtest gt0: SUCCESS (0.005s) [635.586136] Subtest freq-basic-api: SUCCESS (0.006s) [635.705131] [104/141] (399s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25) [637.689837] Starting subtest: plane-upscale-with-rotation-factor-0-25 [637.690988] Starting dynamic subtest: pipe-A-HDMI-A-4 [637.771183] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.079s) [637.780649] Starting dynamic subtest: pipe-B-HDMI-A-4 [637.859427] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.086s) [637.868885] Starting dynamic subtest: pipe-C-HDMI-A-4 [637.947247] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.087s) [637.957870] Starting dynamic subtest: pipe-D-HDMI-A-4 [638.039722] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.089s) [638.041403] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.350s) [638.197562] [105/141] (396s left) gem_exec_balancer (full-late) [638.276840] Starting subtest: full-late [639.787688] Subtest full-late: SUCCESS (1.511s) [640.116475] [106/141] (394s left) gem_tiling_max_stride [640.223430] [107/141] (394s left) kms_addfb_basic (size-max) [642.199516] Starting subtest: size-max [642.200652] Subtest size-max: SUCCESS (0.000s) [642.281411] [108/141] (392s left) perf (rc6-disable) [642.440412] Starting subtest: rc6-disable [642.660864] Subtest rc6-disable: SUCCESS (0.220s) [642.750368] [109/141] (392s left) kms_atomic (plane-primary-legacy) [644.957954] Starting subtest: plane-primary-legacy [645.301449] Subtest plane-primary-legacy: SUCCESS (0.342s) [645.490893] [110/141] (389s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [645.561629] Starting subtest: multi-wait-for-submit-available-signaled [645.562498] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [645.623338] [111/141] (389s left) v3d/v3d_perfmon (create-two-perfmon) [645.721800] Subtest create-two-perfmon: SKIP (0.000s) [645.774684] [112/141] (389s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [648.017052] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs [648.366781] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SUCCESS (0.350s) [648.671477] [113/141] (386s left) gem_softpin (allocator-nopin) [648.745271] Starting subtest: allocator-nopin [648.957991] Subtest allocator-nopin: SUCCESS (0.210s) [649.054789] [114/141] (385s left) v3d/v3d_wait_bo (bad-pad) [649.153135] Subtest bad-pad: SKIP (0.000s) [649.204668] [115/141] (385s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [651.184725] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [651.186824] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [651.255338] [116/141] (383s left) kms_vblank (pipe-b-wait-forked-busy-hang) [653.247869] Starting subtest: pipe-B-wait-forked-busy-hang [667.877431] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (14.628s) [667.988114] [117/141] (367s left) i915_pm_rps (min-max-config-idle) [668.061840] Starting subtest: min-max-config-idle [668.063434] Subtest min-max-config-idle: SKIP (0.000s) [668.121066] [118/141] (366s left) syncobj_basic (test-valid-cycle) [668.188965] Starting subtest: test-valid-cycle [668.189845] Subtest test-valid-cycle: SUCCESS (0.000s) [668.256272] [119/141] (366s left) kms_cursor_crc (cursor-rapid-movement-128x128) [670.348304] Starting subtest: cursor-rapid-movement-128x128 [670.356055] Starting dynamic subtest: pipe-A-HDMI-A-4 [670.824389] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.469s) [670.854316] Starting dynamic subtest: pipe-D-HDMI-A-4 [672.253011] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.408s) [672.255901] Subtest cursor-rapid-movement-128x128: SUCCESS (1.902s) [672.587327] [120/141] (362s left) api_intel_bb (bb-with-allocator) [672.660952] Starting subtest: bb-with-allocator [672.675954] Subtest bb-with-allocator: SUCCESS (0.016s) [672.770575] [121/141] (362s left) syncobj_timeline (etime-single-wait-submitted) [672.840592] Starting subtest: etime-single-wait-submitted [672.950672] Subtest etime-single-wait-submitted: SUCCESS (0.108s) [673.019457] [122/141] (362s left) gem_exec_schedule (independent) [673.100661] Starting subtest: independent [673.101484] Starting dynamic subtest: rcs0 [673.323906] Dynamic subtest rcs0: SUCCESS (0.223s) [673.333222] Starting dynamic subtest: bcs0 [673.513713] Dynamic subtest bcs0: SUCCESS (0.189s) [673.523031] Starting dynamic subtest: vcs0 [673.706723] Dynamic subtest vcs0: SUCCESS (0.192s) [673.715883] Starting dynamic subtest: vcs1 [673.893630] Dynamic subtest vcs1: SUCCESS (0.186s) [673.903109] Starting dynamic subtest: vecs0 [674.078667] Dynamic subtest vecs0: SUCCESS (0.184s) [674.079560] Subtest independent: SUCCESS (0.979s) [674.386329] [123/141] (360s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [676.367739] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [676.369968] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [676.453784] [124/141] (358s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [678.790119] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [678.792086] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [678.969258] [125/141] (356s left) gem_exec_fence (syncobj-timeline-invalid-flags) [679.446095] Starting subtest: syncobj-timeline-invalid-flags [679.446982] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [679.677881] [126/141] (355s left) kms_psr (psr2_cursor_blt) [679.746903] Subtest psr2_cursor_blt: SKIP (0.000s) [679.778213] [127/141] (355s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs) [681.934200] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs [681.936429] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s) [682.262543] [128/141] (352s left) gem_exec_flush (basic-wb-ro-default) [682.336256] Subtest basic-wb-ro-default: SKIP (0.000s) [682.387805] [129/141] (352s left) gem_partial_pwrite_pread (reads-uncached) [682.461167] Subtest reads-uncached: SKIP (0.000s) [682.504571] [130/141] (352s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [684.487730] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [684.489990] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [684.563412] [131/141] (350s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs) [686.921364] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs [686.923216] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s) [687.078642] [132/141] (348s left) kms_frontbuffer_tracking (psr-slowdraw) [689.058019] Starting subtest: psr-slowdraw [689.059946] Subtest psr-slowdraw: SKIP (0.000s) [689.145885] [133/141] (346s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt) [691.164723] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt [691.166940] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [691.229033] [134/141] (344s left) gem_lmem_swapping (heavy-verify-random) [695.354604] Starting subtest: heavy-verify-random [695.355434] Starting dynamic subtest: lmem0 [712.622852] Dynamic subtest lmem0: SUCCESS (17.265s) [712.623647] Subtest heavy-verify-random: SUCCESS (17.266s) [714.465260] [135/141] (320s left) gem_userptr_blits (readonly-unsync) [716.977056] Subtest readonly-unsync: SKIP (0.000s) [717.947040] [136/141] (317s left) syncobj_wait (invalid-wait-bad-flags) [718.021978] Starting subtest: invalid-wait-bad-flags [718.022773] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [718.093075] [137/141] (317s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [720.113273] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [720.115627] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [720.210839] [138/141] (315s left) kms_plane_alpha_blend (alpha-transparent-fb) [722.221712] Starting subtest: alpha-transparent-fb [722.457671] Starting dynamic subtest: pipe-A-HDMI-A-4 [722.929096] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.473s) [722.938619] Starting dynamic subtest: pipe-D-HDMI-A-4 [723.393549] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.462s) [723.394446] Subtest alpha-transparent-fb: SUCCESS (1.174s) [723.533304] [139/141] (311s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [724.565034] Starting subtest: 2x-wf_vblank-ts-check-interruptible [724.591846] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.026s) [724.666372] [140/141] (310s left) kms_plane (plane-position-hole-dpms) [726.681046] Starting subtest: plane-position-hole-dpms [726.683871] Starting dynamic subtest: pipe-A-planes [729.536403] Dynamic subtest pipe-A-planes: SUCCESS (2.852s) [729.549206] Starting dynamic subtest: pipe-B-planes [732.517236] Dynamic subtest pipe-B-planes: SUCCESS (2.978s) [732.518322] Subtest plane-position-hole-dpms: SUCCESS (5.836s) [732.644041] [141/141] (302s left) kms_force_connector_basic (force-connector-state) [732.778504] Starting subtest: force-connector-state [736.451912] Subtest force-connector-state: SUCCESS (3.674s) [738.691563] Closing watchdogs Done.