[32.502623] Initializing watchdogs [32.502854] /dev/watchdog0 [32.535125] [001/136] (960s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [33.045592] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [33.373744] [002/136] (959s left) syncobj_basic (bad-flags-handle-to-fd) [33.658306] Starting subtest: bad-flags-handle-to-fd [33.677095] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [33.773982] [003/136] (959s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [34.141756] Starting subtest: plane-use-after-nonblocking-unbind-fencing [34.164071] Starting dynamic subtest: pipe-A-DP-1 [34.297894] Dynamic subtest pipe-A-DP-1: SUCCESS (0.159s) [34.399057] Starting dynamic subtest: pipe-B-DP-1 [34.941807] Dynamic subtest pipe-B-DP-1: SUCCESS (0.573s) [35.025994] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.897s) [35.372601] [004/136] (957s left) gem_exec_balancer (sliced) [35.664990] Starting subtest: sliced [39.411806] Subtest sliced: SUCCESS (3.719s) [43.405777] [005/136] (949s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [43.842546] Starting subtest: psr-rgb565-draw-mmap-wc [43.879564] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s) [43.984131] [006/136] (949s left) gem_mmap_gtt (medium-copy-odd) [44.240689] Starting subtest: medium-copy-odd [51.086903] Subtest medium-copy-odd: SUCCESS (6.841s) [51.174917] [007/136] (942s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc) [52.070109] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [52.385165] [008/136] (941s left) kms_getfb (getfb2-accept-ccs) [52.670640] Starting subtest: getfb2-accept-ccs [52.691961] Subtest getfb2-accept-ccs: SUCCESS (0.000s) [52.795881] [009/136] (940s left) gen7_exec_parse (batch-without-end) [53.078175] Subtest batch-without-end: SKIP (0.000s) [53.176483] [010/136] (940s left) gem_exec_reloc (basic-scanout) [53.568376] Starting subtest: basic-scanout [53.589841] Starting dynamic subtest: rcs0 [54.106639] Dynamic subtest rcs0: SUCCESS (0.525s) [54.139415] Starting dynamic subtest: bcs0 [54.287778] Dynamic subtest bcs0: SUCCESS (0.166s) [54.320702] Starting dynamic subtest: vcs0 [54.453431] Dynamic subtest vcs0: SUCCESS (0.166s) [54.486423] Starting dynamic subtest: vecs0 [54.618476] Dynamic subtest vecs0: SUCCESS (0.169s) [54.640131] Subtest basic-scanout: SUCCESS (1.027s) [54.723821] [011/136] (939s left) kms_concurrent (pipe-c) [55.088367] Starting subtest: pipe-C [55.107058] Starting dynamic subtest: DP-1 [55.893662] Dynamic subtest DP-1: SUCCESS (0.806s) [55.915067] Subtest pipe-C: SUCCESS (0.809s) [56.202241] [012/136] (937s left) i915_pm_rpm (legacy-planes) [58.148050] Starting subtest: legacy-planes [58.171707] Starting dynamic subtest: plane-39 [60.975310] Dynamic subtest plane-39: SUCCESS (2.821s) [61.014432] Starting dynamic subtest: plane-47 [63.774418] Dynamic subtest plane-47: SUCCESS (2.805s) [63.793469] Subtest legacy-planes: SUCCESS (5.627s) [64.254915] [013/136] (929s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [64.947459] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [65.271964] [014/136] (928s left) kms_flip (flip-vs-rmfb) [65.632635] Starting subtest: flip-vs-rmfb [65.652321] Starting dynamic subtest: A-DP1 [76.118500] Dynamic subtest A-DP1: SUCCESS (10.518s) [76.152693] Starting dynamic subtest: B-DP1 [86.602436] Dynamic subtest B-DP1: SUCCESS (10.480s) [86.637721] Starting dynamic subtest: C-DP1 [97.024577] Dynamic subtest C-DP1: SUCCESS (10.425s) [97.043509] Subtest flip-vs-rmfb: SUCCESS (31.431s) [97.500371] [015/136] (896s left) syncobj_wait (multi-wait-all-for-submit-signaled) [97.860036] Starting subtest: multi-wait-all-for-submit-signaled [97.889333] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [98.015160] [016/136] (896s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [98.380106] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [104.129076] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (5.735s) [104.480050] [017/136] (890s left) gem_exec_flush (basic-uc-rw-default) [104.790163] Starting subtest: basic-uc-rw-default [110.235898] Subtest basic-uc-rw-default: SUCCESS (5.458s) [110.465550] [018/136] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [110.869104] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [110.912468] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [111.020636] [019/136] (883s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [111.623640] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [111.666465] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [112.060780] [020/136] (882s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [112.453127] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [112.495874] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [112.602696] [021/136] (882s left) gem_mmap_wc (write-prefaulted) [112.866854] Starting subtest: write-prefaulted [113.140259] Subtest write-prefaulted: SUCCESS (0.288s) [113.273114] [022/136] (881s left) gem_readwrite (new-obj) [113.522070] Starting subtest: new-obj [113.562407] Subtest new-obj: SUCCESS (0.000s) [113.669129] [023/136] (881s left) syncobj_timeline (device-submit-unordered) [113.927631] Starting subtest: device-submit-unordered [113.948525] Subtest device-submit-unordered: SUCCESS (0.001s) [114.051273] [024/136] (881s left) gem_exec_async (forked-writes) [114.336226] Starting subtest: forked-writes [114.356059] Starting dynamic subtest: rcs0 [114.395287] Dynamic subtest rcs0: SUCCESS (0.068s) [114.432125] Starting dynamic subtest: bcs0 [114.453804] Dynamic subtest bcs0: SUCCESS (0.059s) [114.490733] Starting dynamic subtest: vcs0 [114.532212] Dynamic subtest vcs0: SUCCESS (0.061s) [114.567413] Starting dynamic subtest: vecs0 [114.586163] Dynamic subtest vecs0: SUCCESS (0.059s) [114.604625] Subtest forked-writes: SUCCESS (0.252s) [114.837430] [025/136] (880s left) gem_sync (basic-many-each) [115.267446] Starting subtest: basic-many-each [117.729376] Subtest basic-many-each: SUCCESS (2.378s) [117.836204] [026/136] (877s left) kms_fbcon_fbt (psr) [118.098313] Starting subtest: psr [118.139326] Subtest psr: SKIP (0.001s) [118.241613] [027/136] (877s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [118.651402] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [118.688863] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [119.257805] [028/136] (876s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [119.952949] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs [120.002192] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [120.309871] [029/136] (875s left) v3d/v3d_submit_cl (bad-flag) [120.668634] Subtest bad-flag: SKIP (0.000s) [120.799259] [030/136] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [121.255108] Starting subtest: psr-2p-primscrn-spr-indfb-move [121.299395] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [121.432843] [031/136] (874s left) gem_exec_fence (submit67) [121.823703] Starting subtest: submit67 [121.846041] Starting dynamic subtest: rcs0 [124.378660] Dynamic subtest rcs0: SUCCESS (2.373s) [124.415233] Starting dynamic subtest: bcs0 [125.337391] Dynamic subtest bcs0: SUCCESS (1.130s) [125.408373] Starting dynamic subtest: vcs0 [126.416720] Dynamic subtest vcs0: SUCCESS (1.086s) [126.484641] Starting dynamic subtest: vecs0 [127.649531] Dynamic subtest vecs0: SUCCESS (1.234s) [127.671618] Subtest submit67: SUCCESS (5.828s) [128.410361] [032/136] (867s left) gem_exec_fair (basic-none-vip) [128.852636] Starting subtest: basic-none-vip [128.873447] Starting dynamic subtest: rcs0 [134.450304] Dynamic subtest rcs0: SUCCESS (5.784s) [134.470811] Subtest basic-none-vip: SUCCESS (5.786s) [134.694662] [033/136] (861s left) gem_eio (in-flight-external) [134.999172] Starting subtest: in-flight-external [135.066771] Subtest in-flight-external: SUCCESS (0.082s) [135.266830] [034/136] (860s left) kms_vblank (pipe-b-ts-continuation-modeset) [135.637790] Starting subtest: pipe-B-ts-continuation-modeset [136.582153] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.956s) [136.959724] [035/136] (859s left) gem_mmap_gtt (basic-small-copy-odd) [137.219112] Starting subtest: basic-small-copy-odd [140.490611] Subtest basic-small-copy-odd: SUCCESS (3.290s) [140.631103] [036/136] (855s left) kms_cursor_crc (cursor-random-64x21) [141.199580] Starting subtest: cursor-random-64x21 [141.220898] Starting dynamic subtest: pipe-A-DP-1 [145.311615] Dynamic subtest pipe-A-DP-1: SUCCESS (4.093s) [145.377638] Starting dynamic subtest: pipe-C-DP-1 [149.467038] Dynamic subtest pipe-C-DP-1: SUCCESS (4.101s) [149.485945] Subtest cursor-random-64x21: SUCCESS (8.266s) [149.857689] [037/136] (846s left) gem_userptr_blits (process-exit) [150.201790] Starting subtest: process-exit [150.220313] Subtest process-exit: SUCCESS (0.028s) [150.336537] [038/136] (846s left) fbdev (read) [150.616506] Starting subtest: read [152.019976] Subtest read: SUCCESS (1.413s) [152.133121] [039/136] (844s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [152.543917] Starting subtest: yf-tiled-64bpp-rotate-270 [152.584635] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [152.692710] [040/136] (844s left) kms_vblank (pipe-b-ts-continuation-suspend) [153.070936] Starting subtest: pipe-B-ts-continuation-suspend [170.558691] Subtest pipe-B-ts-continuation-suspend: SUCCESS (2.216s) [175.932057] [041/136] (841s left) kms_vblank (pipe-d-ts-continuation-suspend) [176.323857] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s) [176.515243] [042/136] (840s left) kms_psr (primary_page_flip) [176.813543] Subtest primary_page_flip: SKIP (0.000s) [176.952048] [043/136] (840s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [177.326585] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [177.355495] Starting dynamic subtest: pipe-A-DP-1 [178.247308] Dynamic subtest pipe-A-DP-1: SUCCESS (0.918s) [178.302233] Starting dynamic subtest: pipe-B-DP-1 [179.430034] Dynamic subtest pipe-B-DP-1: SUCCESS (1.190s) [179.500753] Starting dynamic subtest: pipe-C-DP-1 [180.337330] Dynamic subtest pipe-C-DP-1: SUCCESS (0.905s) [180.356017] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.023s) [180.756296] [044/136] (836s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [181.169784] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [181.209040] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [181.321280] [045/136] (836s left) kms_big_fb (4-tiled-8bpp-rotate-180) [181.725757] Starting subtest: 4-tiled-8bpp-rotate-180 [181.762610] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s) [181.875678] [046/136] (835s left) i915_pm_rpm (universal-planes-dpms) [183.731111] Starting subtest: universal-planes-dpms [183.751555] Starting dynamic subtest: plane-31 [186.522747] Dynamic subtest plane-31: SUCCESS (2.789s) [186.567466] Starting dynamic subtest: plane-39 [189.448732] Dynamic subtest plane-39: SUCCESS (2.924s) [189.493530] Starting dynamic subtest: plane-47 [192.382160] Dynamic subtest plane-47: SUCCESS (2.934s) [192.422632] Starting dynamic subtest: plane-55 [195.189698] Dynamic subtest plane-55: SUCCESS (2.806s) [195.211947] Subtest universal-planes-dpms: SUCCESS (11.459s) [195.684891] [047/136] (822s left) gem_busy (close-race) [195.982125] Starting subtest: close-race [218.260500] Subtest close-race: SUCCESS (22.271s) [218.673584] [048/136] (799s left) syncobj_wait (invalid-signal-zero-handles) [219.102380] Starting subtest: invalid-signal-zero-handles [219.121642] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [219.245504] [049/136] (798s left) i915_pm_rpm (cursor) [221.338735] Starting subtest: cursor [224.281716] Subtest cursor: SUCCESS (2.947s) [224.754202] [050/136] (793s left) perf (polling) [225.160746] Starting subtest: polling [225.181402] Starting dynamic subtest: 0-rcs0 [235.453336] Dynamic subtest 0-rcs0: SUCCESS (10.093s) [235.473916] Subtest polling: SUCCESS (10.094s) [235.600554] [051/136] (782s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [235.945455] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [235.967491] Starting dynamic subtest: pipe-A-valid-mode [236.633497] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.665s) [236.654754] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (0.668s) [236.974772] [052/136] (781s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [237.403951] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [237.440794] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [237.554257] [053/136] (780s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [237.812196] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [237.833707] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.002s) [237.948189] [054/136] (780s left) gem_ppgtt (flink-and-close-vma-leak) [238.207092] Starting subtest: flink-and-close-vma-leak [238.227720] Subtest flink-and-close-vma-leak: SUCCESS (0.013s) [238.368547] [055/136] (780s left) perf (low-oa-exponent-permissions) [238.709873] Starting subtest: low-oa-exponent-permissions [238.841908] Subtest low-oa-exponent-permissions: SUCCESS (0.123s) [238.989768] [056/136] (779s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [239.519721] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [239.558212] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [240.031772] [057/136] (778s left) kms_frontbuffer_tracking (fbc-1p-rte) [240.458162] Starting subtest: fbc-1p-rte [244.033049] Subtest fbc-1p-rte: SUCCESS (3.642s) [244.251585] [058/136] (774s left) gem_mmap_gtt (basic) [244.509650] Starting subtest: basic [244.536739] Subtest basic: SUCCESS (0.002s) [244.652808] [059/136] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [245.052720] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [245.094554] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [245.208122] [060/136] (773s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs) [245.689558] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs [245.727700] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s) [246.253282] [061/136] (773s left) kms_flip (plain-flip-interruptible) [246.604235] Starting subtest: plain-flip-interruptible [246.622824] Starting dynamic subtest: A-DP1 [247.778710] Dynamic subtest A-DP1: SUCCESS (1.172s) [247.821387] Starting dynamic subtest: B-DP1 [248.874729] Dynamic subtest B-DP1: SUCCESS (1.091s) [248.914868] Starting dynamic subtest: C-DP1 [249.977377] Dynamic subtest C-DP1: SUCCESS (1.099s) [249.998677] Subtest plain-flip-interruptible: SUCCESS (3.373s) [250.410795] [062/136] (768s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [250.761484] Starting subtest: basic-flip-before-cursor-varying-size [251.830472] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.064s) [252.201486] [063/136] (767s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs) [252.709911] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs [252.751365] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s) [253.260981] [064/136] (766s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [253.612837] Starting subtest: multiplane-rotation-cropping-bottom [267.515967] Subtest multiplane-rotation-cropping-bottom: SUCCESS (13.900s) [267.653853] [065/136] (752s left) v3d/v3d_submit_csd (bad-multisync-in-sync) [267.984664] Subtest bad-multisync-in-sync: SKIP (0.000s) [268.101936] [066/136] (751s left) gem_ctx_bad_destroy (invalid-ctx) [268.350586] Starting subtest: invalid-ctx [268.372837] Subtest invalid-ctx: SUCCESS (0.000s) [268.484095] [067/136] (751s left) gem_busy (semaphore) [268.894470] Starting subtest: semaphore [268.913534] Starting dynamic subtest: rcs0 [268.932590] Dynamic subtest rcs0: SUCCESS (0.038s) [268.978697] Starting dynamic subtest: bcs0 [268.997630] Dynamic subtest bcs0: SUCCESS (0.033s) [269.038463] Starting dynamic subtest: vcs0 [269.059704] Dynamic subtest vcs0: SUCCESS (0.026s) [269.099553] Starting dynamic subtest: vecs0 [269.119944] Dynamic subtest vecs0: SUCCESS (0.025s) [269.138577] Subtest semaphore: SUCCESS (0.127s) [269.293410] [068/136] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [269.712315] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [269.752315] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [269.866281] [069/136] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [270.243933] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [270.286116] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [270.402767] [070/136] (749s left) kms_setmode (invalid-clone-single-crtc) [270.668244] Starting subtest: invalid-clone-single-crtc [270.725381] Subtest invalid-clone-single-crtc: SKIP (0.000s) [270.821221] [071/136] (749s left) kms_chamelium_frames (hdmi-crc-fast) [271.306390] Subtest hdmi-crc-fast: SKIP (0.000s) [271.626572] [072/136] (748s left) gen9_exec_parse (bb-start-out) [271.909446] Starting subtest: bb-start-out [271.929847] Subtest bb-start-out: SUCCESS (0.004s) [272.162181] [073/136] (748s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [272.521034] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [272.542100] Starting dynamic subtest: pipe-A-DP-1 [272.607493] Dynamic subtest pipe-A-DP-1: SUCCESS (0.077s) [272.648989] Starting dynamic subtest: pipe-B-DP-1 [272.946992] Dynamic subtest pipe-B-DP-1: SUCCESS (0.351s) [273.007030] Starting dynamic subtest: pipe-C-DP-1 [273.079736] Dynamic subtest pipe-C-DP-1: SKIP (0.085s) [273.103264] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.523s) [273.458911] [074/136] (747s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [273.828548] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [273.849277] Starting dynamic subtest: pipe-A-valid-mode [273.934400] Dynamic subtest pipe-A-valid-mode: SKIP (0.106s) [273.975264] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.108s) [274.296497] [075/136] (746s left) gem_exec_reloc (basic-wc-gtt-active) [274.557442] Starting subtest: basic-wc-gtt-active [274.693296] Subtest basic-wc-gtt-active: SUCCESS (0.139s) [274.924892] [076/136] (745s left) sysfs_timeslice_duration (idempotent) [275.186791] Starting subtest: idempotent [275.207568] Starting dynamic subtest: vecs0 [275.228754] Dynamic subtest vecs0: SUCCESS (0.001s) [275.267922] Starting dynamic subtest: vcs0 [275.286642] Dynamic subtest vcs0: SUCCESS (0.002s) [275.324582] Starting dynamic subtest: bcs0 [275.343152] Dynamic subtest bcs0: SUCCESS (0.001s) [275.384043] Starting dynamic subtest: rcs0 [275.405551] Dynamic subtest rcs0: SUCCESS (0.001s) [275.425972] Subtest idempotent: SUCCESS (0.014s) [275.534688] [077/136] (745s left) gem_ctx_persistence (engines-mixed-process) [275.801045] Starting subtest: engines-mixed-process [275.820083] Starting dynamic subtest: rcs0 [276.173166] Dynamic subtest rcs0: SUCCESS (0.354s) [276.214622] Starting dynamic subtest: bcs0 [276.515466] Dynamic subtest bcs0: SUCCESS (0.357s) [276.557294] Starting dynamic subtest: vcs0 [276.887592] Dynamic subtest vcs0: SUCCESS (0.351s) [276.931531] Starting dynamic subtest: vecs0 [277.237002] Dynamic subtest vecs0: SUCCESS (0.349s) [277.258442] Subtest engines-mixed-process: SUCCESS (1.420s) [277.371427] [078/136] (743s left) vgem_basic (dmabuf-fence-before) [277.633808] Starting subtest: dmabuf-fence-before [277.654760] Subtest dmabuf-fence-before: SUCCESS (0.001s) [277.763256] [079/136] (743s left) kms_cursor_edge_walk (128x128-top-edge) [278.141602] Starting subtest: 128x128-top-edge [278.163607] Starting dynamic subtest: pipe-A-DP-1 [281.753368] Dynamic subtest pipe-A-DP-1: SUCCESS (3.612s) [281.804761] Starting dynamic subtest: pipe-C-DP-1 [285.201894] Dynamic subtest pipe-C-DP-1: SUCCESS (3.457s) [285.227391] Subtest 128x128-top-edge: SUCCESS (7.075s) [285.572012] [080/136] (735s left) kms_chamelium_color (ctm-blue-to-red) [285.977728] Subtest ctm-blue-to-red: SKIP (0.000s) [286.112207] [081/136] (735s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [289.144652] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [289.255858] [082/136] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [289.655409] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [289.696839] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [289.808218] [083/136] (731s left) kms_flip (flip-vs-fences-interruptible) [290.149129] Starting subtest: flip-vs-fences-interruptible [290.170536] Starting dynamic subtest: A-DP1 [301.016383] Dynamic subtest A-DP1: SUCCESS (10.714s) [301.055252] Starting dynamic subtest: B-DP1 [311.699323] Dynamic subtest B-DP1: SUCCESS (10.671s) [311.745195] Starting dynamic subtest: C-DP1 [322.346391] Dynamic subtest C-DP1: SUCCESS (10.822s) [322.368030] Subtest flip-vs-fences-interruptible: SUCCESS (32.216s) [322.808866] [084/136] (698s left) kms_vblank (pipe-d-ts-continuation-dpms-rpm) [323.198234] Subtest pipe-D-ts-continuation-dpms-rpm: SKIP (0.000s) [323.356602] [085/136] (698s left) perf_pmu (busy-idle-no-semaphores) [323.620007] Starting subtest: busy-idle-no-semaphores [323.641229] Starting dynamic subtest: rcs0 [324.236327] Dynamic subtest rcs0: SUCCESS (0.623s) [324.276156] Starting dynamic subtest: bcs0 [324.858260] Dynamic subtest bcs0: SUCCESS (0.620s) [324.898752] Starting dynamic subtest: vcs0 [325.482569] Dynamic subtest vcs0: SUCCESS (0.619s) [325.524558] Starting dynamic subtest: vecs0 [326.100687] Dynamic subtest vecs0: SUCCESS (0.618s) [326.119610] Subtest busy-idle-no-semaphores: SUCCESS (2.489s) [326.237032] [086/136] (695s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [326.483490] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [326.581212] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [326.698565] [087/136] (695s left) syncobj_timeline (invalid-single-wait-available-unsubmitted) [326.930841] Starting subtest: invalid-single-wait-available-unsubmitted [326.951904] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s) [327.043817] [088/136] (695s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-5) [327.364733] Starting subtest: plane-downscale-with-pixel-format-factor-0-5 [327.383992] Starting dynamic subtest: pipe-A-DP-1 [329.918935] Dynamic subtest pipe-A-DP-1: SUCCESS (2.540s) [329.986831] Starting dynamic subtest: pipe-B-DP-1 [332.484704] Dynamic subtest pipe-B-DP-1: SUCCESS (2.559s) [332.524342] Starting dynamic subtest: pipe-C-DP-1 [332.859371] Dynamic subtest pipe-C-DP-1: SUCCESS (0.380s) [332.878983] Subtest plane-downscale-with-pixel-format-factor-0-5: SUCCESS (5.490s) [333.293016] [089/136] (688s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [333.711675] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [333.788953] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.034s) [333.905749] [090/136] (688s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc) [334.444490] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc [334.481936] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s) [334.945243] [091/136] (687s left) gem_exec_whisper (basic-forked) [335.234874] Starting subtest: basic-forked [346.011551] Subtest basic-forked: SUCCESS (10.778s) [346.210925] [092/136] (676s left) kms_rotation_crc (cursor-rotation-180) [346.550402] Starting subtest: cursor-rotation-180 [347.325552] Subtest cursor-rotation-180: SUCCESS (0.784s) [347.784417] [093/136] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [348.214643] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [348.252426] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [348.365997] [094/136] (674s left) kms_vblank (pipe-a-wait-idle) [348.725721] Starting subtest: pipe-A-wait-idle [350.990242] Subtest pipe-A-wait-idle: SUCCESS (2.273s) [351.376925] [095/136] (671s left) gem_exec_whisper (basic-queues-priority) [351.698090] Starting subtest: basic-queues-priority [363.738514] Subtest basic-queues-priority: SUCCESS (12.066s) [363.943323] [096/136] (658s left) kms_big_fb (x-tiled-8bpp-rotate-270) [364.324932] Starting subtest: x-tiled-8bpp-rotate-270 [364.423025] Subtest x-tiled-8bpp-rotate-270: SKIP (0.072s) [364.565261] [097/136] (658s left) gem_lmem_swapping (verify-random) [364.855349] Subtest verify-random: SKIP (0.000s) [364.991823] [098/136] (658s left) drm_fdinfo (all-busy-idle-check-all) [365.248792] Starting subtest: all-busy-idle-check-all [365.880225] Subtest all-busy-idle-check-all: SUCCESS (0.628s) [365.987916] [099/136] (657s left) device_reset (cold-reset-bound) [366.289124] Subtest cold-reset-bound: SKIP (0.000s) [366.394610] [100/136] (656s left) syncobj_timeline (single-wait-signaled) [366.651494] Starting subtest: single-wait-signaled [366.670538] Subtest single-wait-signaled: SUCCESS (0.001s) [366.762969] [101/136] (656s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [367.125023] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [385.765838] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (18.652s) [386.140848] [102/136] (637s left) kms_lease (lease_again) [386.502014] Starting subtest: lease_again [386.521032] Starting dynamic subtest: pipe-A-DP-1 [386.539887] Dynamic subtest pipe-A-DP-1: SUCCESS (0.005s) [386.580944] Starting dynamic subtest: pipe-B-DP-1 [386.602779] Dynamic subtest pipe-B-DP-1: SUCCESS (0.003s) [386.646008] Starting dynamic subtest: pipe-C-DP-1 [386.666566] Dynamic subtest pipe-C-DP-1: SUCCESS (0.004s) [386.687079] Subtest lease_again: SUCCESS (0.020s) [386.801432] [103/136] (636s left) kms_flip (flip-vs-modeset-vs-hang) [387.167051] Starting subtest: flip-vs-modeset-vs-hang [387.187339] Starting dynamic subtest: A-DP1 [401.791312] Dynamic subtest A-DP1: SUCCESS (14.646s) [401.830416] Starting dynamic subtest: C-DP1 [415.750099] Dynamic subtest C-DP1: SUCCESS (13.950s) [415.772221] Subtest flip-vs-modeset-vs-hang: SUCCESS (28.603s) [416.146988] [104/136] (607s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [416.559742] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [416.609767] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [416.745025] [105/136] (607s left) gem_softpin (allocator-basic-reserve) [417.039383] Starting subtest: allocator-basic-reserve [417.257030] Subtest allocator-basic-reserve: SUCCESS (0.227s) [417.426651] [106/136] (606s left) kms_flip (flip-vs-blocking-wf-vblank) [417.820404] Starting subtest: flip-vs-blocking-wf-vblank [417.848379] Starting dynamic subtest: A-DP1 [428.790173] Dynamic subtest A-DP1: SUCCESS (10.826s) [428.840932] Starting dynamic subtest: B-DP1 [439.329326] Dynamic subtest B-DP1: SUCCESS (10.723s) [439.372644] Starting dynamic subtest: C-DP1 [450.058500] Dynamic subtest C-DP1: SUCCESS (10.727s) [450.079463] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.287s) [450.512617] [107/136] (573s left) kms_hdr (static-swap) [450.852341] Starting subtest: static-swap [450.889920] Subtest static-swap: SKIP (0.000s) [451.007197] [108/136] (573s left) gem_exec_schedule (u-semaphore-noskip) [451.424458] Starting subtest: u-semaphore-noskip [451.519622] Subtest u-semaphore-noskip: SUCCESS (0.236s) [451.886273] [109/136] (572s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [452.225495] Starting subtest: primary-x-tiled-reflect-x-180 [452.264863] Subtest primary-x-tiled-reflect-x-180: SKIP (0.002s) [452.383292] [110/136] (571s left) kms_draw_crc (draw-method-blt) [452.734638] Starting subtest: draw-method-blt [452.753540] Starting dynamic subtest: xrgb8888-untiled [453.057428] Dynamic subtest xrgb8888-untiled: SUCCESS (0.318s) [453.115901] Starting dynamic subtest: xrgb8888-xtiled [453.227756] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.165s) [453.276119] Starting dynamic subtest: xrgb8888-ytiled [453.406884] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.185s) [453.447764] Starting dynamic subtest: rgb565-untiled [453.707478] Dynamic subtest rgb565-untiled: SUCCESS (0.295s) [453.749055] Starting dynamic subtest: rgb565-xtiled [453.879515] Dynamic subtest rgb565-xtiled: SUCCESS (0.165s) [453.924722] Starting dynamic subtest: rgb565-ytiled [454.056890] Dynamic subtest rgb565-ytiled: SUCCESS (0.182s) [454.101964] Starting dynamic subtest: xrgb2101010-untiled [454.357249] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.299s) [454.401727] Starting dynamic subtest: xrgb2101010-xtiled [454.529249] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.165s) [454.570541] Starting dynamic subtest: xrgb2101010-ytiled [454.709253] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.182s) [454.731321] Subtest draw-method-blt: SUCCESS (1.969s) [454.846970] [111/136] (569s left) kms_big_fb (linear-8bpp-rotate-270) [455.225202] Starting subtest: linear-8bpp-rotate-270 [455.307910] Subtest linear-8bpp-rotate-270: SKIP (0.079s) [455.450314] [112/136] (569s left) perf_pmu (rc6-suspend) [455.698363] Starting subtest: rc6-suspend [480.537030] Subtest rc6-suspend: SUCCESS (8.779s) [481.659692] [113/136] (559s left) api_intel_bb (misplaced-blitter) [481.918355] Starting subtest: misplaced-blitter [481.940345] Subtest misplaced-blitter: SUCCESS (0.016s) [482.068926] [114/136] (559s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [482.750706] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs [482.790698] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [483.129774] [115/136] (558s left) kms_addfb_basic (legacy-format) [483.376615] Starting subtest: legacy-format [483.558688] Subtest legacy-format: SUCCESS (0.117s) [484.022576] [116/136] (557s left) gem_exec_reloc (basic-wc-active) [484.274362] Starting subtest: basic-wc-active [484.414778] Subtest basic-wc-active: SUCCESS (0.139s) [484.645315] [117/136] (557s left) gem_partial_pwrite_pread (write) [484.905826] Starting subtest: write [498.855843] Subtest write: SUCCESS (13.949s) [499.030435] [118/136] (543s left) kms_pipe_crc_basic (suspend-read-crc) [499.379884] Starting subtest: suspend-read-crc [499.399189] Starting dynamic subtest: pipe-A-DP-1 [517.942885] Dynamic subtest pipe-A-DP-1: SUCCESS (2.543s) [526.728402] [119/136] (532s left) gem_exec_reloc (basic-write-gtt-active) [526.977021] Starting subtest: basic-write-gtt-active [527.112117] Subtest basic-write-gtt-active: SUCCESS (0.136s) [527.351531] [120/136] (531s left) gem_spin_batch (legacy-resubmit-new) [527.630786] Starting subtest: legacy-resubmit-new [527.652154] Starting dynamic subtest: default [527.672711] Dynamic subtest default: SUCCESS (0.007s) [527.712855] Starting dynamic subtest: render [527.731470] Dynamic subtest render: SUCCESS (0.007s) [527.771841] Starting dynamic subtest: bsd [527.790537] Dynamic subtest bsd: SUCCESS (0.007s) [527.834322] Starting dynamic subtest: bsd1 [527.855703] Dynamic subtest bsd1: SUCCESS (0.006s) [527.898522] Starting dynamic subtest: blt [527.918859] Dynamic subtest blt: SUCCESS (0.008s) [527.958833] Starting dynamic subtest: vebox [527.977404] Dynamic subtest vebox: SUCCESS (0.006s) [527.995895] Subtest legacy-resubmit-new: SUCCESS (0.051s) [528.111584] [121/136] (531s left) gem_userptr_blits (sync-overlap) [528.450840] Starting subtest: sync-overlap [528.469588] Subtest sync-overlap: SUCCESS (0.001s) [528.582448] [122/136] (530s left) kms_content_protection (lic) [528.978486] Starting subtest: LIC [529.018919] Starting dynamic subtest: pipe-A-DP-1 [649.437351] Per-test timeout exceeded. Killing the current test with SIGQUIT. [656.274860] Closing watchdogs [656.280411] Initializing watchdogs [656.280581] /dev/watchdog0 [656.342697] [123/136] (403s left) kms_color (ctm-max) [656.711821] Starting subtest: ctm-max [656.730619] Starting dynamic subtest: pipe-A-DP-1 [657.245579] Dynamic subtest pipe-A-DP-1: SUCCESS (0.519s) [657.296798] Starting dynamic subtest: pipe-B-DP-1 [658.019633] Dynamic subtest pipe-B-DP-1: SUCCESS (0.776s) [658.062054] Starting dynamic subtest: pipe-C-DP-1 [658.917588] Dynamic subtest pipe-C-DP-1: SUCCESS (0.898s) [658.939107] Subtest ctm-max: SUCCESS (2.204s) [659.294598] [124/136] (400s left) vc4/vc4_label_bo (set-bad-name) [659.642684] Subtest set-bad-name: SKIP (0.000s) [659.761868] [125/136] (399s left) i915_hangman (gt-engine-hang) [660.019577] Starting subtest: gt-engine-hang [660.041334] Starting dynamic subtest: rcs0 [660.609187] Dynamic subtest rcs0: SUCCESS (0.594s) [660.659227] Starting dynamic subtest: bcs0 [661.200911] Dynamic subtest bcs0: SUCCESS (0.592s) [661.248884] Starting dynamic subtest: vcs0 [661.803184] Dynamic subtest vcs0: SUCCESS (0.595s) [661.851521] Starting dynamic subtest: vecs0 [662.392566] Dynamic subtest vecs0: SUCCESS (0.588s) [662.411566] Subtest gt-engine-hang: SUCCESS (2.374s) [662.565788] [126/136] (397s left) gem_ctx_isolation (clean) [662.846660] Starting subtest: clean [662.872996] Starting dynamic subtest: rcs0 [663.057157] Dynamic subtest rcs0: SUCCESS (0.207s) [663.107390] Starting dynamic subtest: bcs0 [663.348974] Dynamic subtest bcs0: SUCCESS (0.291s) [663.408699] Starting dynamic subtest: vcs0 [663.594489] Dynamic subtest vcs0: SUCCESS (0.247s) [663.644402] Starting dynamic subtest: vecs0 [663.808033] Dynamic subtest vecs0: SUCCESS (0.216s) [663.841992] Subtest clean: SUCCESS (0.966s) [664.066432] [127/136] (395s left) gem_mmap_gtt (basic-short) [664.343671] Starting subtest: basic-short [664.367915] Subtest basic-short: SUCCESS (0.051s) [664.542374] [128/136] (395s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [664.961207] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [665.011453] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [665.162426] [129/136] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [665.591095] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [665.640858] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [665.786762] [130/136] (394s left) vc4/vc4_purgeable_bo (access-purged-bo-mem) [666.114212] Subtest access-purged-bo-mem: SKIP (0.000s) [666.226137] [131/136] (394s left) gem_caching (reads) [666.480762] Starting subtest: reads [672.743299] Subtest reads: SUCCESS (6.250s) [672.859833] [132/136] (387s left) gem_ctx_sseu (mmap-args) [673.141081] Subtest mmap-args: SKIP (0.000s) [673.239505] [133/136] (387s left) gem_exec_schedule (preempt-queue-contexts-chain) [673.649396] Starting subtest: preempt-queue-contexts-chain [673.672204] Starting dynamic subtest: rcs0 [674.503747] Dynamic subtest rcs0: SUCCESS (0.994s) [674.566449] Starting dynamic subtest: bcs0 [675.519158] Dynamic subtest bcs0: SUCCESS (1.016s) [675.580659] Starting dynamic subtest: vcs0 [676.549749] Dynamic subtest vcs0: SUCCESS (1.026s) [676.614276] Starting dynamic subtest: vecs0 [677.594971] Dynamic subtest vecs0: SUCCESS (1.045s) [677.613921] Subtest preempt-queue-contexts-chain: SUCCESS (4.087s) [677.959624] [134/136] (382s left) gem_render_copy (yf-tiled-to-vebox-linear) [678.235259] Starting subtest: yf-tiled-to-vebox-linear [678.275365] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [678.438996] [135/136] (382s left) kms_psr2_sf (primary-plane-update-sf-dmg-area) [678.721492] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s) [678.813172] [136/136] (382s left) gem_userptr_blits (input-checking) [679.103172] Starting subtest: input-checking [679.121868] Subtest input-checking: SUCCESS (0.000s) [679.216078] Closing watchdogs Done.