[27.616254] Initializing watchdogs [27.616315] /dev/watchdog0 [27.620776] [001/137] (960s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs) [27.932523] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs [27.934433] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s) [28.058097] [002/137] (960s left) kms_vblank (pipe-c-wait-busy) [28.145326] Starting subtest: pipe-C-wait-busy [29.477676] Subtest pipe-C-wait-busy: SUCCESS (1.333s) [29.583531] [003/137] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [29.689957] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [29.691477] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [29.740916] [004/137] (958s left) perf (invalid-create-userspace-config) [29.828164] Starting subtest: invalid-create-userspace-config [29.828868] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [29.838448] [005/137] (958s left) kms_frontbuffer_tracking (psr-slowdraw) [29.930798] Starting subtest: psr-slowdraw [29.932187] Subtest psr-slowdraw: SKIP (0.000s) [29.983105] [006/137] (958s left) kms_color (ctm-max) [30.072031] Starting subtest: ctm-max [30.073557] Starting dynamic subtest: pipe-A-HDMI-A-1 [30.345485] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.273s) [30.352475] Starting dynamic subtest: pipe-B-HDMI-A-1 [30.620660] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.273s) [30.623822] Starting dynamic subtest: pipe-C-HDMI-A-1 [30.888031] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.266s) [30.891842] Starting dynamic subtest: pipe-D-HDMI-A-1 [31.155906] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.267s) [31.156606] Subtest ctm-max: SUCCESS (1.085s) [31.250245] [007/137] (956s left) gem_ctx_persistence (legacy-engines-hostile) [31.296728] Starting subtest: legacy-engines-hostile [31.297438] Starting dynamic subtest: render [31.334998] Dynamic subtest render: SUCCESS (0.038s) [31.338905] Starting dynamic subtest: bsd1 [31.423946] Dynamic subtest bsd1: SUCCESS (0.089s) [31.428096] Starting dynamic subtest: bsd2 [31.503374] Dynamic subtest bsd2: SUCCESS (0.079s) [31.509696] Starting dynamic subtest: blt [31.593806] Dynamic subtest blt: SUCCESS (0.089s) [31.603213] Starting dynamic subtest: vebox [31.681034] Dynamic subtest vebox: SUCCESS (0.086s) [31.682329] Subtest legacy-engines-hostile: SUCCESS (0.383s) [31.724448] [008/137] (956s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [31.823448] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [31.824798] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [31.866854] [009/137] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [31.959682] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [31.961051] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [32.017143] [010/137] (956s left) kms_flip (2x-flip-vs-panning) [32.091429] Starting subtest: 2x-flip-vs-panning [32.103428] Subtest 2x-flip-vs-panning: SKIP (0.012s) [32.142087] [011/137] (956s left) gem_ccs (ctrl-surf-copy-new-ctx) [32.186403] Starting subtest: ctrl-surf-copy-new-ctx [32.187903] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [32.222032] [012/137] (955s left) kms_frontbuffer_tracking (fbc-tiling-y) [32.324847] Starting subtest: fbc-tiling-y [33.448650] Subtest fbc-tiling-y: SUCCESS (1.125s) [33.542492] [013/137] (954s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [33.604057] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [33.604897] Starting dynamic subtest: smem [33.703854] Dynamic subtest smem: SUCCESS (0.099s) [33.704763] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.100s) [33.850547] [014/137] (954s left) gem_mmap_gtt (cpuset-big-copy-xy) [33.907055] Starting subtest: cpuset-big-copy-XY [54.708701] Subtest cpuset-big-copy-XY: SUCCESS (20.801s) [54.748760] [015/137] (933s left) kms_3d [56.409802] [016/137] (931s left) kms_busy (basic) [56.519757] Starting subtest: basic [56.520456] Starting dynamic subtest: flip [56.855192] Dynamic subtest flip: SUCCESS (0.335s) [56.859054] Starting dynamic subtest: modeset [57.329758] Dynamic subtest modeset: SUCCESS (0.474s) [57.330634] Subtest basic: SUCCESS (0.810s) [57.441635] [017/137] (930s left) kms_cursor_legacy (torture-bo) [57.529226] Starting subtest: torture-bo [57.529953] Starting dynamic subtest: pipe-A [79.289999] Dynamic subtest pipe-A: SUCCESS (21.752s) [79.294358] Starting dynamic subtest: pipe-B [100.935613] Dynamic subtest pipe-B: SUCCESS (21.620s) [100.943186] Starting dynamic subtest: pipe-C [122.504425] Dynamic subtest pipe-C: SUCCESS (21.569s) [122.508499] Starting dynamic subtest: pipe-D [144.031440] Dynamic subtest pipe-D: SUCCESS (21.552s) [144.036081] Starting dynamic subtest: all-pipes [165.610506] Dynamic subtest all-pipes: SUCCESS (21.554s) [165.611694] Subtest torture-bo: SUCCESS (108.047s) [165.626094] [018/137] (822s left) gem_render_copy_redux (flink) [165.704095] Starting subtest: flink [166.643807] Subtest flink: SUCCESS (0.940s) [166.724090] [019/137] (821s left) gem_exec_whisper (basic-fds-forked) [166.786504] Starting subtest: basic-fds-forked [172.226596] Subtest basic-fds-forked: SUCCESS (5.430s) [172.369214] [020/137] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [172.468482] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [172.469833] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [172.525012] [021/137] (815s left) gem_exec_params (rel-constants-invalid-rel-gen5) [172.569814] Starting subtest: rel-constants-invalid-rel-gen5 [172.570697] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [172.631283] [022/137] (815s left) gen7_exec_parse (bitmasks) [172.689076] Subtest bitmasks: SKIP (0.000s) [172.711392] [023/137] (815s left) gem_exec_schedule (preempt-hang) [172.879194] Starting subtest: preempt-hang [172.880457] Starting dynamic subtest: rcs0 [173.074235] Dynamic subtest rcs0: SUCCESS (0.197s) [173.078767] Starting dynamic subtest: bcs0 [173.268800] Dynamic subtest bcs0: SUCCESS (0.194s) [173.273471] Starting dynamic subtest: vcs0 [173.451447] Dynamic subtest vcs0: SUCCESS (0.183s) [173.456224] Starting dynamic subtest: vcs1 [173.637090] Dynamic subtest vcs1: SUCCESS (0.186s) [173.641863] Starting dynamic subtest: vecs0 [173.826577] Dynamic subtest vecs0: SUCCESS (0.189s) [173.827537] Subtest preempt-hang: SUCCESS (0.950s) [173.978061] [024/137] (814s left) gem_eio (create-ext) [174.041194] Starting subtest: create-ext [174.064761] Subtest create-ext: SUCCESS (0.023s) [174.136423] [025/137] (814s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [174.229693] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [174.230493] Starting dynamic subtest: pipe-A-valid-mode [174.282745] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s) [174.284168] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.053s) [174.356436] [026/137] (814s left) api_intel_allocator (two-level-inception) [174.399279] Starting subtest: two-level-inception [179.830844] Subtest two-level-inception: SUCCESS (5.398s) [179.879118] [027/137] (808s left) kms_chamelium_hpd (hdmi-hpd) [180.046078] Subtest hdmi-hpd: SKIP (0.000s) [180.102247] [028/137] (808s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [180.146642] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [180.166730] [029/137] (808s left) kms_psr (psr2_cursor_blt) [180.210853] Subtest psr2_cursor_blt: SKIP (0.000s) [180.225161] [030/137] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [180.316586] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [180.317946] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [180.364531] [031/137] (808s left) syncobj_timeline (invalid-signal-illegal-point) [180.407711] Starting subtest: invalid-signal-illegal-point [180.408473] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [180.439619] [032/137] (808s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [180.530696] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [180.532062] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [180.590014] [033/137] (807s left) kms_cursor_crc (cursor-sliding-512x512) [180.682649] Starting subtest: cursor-sliding-512x512 [180.684990] Subtest cursor-sliding-512x512: SKIP (0.001s) [180.731466] [034/137] (807s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [180.820355] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [180.821090] Starting dynamic subtest: pipe-A-valid-mode [181.843986] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.023s) [181.844713] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SUCCESS (1.023s) [181.962840] [035/137] (806s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs) [182.143711] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs [182.145535] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SKIP (0.000s) [182.387363] [036/137] (806s left) i915_module_load (load) [182.429614] Starting subtest: load [182.431138] Subtest load: SKIP (0.001s) [182.454147] [037/137] (806s left) i915_pm_rpm (gem-idle) [183.964932] Starting subtest: gem-idle [190.498941] Subtest gem-idle: SUCCESS (6.532s) [190.595514] [038/137] (797s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [190.643940] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [190.644814] Starting dynamic subtest: smem [190.726067] Dynamic subtest smem: SUCCESS (0.082s) [190.726905] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.082s) [190.878260] [039/137] (797s left) v3d/v3d_submit_csd (single-out-sync) [190.949765] Subtest single-out-sync: SKIP (0.000s) [190.978867] [040/137] (797s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [191.087013] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [192.141381] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.056s) [192.218619] [041/137] (796s left) gem_render_copy_redux (flink-interruptible) [192.268558] Starting subtest: flink-interruptible [193.222535] Subtest flink-interruptible: SUCCESS (0.954s) [193.294543] [042/137] (795s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs) [193.612303] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs [193.616881] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.004s) [193.764420] [043/137] (794s left) gem_partial_pwrite_pread (reads-snoop) [193.819744] Starting subtest: reads-snoop [195.182647] Subtest reads-snoop: SUCCESS (1.362s) [195.261430] [044/137] (793s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [195.361774] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [195.667191] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.307s) [195.760820] [045/137] (792s left) gem_lmem_swapping (parallel-random-engines) [195.816686] Subtest parallel-random-engines: SKIP (0.000s) [195.831449] [046/137] (792s left) kms_frontbuffer_tracking (basic) [195.923123] Starting subtest: basic [197.342207] Subtest basic: SUCCESS (1.421s) [197.432935] [047/137] (791s left) kms_cursor_crc (cursor-offscreen-32x10) [197.527661] Starting subtest: cursor-offscreen-32x10 [197.565197] Subtest cursor-offscreen-32x10: SKIP (0.036s) [197.613425] [048/137] (791s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [197.657388] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [197.761029] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [197.796608] [049/137] (790s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [197.886781] Starting subtest: plane-use-after-nonblocking-unbind-fencing [197.887670] Starting dynamic subtest: pipe-A-HDMI-A-1 [197.950401] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.064s) [198.014937] Starting dynamic subtest: pipe-B-HDMI-A-1 [198.144961] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.135s) [198.226551] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.341s) [198.318541] [050/137] (790s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [198.362245] Starting subtest: invalid-bsd1-flag-on-vebox [198.363028] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [198.409945] [051/137] (790s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [198.501999] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [198.503552] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [198.560242] [052/137] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [198.652835] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [198.654206] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [198.701726] [053/137] (790s left) kms_rmfb (close-fd) [198.788896] Starting subtest: close-fd [198.790608] Starting dynamic subtest: pipe-A-HDMI-A-1 [198.881686] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.091s) [198.886468] Starting dynamic subtest: pipe-B-HDMI-A-1 [199.049507] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.167s) [199.056206] Starting dynamic subtest: pipe-C-HDMI-A-1 [199.198778] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s) [199.205761] Starting dynamic subtest: pipe-D-HDMI-A-1 [199.348959] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s) [199.349776] Subtest close-fd: SUCCESS (0.559s) [199.468548] [054/137] (789s left) syncobj_wait (reset-unsignaled) [199.514078] Starting subtest: reset-unsignaled [199.514893] Subtest reset-unsignaled: SUCCESS (0.000s) [199.551329] [055/137] (789s left) kms_invalid_mode (bad-vsync-start) [199.664393] Starting subtest: bad-vsync-start [199.665222] Starting dynamic subtest: HDMI-A-1-pipe-A [199.723169] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.060s) [199.728757] Starting dynamic subtest: HDMI-A-1-pipe-B [199.732758] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.008s) [199.737338] Starting dynamic subtest: HDMI-A-1-pipe-C [199.738048] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.001s) [199.742496] Starting dynamic subtest: HDMI-A-1-pipe-D [199.743204] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s) [199.743899] Subtest bad-vsync-start: SUCCESS (0.073s) [199.828584] [056/137] (788s left) api_intel_allocator (gem-pool) [199.873741] Starting subtest: gem-pool [199.876597] Subtest gem-pool: SUCCESS (0.004s) [199.945226] [057/137] (788s left) gem_exec_fair (basic-none) [199.997720] Starting subtest: basic-none [199.998547] Starting dynamic subtest: rcs0 [205.280547] Dynamic subtest rcs0: FAIL (5.266s) [205.285273] Starting dynamic subtest: bcs0 [210.786682] Dynamic subtest bcs0: FAIL (5.498s) [210.791120] Starting dynamic subtest: vcs0 [216.162653] Dynamic subtest vcs0: FAIL (5.375s) [216.167264] Starting dynamic subtest: vcs1 [221.619989] Dynamic subtest vcs1: FAIL (5.458s) [221.624229] Starting dynamic subtest: vecs0 [227.004511] Dynamic subtest vecs0: FAIL (5.379s) [227.005255] Subtest basic-none: FAIL (26.978s) [227.133472] [058/137] (761s left) gem_userptr_blits (probe) [227.201219] Starting subtest: probe [227.451055] Subtest probe: SUCCESS (0.241s) [227.511351] [059/137] (761s left) kms_big_fb (linear-8bpp-rotate-270) [227.610167] Starting subtest: linear-8bpp-rotate-270 [227.659102] Subtest linear-8bpp-rotate-270: SKIP (0.047s) [227.723149] [060/137] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [227.817755] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [227.819095] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [227.864616] [061/137] (760s left) perf_pmu (multi-client) [227.908753] Starting subtest: multi-client [227.909514] Starting dynamic subtest: rcs0 [228.939713] Dynamic subtest rcs0: SUCCESS (1.029s) [228.950436] Starting dynamic subtest: bcs0 [229.973160] Dynamic subtest bcs0: SUCCESS (1.024s) [229.981362] Starting dynamic subtest: vcs0 [230.993513] Dynamic subtest vcs0: SUCCESS (1.020s) [231.000897] Starting dynamic subtest: vcs1 [232.021889] Dynamic subtest vcs1: SUCCESS (1.028s) [232.029961] Starting dynamic subtest: vecs0 [233.040121] Dynamic subtest vecs0: SUCCESS (1.017s) [233.041309] Subtest multi-client: SUCCESS (5.122s) [233.098295] [062/137] (755s left) v3d/v3d_submit_cl (job-perfmon) [233.161471] Subtest job-perfmon: SKIP (0.000s) [233.189663] [063/137] (755s left) kms_cursor_legacy (flip-vs-cursor-toggle) [233.285774] Starting subtest: flip-vs-cursor-toggle [238.728125] Subtest flip-vs-cursor-toggle: SUCCESS (5.441s) [238.825167] [064/137] (750s left) i915_query (engine-info) [238.868694] Starting subtest: engine-info [238.870396] Subtest engine-info: SUCCESS (0.001s) [238.908988] [065/137] (749s left) gem_ppgtt (flink-and-close-vma-leak) [238.955363] Starting subtest: flink-and-close-vma-leak [238.958332] Subtest flink-and-close-vma-leak: SUCCESS (0.002s) [239.024149] [066/137] (749s left) syncobj_wait (multi-wait-all-for-submit-submitted) [239.067868] Starting subtest: multi-wait-all-for-submit-submitted [239.169689] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s) [239.218158] [067/137] (749s left) kms_scaling_modes (scaling-mode-center) [239.312181] Starting subtest: scaling-mode-center [239.314646] Subtest scaling-mode-center: SKIP (0.002s) [239.349339] [068/137] (749s left) gem_mmap_wc (bad-size) [239.392546] Starting subtest: bad-size [239.393271] Subtest bad-size: SUCCESS (0.000s) [239.446690] [069/137] (749s left) vgem_slow (nohang) [239.528341] Starting subtest: nohang [249.860867] Subtest nohang: SUCCESS (10.297s) [249.874129] [070/137] (739s left) kms_chamelium_frames (hdmi-crc-multiple) [250.023096] Subtest hdmi-crc-multiple: SKIP (0.000s) [250.077027] [071/137] (738s left) gem_ctx_shared (exec-single-timeline) [250.125181] Starting subtest: exec-single-timeline [250.125984] Starting dynamic subtest: rcs0 [251.178053] Dynamic subtest rcs0: SUCCESS (1.044s) [251.184946] Starting dynamic subtest: bcs0 [252.202010] Dynamic subtest bcs0: SUCCESS (1.023s) [252.208725] Starting dynamic subtest: vcs0 [253.225780] Dynamic subtest vcs0: SUCCESS (1.023s) [253.232849] Starting dynamic subtest: vcs1 [254.250154] Dynamic subtest vcs1: SUCCESS (1.023s) [254.256764] Starting dynamic subtest: vecs0 [255.274194] Dynamic subtest vecs0: SUCCESS (1.023s) [255.275329] Subtest exec-single-timeline: SUCCESS (5.140s) [255.420246] [072/137] (733s left) gem_bad_reloc (negative-reloc) [255.474603] Starting subtest: negative-reloc [255.476918] Subtest negative-reloc: SUCCESS (0.000s) [255.547676] [073/137] (733s left) syncobj_wait (invalid-reset-zero-handles) [255.602262] Starting subtest: invalid-reset-zero-handles [255.603181] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [255.640835] [074/137] (733s left) v3d/v3d_perfmon (create-perfmon-0) [255.711304] Subtest create-perfmon-0: SKIP (0.000s) [255.740467] [075/137] (733s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [255.966845] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs [255.970423] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [256.185163] [076/137] (732s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs) [256.497073] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs [256.498621] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s) [256.620909] [077/137] (732s left) kms_cdclk (mode-transition) [256.664913] Subtest mode-transition: SKIP (0.000s) [256.681431] [078/137] (732s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [256.771380] Starting subtest: cursor-vs-flip-atomic-transitions [284.749073] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (27.978s) [284.849859] [079/137] (704s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [285.028303] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs [285.029067] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [285.286719] [080/137] (703s left) kms_writeback (writeback-fb-id) [285.418459] Subtest writeback-fb-id: SKIP (0.000s) [285.438941] [081/137] (703s left) gem_exec_reloc (basic-scanout) [285.531378] Starting subtest: basic-scanout [285.532196] Starting dynamic subtest: rcs0 [285.664922] Dynamic subtest rcs0: SUCCESS (0.135s) [285.670831] Starting dynamic subtest: bcs0 [285.764953] Dynamic subtest bcs0: SUCCESS (0.100s) [285.769804] Starting dynamic subtest: vcs0 [285.864887] Dynamic subtest vcs0: SUCCESS (0.100s) [285.869686] Starting dynamic subtest: vcs1 [285.964888] Dynamic subtest vcs1: SUCCESS (0.100s) [285.970040] Starting dynamic subtest: vecs0 [286.064884] Dynamic subtest vecs0: SUCCESS (0.100s) [286.065627] Subtest basic-scanout: SUCCESS (0.535s) [286.128640] [082/137] (702s left) gem_exec_reloc (basic-wc-cpu-noreloc) [286.173369] Starting subtest: basic-wc-cpu-noreloc [286.175376] Subtest basic-wc-cpu-noreloc: SUCCESS (0.002s) [286.253084] [083/137] (702s left) kms_pipe_crc_basic (nonblocking-crc) [286.341723] Starting subtest: nonblocking-crc [286.342518] Starting dynamic subtest: pipe-A-HDMI-A-1 [286.657499] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.315s) [286.663721] Starting dynamic subtest: pipe-B-HDMI-A-1 [286.973152] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.314s) [286.979546] Starting dynamic subtest: pipe-C-HDMI-A-1 [287.281560] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.308s) [287.286884] Starting dynamic subtest: pipe-D-HDMI-A-1 [287.588119] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.305s) [287.588913] Subtest nonblocking-crc: SUCCESS (1.247s) [287.661060] [084/137] (701s left) syncobj_wait (wait-any-snapshot) [287.709205] Starting subtest: wait-any-snapshot [287.790435] Subtest wait-any-snapshot: SUCCESS (0.081s) [287.826251] [085/137] (701s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [287.868549] Starting subtest: single-wait-all-for-submit-available-signaled [287.869419] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [287.909598] [086/137] (701s left) gem_exec_schedule (reorder-wide) [288.081801] Starting subtest: reorder-wide [288.083028] Starting dynamic subtest: rcs0 [288.143211] Dynamic subtest rcs0: SUCCESS (0.066s) [288.152670] Starting dynamic subtest: bcs0 [288.206604] Dynamic subtest bcs0: SUCCESS (0.063s) [288.215769] Starting dynamic subtest: vcs0 [288.268700] Dynamic subtest vcs0: SUCCESS (0.061s) [288.278363] Starting dynamic subtest: vcs1 [288.330417] Dynamic subtest vcs1: SUCCESS (0.061s) [288.340166] Starting dynamic subtest: vecs0 [288.392380] Dynamic subtest vecs0: SUCCESS (0.061s) [288.393465] Subtest reorder-wide: SUCCESS (0.316s) [288.545185] [087/137] (700s left) kms_prop_blob (invalid-get-prop-any) [288.599955] Starting subtest: invalid-get-prop-any [288.600767] Subtest invalid-get-prop-any: SUCCESS (0.000s) [288.634229] [088/137] (700s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [288.730998] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [288.732616] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [288.793147] [089/137] (700s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs) [288.979798] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs [288.981148] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s) [289.249048] [090/137] (699s left) kms_plane_multiple (tiling-yf) [289.348266] Starting subtest: tiling-yf [289.349788] Subtest tiling-yf: SKIP (0.000s) [289.382225] [091/137] (699s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [289.479176] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [289.480766] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [289.540131] [092/137] (699s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [289.629490] Starting subtest: plane-all-transition-nonblocking-fencing [289.631656] Starting dynamic subtest: pipe-A-HDMI-A-1 [291.558769] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.928s) [291.623071] Starting dynamic subtest: pipe-B-HDMI-A-1 [293.614714] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.997s) [293.657672] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (4.028s) [293.756534] [093/137] (695s left) perf_pmu (event-wait) [293.802816] Starting subtest: event-wait [293.803602] Starting dynamic subtest: rcs0 [293.805148] Dynamic subtest rcs0: SKIP (0.000s) [293.806605] Subtest event-wait: SKIP (0.000s) [293.839414] [094/137] (695s left) kms_vblank (pipe-b-query-idle-hang) [293.930045] Starting subtest: pipe-B-query-idle-hang [307.720539] Subtest pipe-B-query-idle-hang: SUCCESS (13.791s) [307.838264] [095/137] (681s left) kms_cursor_legacy (cursor-vs-flip-atomic) [307.931834] Starting subtest: cursor-vs-flip-atomic [335.565351] Subtest cursor-vs-flip-atomic: SUCCESS (27.633s) [335.656471] [096/137] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [335.753110] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [335.754493] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [335.814305] [097/137] (653s left) i915_pm_lpsp (kms-lpsp) [336.910102] Starting subtest: kms-lpsp [336.910838] Starting dynamic subtest: kms-lpsp-HDMI-A [338.377312] Dynamic subtest kms-lpsp-HDMI-A: FAIL (1.402s) [338.378013] Subtest kms-lpsp: FAIL (1.459s) [338.460932] [098/137] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [338.561825] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [338.563165] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [338.618353] [099/137] (650s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [338.714035] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [339.305921] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.591s) [339.384530] [100/137] (649s left) kms_flip (basic-flip-vs-wf_vblank) [339.471767] Starting subtest: basic-flip-vs-wf_vblank [339.474871] Starting dynamic subtest: A-HDMI-A1 [340.295242] Dynamic subtest A-HDMI-A1: SUCCESS (0.820s) [340.301811] Starting dynamic subtest: B-HDMI-A1 [341.090220] Dynamic subtest B-HDMI-A1: SUCCESS (0.792s) [341.094938] Starting dynamic subtest: C-HDMI-A1 [341.877811] Dynamic subtest C-HDMI-A1: SUCCESS (0.786s) [341.883797] Starting dynamic subtest: D-HDMI-A1 [342.664018] Dynamic subtest D-HDMI-A1: SUCCESS (0.786s) [342.664754] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.192s) [342.782407] [101/137] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [342.878585] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [343.977685] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (1.101s) [344.056394] [102/137] (645s left) kms_atomic_transition (modeset-transition-nonblocking) [344.147090] Starting subtest: modeset-transition-nonblocking [344.147885] Starting dynamic subtest: 1x-outputs [347.341347] Dynamic subtest 1x-outputs: SUCCESS (3.194s) [347.399010] Subtest modeset-transition-nonblocking: SUCCESS (3.252s) [347.506126] [103/137] (641s left) gem_softpin (evict-active-interruptible) [347.554882] Starting subtest: evict-active-interruptible [347.559536] Subtest evict-active-interruptible: SUCCESS (0.005s) [347.626015] [104/137] (641s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [347.670190] Starting subtest: multi-wait-all-for-submit-submitted-signaled [347.776890] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [347.809810] [105/137] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [347.904831] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [347.906410] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [347.967956] [106/137] (641s left) perf (i915-ref-count) [348.048934] Starting subtest: i915-ref-count [348.063509] Subtest i915-ref-count: SUCCESS (0.015s) [348.082160] [107/137] (641s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [348.170188] Starting subtest: basic-busy-flip-before-cursor-legacy [348.171661] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [348.209958] [108/137] (641s left) gem_exec_fence (syncobj-timeline-repeat) [348.608194] Starting subtest: syncobj-timeline-repeat [348.829999] Subtest syncobj-timeline-repeat: SUCCESS (0.219s) [348.960241] [109/137] (640s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs) [349.215931] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs [349.217439] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s) [349.390212] [110/137] (640s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [349.483298] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [350.076636] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.594s) [350.148533] [111/137] (639s left) syncobj_timeline (multi-wait-all-available-submitted) [350.191343] Starting subtest: multi-wait-all-available-submitted [350.192084] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [350.231629] [112/137] (639s left) vc4/vc4_tiling (set-bad-flags) [350.294402] Subtest set-bad-flags: SKIP (0.000s) [350.323566] [113/137] (639s left) kms_vblank (pipe-d-query-forked-busy-hang) [350.412975] Starting subtest: pipe-D-query-forked-busy-hang [364.557962] Subtest pipe-D-query-forked-busy-hang: SUCCESS (14.146s) [364.658225] [114/137] (624s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [364.751611] Starting subtest: fbc-1p-pri-indfb-multidraw [372.546796] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (7.796s) [372.626188] [115/137] (616s left) prime_mmap_kms (buffer-sharing) [372.717032] Starting subtest: buffer-sharing [372.852688] Subtest buffer-sharing: SUCCESS (0.137s) [372.943805] [116/137] (616s left) gem_ctx_isolation (dirty-create) [373.007008] Starting subtest: dirty-create [373.007870] Starting dynamic subtest: rcs0 [373.200244] Dynamic subtest rcs0: SUCCESS (0.184s) [373.205131] Starting dynamic subtest: bcs0 [373.422894] Dynamic subtest bcs0: SUCCESS (0.222s) [373.427748] Starting dynamic subtest: vcs0 [373.648590] Dynamic subtest vcs0: SUCCESS (0.225s) [373.653377] Starting dynamic subtest: vcs1 [373.877503] Dynamic subtest vcs1: SUCCESS (0.229s) [373.882311] Starting dynamic subtest: vecs0 [374.092813] Dynamic subtest vecs0: SUCCESS (0.215s) [374.093649] Subtest dirty-create: SUCCESS (1.077s) [374.245277] [117/137] (615s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs) [374.502493] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs [374.504006] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [374.699521] [118/137] (614s left) gem_pxp (create-protected-buffer) [377.267836] Subtest create-protected-buffer: SKIP (0.000s) [377.305340] [119/137] (612s left) gem_exec_balancer (parallel) [377.557698] Starting subtest: parallel [378.391745] Subtest parallel: SUCCESS (0.834s) [378.425610] [120/137] (611s left) core_setmaster (master-drop-set-shared-fd) [378.939680] Starting subtest: master-drop-set-shared-fd [378.953040] Subtest master-drop-set-shared-fd: SUCCESS (0.013s) [378.962837] [121/137] (610s left) syncobj_basic (bad-pad-handle-to-fd) [379.005393] Starting subtest: bad-pad-handle-to-fd [379.006292] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [379.041332] [122/137] (610s left) kms_vblank (pipe-b-accuracy-idle) [379.139207] Starting subtest: pipe-B-accuracy-idle [380.395318] Subtest pipe-B-accuracy-idle: SUCCESS (1.257s) [380.480160] [123/137] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [380.572970] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [380.574418] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [380.613863] [124/137] (608s left) vc4/vc4_perfmon (destroy-invalid-perfmon) [380.676300] Subtest destroy-invalid-perfmon: SKIP (0.000s) [380.705361] [125/137] (608s left) gem_mmap_wc (read-write) [380.746887] Starting subtest: read-write [380.749765] Subtest read-write: SUCCESS (0.003s) [380.815109] [126/137] (608s left) gen9_exec_parse (batch-zero-length) [380.862412] Subtest batch-zero-length: SKIP (0.000s) [380.881404] [127/137] (608s left) gem_exec_reloc (basic-gtt-read-noreloc) [380.928076] Starting subtest: basic-gtt-read-noreloc [380.930178] Subtest basic-gtt-read-noreloc: SUCCESS (0.002s) [381.015264] [128/137] (608s left) sysfs_heartbeat_interval (precise) [381.063232] Starting subtest: precise [381.064025] Starting dynamic subtest: vecs0 [382.540490] Dynamic subtest vecs0: SUCCESS (1.476s) [382.547918] Starting dynamic subtest: vcs0 [384.026293] Dynamic subtest vcs0: SUCCESS (1.485s) [384.033079] Starting dynamic subtest: bcs0 [385.505472] Dynamic subtest bcs0: SUCCESS (1.478s) [385.512375] Starting dynamic subtest: rcs0 [386.986226] Dynamic subtest rcs0: SUCCESS (1.480s) [386.992772] Starting dynamic subtest: vcs1 [388.453160] Dynamic subtest vcs1: SUCCESS (1.466s) [388.454013] Subtest precise: SUCCESS (7.389s) [388.497172] [129/137] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [388.598093] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [388.599460] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [388.648008] [130/137] (600s left) kms_lease (lease_again) [388.736389] Starting subtest: lease_again [388.737144] Starting dynamic subtest: pipe-A-HDMI-A-1 [388.739496] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [388.744746] Starting dynamic subtest: pipe-B-HDMI-A-1 [388.745509] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [388.750723] Starting dynamic subtest: pipe-C-HDMI-A-1 [388.751483] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [388.756284] Starting dynamic subtest: pipe-D-HDMI-A-1 [388.757008] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [388.757698] Subtest lease_again: SUCCESS (0.008s) [388.781440] [131/137] (600s left) drm_fdinfo (busy-check-all) [388.824653] Starting subtest: busy-check-all [388.825426] Starting dynamic subtest: rcs0 [389.339353] Dynamic subtest rcs0: SUCCESS (0.510s) [389.344419] Starting dynamic subtest: bcs0 [389.852529] Dynamic subtest bcs0: SUCCESS (0.516s) [389.859955] Starting dynamic subtest: vcs0 [390.372157] Dynamic subtest vcs0: SUCCESS (0.518s) [390.380441] Starting dynamic subtest: vcs1 [390.893056] Dynamic subtest vcs1: SUCCESS (0.520s) [390.901398] Starting dynamic subtest: vecs0 [391.414484] Dynamic subtest vecs0: SUCCESS (0.521s) [391.415614] Subtest busy-check-all: SUCCESS (2.589s) [391.455979] [132/137] (598s left) syncobj_timeline (etime-single-wait-all-submitted) [391.503444] Starting subtest: etime-single-wait-all-submitted [391.609744] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [391.658675] [133/137] (598s left) kms_cursor_crc (cursor-onscreen-64x64) [391.752605] Starting subtest: cursor-onscreen-64x64 [391.757915] Starting dynamic subtest: pipe-A-HDMI-A-1 [392.908707] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.152s) [392.932052] Starting dynamic subtest: pipe-D-HDMI-A-1 [394.074713] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.147s) [394.075495] Subtest cursor-onscreen-64x64: SUCCESS (2.322s) [394.179286] [134/137] (595s left) perf_pmu (all-busy-check-all) [394.224607] Starting subtest: all-busy-check-all [394.739262] Subtest all-busy-check-all: SUCCESS (0.513s) [394.785429] [135/137] (594s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-0-25) [394.879635] Starting subtest: planes-downscale-factor-0-75-upscale-0-25 [394.880494] Starting dynamic subtest: pipe-A-HDMI-A-1 [394.940293] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.060s) [394.946502] Starting dynamic subtest: pipe-B-HDMI-A-1 [395.065422] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.123s) [395.072067] Starting dynamic subtest: pipe-C-HDMI-A-1 [395.174303] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.108s) [395.181024] Starting dynamic subtest: pipe-D-HDMI-A-1 [395.283111] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.107s) [395.283868] Subtest planes-downscale-factor-0-75-upscale-0-25: SUCCESS (0.404s) [395.398105] [136/137] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [395.494305] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [395.495913] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [395.556414] [137/137] (594s left) kms_atomic (crtc-invalid-params) [395.693944] Starting subtest: crtc-invalid-params [395.725060] Subtest crtc-invalid-params: SUCCESS (0.031s) [395.883533] Closing watchdogs Done.