[50.657645] Initializing watchdogs [50.657882] /dev/watchdog0 [50.674430] [001/137] (960s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs) [51.336375] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s) [51.647438] [002/137] (959s left) kms_vblank (pipe-c-wait-busy) [51.938167] Starting subtest: pipe-C-wait-busy [54.880477] Subtest pipe-C-wait-busy: SUCCESS (2.948s) [55.205366] [003/137] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [55.504646] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [55.508664] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [55.587857] [004/137] (955s left) perf (invalid-create-userspace-config) [55.937369] Starting subtest: invalid-create-userspace-config [55.939560] Subtest invalid-create-userspace-config: SUCCESS (0.005s) [55.986486] [005/137] (955s left) kms_frontbuffer_tracking (psr-slowdraw) [56.281018] Starting subtest: psr-slowdraw [56.284947] Subtest psr-slowdraw: SKIP (0.000s) [56.354672] [006/137] (954s left) kms_color (ctm-max) [56.637399] Starting subtest: ctm-max [56.639563] Starting dynamic subtest: pipe-A-DP-1 [57.140449] Dynamic subtest pipe-A-DP-1: SUCCESS (0.501s) [57.159051] Starting dynamic subtest: pipe-B-DP-1 [57.928406] Dynamic subtest pipe-B-DP-1: SUCCESS (0.786s) [57.945403] Starting dynamic subtest: pipe-C-DP-1 [58.860383] Dynamic subtest pipe-C-DP-1: SUCCESS (0.928s) [58.862302] Subtest ctm-max: SUCCESS (2.225s) [59.181141] [007/137] (952s left) gem_ctx_persistence (legacy-engines-hostile) [59.381565] Starting subtest: legacy-engines-hostile [59.387182] Starting dynamic subtest: render [59.501711] Dynamic subtest render: SUCCESS (0.114s) [59.517885] Starting dynamic subtest: bsd [59.590666] Dynamic subtest bsd: SUCCESS (0.086s) [59.608231] Starting dynamic subtest: blt [59.685687] Dynamic subtest blt: SUCCESS (0.094s) [59.701467] Starting dynamic subtest: vebox [59.777758] Dynamic subtest vebox: SUCCESS (0.092s) [59.779990] Subtest legacy-engines-hostile: SUCCESS (0.396s) [59.864287] [008/137] (951s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [60.160712] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [60.165551] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [60.248159] [009/137] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [60.551397] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [60.555127] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [60.648036] [010/137] (950s left) kms_flip (2x-flip-vs-panning) [60.926107] Starting subtest: 2x-flip-vs-panning [60.930030] Subtest 2x-flip-vs-panning: SKIP (0.003s) [61.030757] [011/137] (950s left) gem_ccs (ctrl-surf-copy-new-ctx) [61.226775] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [61.266304] [012/137] (950s left) kms_frontbuffer_tracking (fbc-tiling-y) [61.564815] Starting subtest: fbc-tiling-y [63.815523] Subtest fbc-tiling-y: SUCCESS (2.255s) [63.947593] [013/137] (947s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [64.153216] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [64.157189] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [64.348571] [014/137] (947s left) gem_mmap_gtt (cpuset-big-copy-xy) [64.534924] Starting subtest: cpuset-big-copy-XY [89.410786] Subtest cpuset-big-copy-XY: SUCCESS (24.875s) [89.834260] [015/137] (921s left) kms_3d [90.184335] [016/137] (921s left) kms_busy (basic) [90.499319] Starting subtest: basic [90.501449] Starting dynamic subtest: flip [91.294948] Dynamic subtest flip: SUCCESS (0.794s) [91.312479] Starting dynamic subtest: modeset [92.719526] Dynamic subtest modeset: SUCCESS (1.425s) [92.722545] Subtest basic: SUCCESS (2.222s) [93.084898] [017/137] (918s left) kms_cursor_legacy (torture-bo) [93.376789] Starting subtest: torture-bo [93.378977] Starting dynamic subtest: pipe-A [115.211517] Dynamic subtest pipe-A: SUCCESS (21.834s) [115.229835] Starting dynamic subtest: pipe-B [136.839809] Dynamic subtest pipe-B: SUCCESS (21.628s) [136.856653] Starting dynamic subtest: pipe-C [158.468242] Dynamic subtest pipe-C: SUCCESS (21.627s) [158.485077] Starting dynamic subtest: all-pipes [180.109483] Dynamic subtest all-pipes: SUCCESS (21.643s) [180.111686] Subtest torture-bo: SUCCESS (86.732s) [180.199203] [018/137] (831s left) gem_render_copy_redux (flink) [180.416252] Starting subtest: flink [184.925293] Subtest flink: SUCCESS (4.509s) [185.031645] [019/137] (826s left) gem_exec_whisper (basic-fds-forked) [185.237040] Starting subtest: basic-fds-forked [202.962412] Subtest basic-fds-forked: SUCCESS (17.723s) [203.167861] [020/137] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [203.557276] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [203.562323] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [203.659365] [021/137] (808s left) gem_exec_params (rel-constants-invalid-rel-gen5) [203.895202] Starting subtest: rel-constants-invalid-rel-gen5 [203.897762] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s) [204.004177] [022/137] (807s left) gen7_exec_parse (bitmasks) [204.226993] Subtest bitmasks: SKIP (0.000s) [204.269147] [023/137] (807s left) gem_exec_schedule (preempt-hang) [204.597431] Starting subtest: preempt-hang [204.599722] Starting dynamic subtest: rcs0 [204.884221] Dynamic subtest rcs0: SUCCESS (0.288s) [204.904237] Starting dynamic subtest: bcs0 [205.173329] Dynamic subtest bcs0: SUCCESS (0.289s) [205.191687] Starting dynamic subtest: vcs0 [205.441787] Dynamic subtest vcs0: SUCCESS (0.268s) [205.461704] Starting dynamic subtest: vecs0 [205.703182] Dynamic subtest vecs0: SUCCESS (0.261s) [205.705339] Subtest preempt-hang: SUCCESS (1.107s) [205.950944] [024/137] (805s left) gem_eio (create-ext) [206.191740] Starting subtest: create-ext [206.239182] Subtest create-ext: SUCCESS (0.048s) [206.404912] [025/137] (805s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [206.683520] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [206.685687] Starting dynamic subtest: pipe-A-valid-mode [206.807931] Dynamic subtest pipe-A-valid-mode: SKIP (0.125s) [206.811896] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.127s) [207.138731] [026/137] (804s left) api_intel_allocator (two-level-inception) [207.322971] Starting subtest: two-level-inception [212.809686] Subtest two-level-inception: SUCCESS (5.484s) [212.887548] [027/137] (799s left) kms_chamelium_hpd (hdmi-hpd) [213.271343] Subtest hdmi-hpd: SKIP (0.000s) [213.551759] [028/137] (798s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [213.737854] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [213.780626] [029/137] (798s left) kms_psr (psr2_cursor_blt) [213.963110] Subtest psr2_cursor_blt: SKIP (0.000s) [214.012278] [030/137] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [214.302930] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [214.306899] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [214.410313] [031/137] (797s left) syncobj_timeline (invalid-signal-illegal-point) [214.593667] Starting subtest: invalid-signal-illegal-point [214.595953] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [214.677358] [032/137] (797s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [214.963851] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [214.968054] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [215.060772] [033/137] (797s left) kms_cursor_crc (cursor-sliding-512x512) [215.360163] Starting subtest: cursor-sliding-512x512 [215.364605] Subtest cursor-sliding-512x512: SKIP (0.002s) [215.477696] [034/137] (796s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [215.753689] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [215.755788] Starting dynamic subtest: pipe-A-valid-mode [216.434566] Dynamic subtest pipe-A-valid-mode: SKIP (0.674s) [216.438363] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.676s) [216.837159] [035/137] (795s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs) [217.298207] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs [217.754698] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SUCCESS (0.455s) [218.338093] [036/137] (794s left) i915_module_load (load) [218.518445] Starting subtest: load [218.525163] Subtest load: SKIP (0.003s) [218.584991] [037/137] (793s left) i915_pm_rpm (gem-idle) [220.365560] Starting subtest: gem-idle [225.818346] Subtest gem-idle: SUCCESS (5.450s) [226.240327] [038/137] (786s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [226.452406] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [226.456345] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [226.655107] [039/137] (785s left) v3d/v3d_submit_csd (single-out-sync) [226.886115] Subtest single-out-sync: SKIP (0.000s) [226.952254] [040/137] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [227.246725] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [229.449580] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.208s) [229.568629] [041/137] (782s left) gem_render_copy_redux (flink-interruptible) [229.779266] Starting subtest: flink-interruptible [234.377851] Subtest flink-interruptible: SUCCESS (4.599s) [234.487736] [042/137] (778s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs) [235.113116] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs [235.119819] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.004s) [235.436480] [043/137] (777s left) gem_partial_pwrite_pread (reads-snoop) [235.626954] Starting subtest: reads-snoop [241.830593] Subtest reads-snoop: SUCCESS (6.103s) [241.859698] [044/137] (770s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [242.177085] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [242.185481] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s) [242.270434] [045/137] (770s left) gem_lmem_swapping (parallel-random-engines) [242.460734] Subtest parallel-random-engines: SKIP (0.000s) [242.505554] [046/137] (770s left) kms_frontbuffer_tracking (basic) [242.792232] Starting subtest: basic [245.620157] Subtest basic: SUCCESS (2.827s) [245.734590] [047/137] (767s left) kms_cursor_crc (cursor-offscreen-32x10) [246.016904] Starting subtest: cursor-offscreen-32x10 [246.125531] Subtest cursor-offscreen-32x10: SKIP (0.103s) [246.237563] [048/137] (766s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [246.419825] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [246.523267] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s) [246.603311] [049/137] (766s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [246.887566] Starting subtest: plane-use-after-nonblocking-unbind-fencing [246.889935] Starting dynamic subtest: pipe-A-DP-1 [247.047747] Dynamic subtest pipe-A-DP-1: SUCCESS (0.163s) [247.153716] Starting dynamic subtest: pipe-B-DP-1 [247.681818] Dynamic subtest pipe-B-DP-1: SUCCESS (0.548s) [247.764474] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.881s) [248.097506] [050/137] (764s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [248.287809] Starting subtest: invalid-bsd1-flag-on-vebox [248.290484] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s) [248.380612] [051/137] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [248.676292] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [248.680355] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [248.763811] [052/137] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [249.057031] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [249.061203] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [249.164463] [053/137] (763s left) kms_rmfb (close-fd) [249.466393] Starting subtest: close-fd [249.468734] Starting dynamic subtest: pipe-A-DP-1 [249.584979] Dynamic subtest pipe-A-DP-1: SUCCESS (0.115s) [249.612692] Starting dynamic subtest: pipe-B-DP-1 [250.016851] Dynamic subtest pipe-B-DP-1: SUCCESS (0.433s) [250.047076] Starting dynamic subtest: pipe-C-DP-1 [250.438533] Dynamic subtest pipe-C-DP-1: SUCCESS (0.423s) [250.440620] Subtest close-fd: SUCCESS (0.976s) [250.832115] [054/137] (762s left) syncobj_wait (reset-unsignaled) [251.016671] Starting subtest: reset-unsignaled [251.018750] Subtest reset-unsignaled: SUCCESS (0.000s) [251.098067] [055/137] (761s left) kms_invalid_mode (bad-vsync-start) [251.385939] Starting subtest: bad-vsync-start [251.388755] Starting dynamic subtest: DP-1-pipe-A [251.483322] Dynamic subtest DP-1-pipe-A: SUCCESS (0.102s) [251.503751] Starting dynamic subtest: DP-1-pipe-B [251.506116] Dynamic subtest DP-1-pipe-B: SUCCESS (0.013s) [251.525805] Starting dynamic subtest: DP-1-pipe-C [251.528146] Dynamic subtest DP-1-pipe-C: SUCCESS (0.013s) [251.530411] Subtest bad-vsync-start: SUCCESS (0.134s) [251.818629] [056/137] (761s left) api_intel_allocator (gem-pool) [251.999125] Starting subtest: gem-pool [252.015328] Subtest gem-pool: SUCCESS (0.017s) [252.118744] [057/137] (761s left) gem_exec_fair (basic-none) [252.323271] Starting subtest: basic-none [252.325371] Starting dynamic subtest: rcs0 [257.900200] Dynamic subtest rcs0: SUCCESS (5.575s) [257.923763] Starting dynamic subtest: bcs0 [257.927779] Dynamic subtest bcs0: SKIP (0.011s) [257.948151] Starting dynamic subtest: vcs0 [263.862109] Dynamic subtest vcs0: SUCCESS (5.950s) [263.882778] Starting dynamic subtest: vecs0 [269.843167] Dynamic subtest vecs0: SUCCESS (5.981s) [269.845166] Subtest basic-none: SUCCESS (17.519s) [270.036796] [058/137] (743s left) gem_userptr_blits (probe) [270.276764] Starting subtest: probe [271.407562] Subtest probe: SUCCESS (1.131s) [271.517918] [059/137] (741s left) kms_big_fb (linear-8bpp-rotate-270) [271.822233] Starting subtest: linear-8bpp-rotate-270 [271.894674] Subtest linear-8bpp-rotate-270: SKIP (0.071s) [272.003385] [060/137] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [272.310157] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [272.314068] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [272.402901] [061/137] (740s left) perf_pmu (multi-client) [272.595603] Starting subtest: multi-client [272.597824] Starting dynamic subtest: rcs0 [273.630832] Dynamic subtest rcs0: SUCCESS (1.032s) [273.651181] Starting dynamic subtest: bcs0 [274.657719] Dynamic subtest bcs0: SUCCESS (1.026s) [274.678283] Starting dynamic subtest: vcs0 [275.689202] Dynamic subtest vcs0: SUCCESS (1.030s) [275.709351] Starting dynamic subtest: vecs0 [276.718667] Dynamic subtest vecs0: SUCCESS (1.027s) [276.720969] Subtest multi-client: SUCCESS (4.121s) [276.819947] [062/137] (736s left) v3d/v3d_submit_cl (job-perfmon) [277.067755] Subtest job-perfmon: SKIP (0.000s) [277.136216] [063/137] (736s left) kms_cursor_legacy (flip-vs-cursor-toggle) [277.415462] Starting subtest: flip-vs-cursor-toggle [296.298473] Subtest flip-vs-cursor-toggle: SUCCESS (18.881s) [296.626327] [064/137] (716s left) i915_query (engine-info) [296.815830] Starting subtest: engine-info [296.818174] Subtest engine-info: SUCCESS (0.004s) [296.907294] [065/137] (716s left) gem_ppgtt (flink-and-close-vma-leak) [297.099921] Starting subtest: flink-and-close-vma-leak [297.111302] Subtest flink-and-close-vma-leak: SUCCESS (0.011s) [297.224353] [066/137] (716s left) syncobj_wait (multi-wait-all-for-submit-submitted) [297.407170] Starting subtest: multi-wait-all-for-submit-submitted [297.515177] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [297.605746] [067/137] (715s left) kms_scaling_modes (scaling-mode-center) [297.892445] Starting subtest: scaling-mode-center [297.896440] Subtest scaling-mode-center: SKIP (0.001s) [297.974256] [068/137] (715s left) gem_mmap_wc (bad-size) [298.157588] Starting subtest: bad-size [298.159998] Subtest bad-size: SUCCESS (0.002s) [298.257848] [069/137] (715s left) vgem_slow (nohang) [298.519721] Starting subtest: nohang [308.709834] Subtest nohang: SUCCESS (10.190s) [308.772535] [070/137] (704s left) kms_chamelium_frames (hdmi-crc-multiple) [309.154773] Subtest hdmi-crc-multiple: SKIP (0.000s) [309.451358] [071/137] (704s left) gem_ctx_shared (exec-single-timeline) [309.656724] Starting subtest: exec-single-timeline [309.659055] Starting dynamic subtest: rcs0 [310.691771] Dynamic subtest rcs0: SUCCESS (1.032s) [310.717123] Starting dynamic subtest: bcs0 [311.779643] Dynamic subtest bcs0: SUCCESS (1.086s) [311.805287] Starting dynamic subtest: vcs0 [312.867961] Dynamic subtest vcs0: SUCCESS (1.087s) [312.893375] Starting dynamic subtest: vecs0 [313.955614] Dynamic subtest vecs0: SUCCESS (1.087s) [313.957808] Subtest exec-single-timeline: SUCCESS (4.298s) [314.174561] [072/137] (699s left) gem_bad_reloc (negative-reloc) [314.370057] Starting subtest: negative-reloc [314.375836] Subtest negative-reloc: SUCCESS (0.002s) [314.472976] [073/137] (699s left) syncobj_wait (invalid-reset-zero-handles) [314.660535] Starting subtest: invalid-reset-zero-handles [314.662810] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [314.740629] [074/137] (699s left) v3d/v3d_perfmon (create-perfmon-0) [314.987572] Subtest create-perfmon-0: SKIP (0.000s) [315.056172] [075/137] (698s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [315.541470] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs [315.545515] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [315.984226] [076/137] (697s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs) [316.606363] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s) [316.916521] [077/137] (696s left) kms_cdclk (mode-transition) [317.100507] Subtest mode-transition: SKIP (0.000s) [317.151870] [078/137] (696s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [317.427096] Starting subtest: cursor-vs-flip-atomic-transitions [354.629224] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (37.206s) [354.972196] [079/137] (658s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [355.393163] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs [355.396977] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [355.906227] [080/137] (658s left) kms_writeback (writeback-fb-id) [356.302066] Subtest writeback-fb-id: SKIP (0.000s) [356.358856] [081/137] (657s left) gem_exec_reloc (basic-scanout) [356.661540] Starting subtest: basic-scanout [356.663503] Starting dynamic subtest: rcs0 [356.914967] Dynamic subtest rcs0: SUCCESS (0.258s) [356.936268] Starting dynamic subtest: bcs0 [357.081560] Dynamic subtest bcs0: SUCCESS (0.166s) [357.102797] Starting dynamic subtest: vcs0 [357.250147] Dynamic subtest vcs0: SUCCESS (0.166s) [357.271169] Starting dynamic subtest: vecs0 [357.417774] Dynamic subtest vecs0: SUCCESS (0.165s) [357.419983] Subtest basic-scanout: SUCCESS (0.759s) [357.541468] [082/137] (656s left) gem_exec_reloc (basic-wc-cpu-noreloc) [357.735171] Starting subtest: basic-wc-cpu-noreloc [357.747693] Subtest basic-wc-cpu-noreloc: SUCCESS (0.012s) [357.939090] [083/137] (656s left) kms_pipe_crc_basic (nonblocking-crc) [358.227507] Starting subtest: nonblocking-crc [358.229880] Starting dynamic subtest: pipe-A-DP-1 [358.812869] Dynamic subtest pipe-A-DP-1: SUCCESS (0.585s) [358.835668] Starting dynamic subtest: pipe-B-DP-1 [359.682670] Dynamic subtest pipe-B-DP-1: SUCCESS (0.865s) [359.705448] Starting dynamic subtest: pipe-C-DP-1 [360.693488] Dynamic subtest pipe-C-DP-1: SUCCESS (1.005s) [360.697724] Subtest nonblocking-crc: SUCCESS (2.464s) [360.990392] [084/137] (653s left) syncobj_wait (wait-any-snapshot) [361.176137] Starting subtest: wait-any-snapshot [361.258868] Subtest wait-any-snapshot: SUCCESS (0.082s) [361.337808] [085/137] (652s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [361.523260] Starting subtest: single-wait-all-for-submit-available-signaled [361.525617] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [361.604134] [086/137] (652s left) gem_exec_schedule (reorder-wide) [361.938874] Starting subtest: reorder-wide [361.941294] Starting dynamic subtest: rcs0 [362.110490] Dynamic subtest rcs0: SUCCESS (0.167s) [362.137566] Starting dynamic subtest: bcs0 [362.443488] Dynamic subtest bcs0: SUCCESS (0.334s) [362.469671] Starting dynamic subtest: vcs0 [362.603853] Dynamic subtest vcs0: SUCCESS (0.159s) [362.636418] Starting dynamic subtest: vecs0 [362.761828] Dynamic subtest vecs0: SUCCESS (0.158s) [362.764116] Subtest reorder-wide: SUCCESS (0.823s) [362.988059] [087/137] (651s left) kms_prop_blob (invalid-get-prop-any) [363.168994] Starting subtest: invalid-get-prop-any [363.191182] Subtest invalid-get-prop-any: SUCCESS (0.000s) [363.255463] [088/137] (651s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [363.559068] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [363.563518] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [363.672443] [089/137] (650s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs) [364.082714] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs [364.085069] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s) [364.614253] [090/137] (649s left) kms_plane_multiple (tiling-yf) [364.901430] Starting subtest: tiling-yf [364.903852] Starting dynamic subtest: pipe-A-DP-1 [366.650730] Dynamic subtest pipe-A-DP-1: SUCCESS (1.748s) [366.672320] Starting dynamic subtest: pipe-B-DP-1 [368.689632] Dynamic subtest pipe-B-DP-1: SUCCESS (2.036s) [368.710349] Starting dynamic subtest: pipe-C-DP-1 [370.667141] Dynamic subtest pipe-C-DP-1: SUCCESS (1.974s) [370.669330] Subtest tiling-yf: SUCCESS (5.765s) [371.021979] [091/137] (643s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [371.328313] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [371.332440] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [371.422268] [092/137] (643s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [371.702964] Starting subtest: plane-all-transition-nonblocking-fencing [371.704918] Starting dynamic subtest: pipe-A-DP-1 [375.614412] Dynamic subtest pipe-A-DP-1: SUCCESS (3.912s) [375.751677] Starting dynamic subtest: pipe-B-DP-1 [380.090304] Dynamic subtest pipe-B-DP-1: SUCCESS (4.375s) [380.189932] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (8.489s) [380.522511] [093/137] (633s left) perf_pmu (event-wait) [380.724950] Starting subtest: event-wait [380.727489] Starting dynamic subtest: rcs0 [380.731998] Dynamic subtest rcs0: SKIP (0.000s) [380.736249] Subtest event-wait: SKIP (0.002s) [380.822382] [094/137] (633s left) kms_vblank (pipe-b-query-idle-hang) [381.110396] Starting subtest: pipe-B-query-idle-hang [388.541406] Subtest pipe-B-query-idle-hang: SUCCESS (7.429s) [388.866903] [095/137] (625s left) kms_cursor_legacy (cursor-vs-flip-atomic) [389.145904] Starting subtest: cursor-vs-flip-atomic [425.657185] Subtest cursor-vs-flip-atomic: SUCCESS (36.513s) [425.970547] [096/137] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [426.265751] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [426.269645] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [426.368849] [097/137] (588s left) i915_pm_lpsp (kms-lpsp) [427.664770] Starting subtest: kms-lpsp [427.666905] Starting dynamic subtest: kms-lpsp-DP [427.670772] Dynamic subtest kms-lpsp-DP: SKIP (0.000s) [427.674581] Subtest kms-lpsp: SKIP (0.002s) [427.835740] [098/137] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [428.130535] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [428.134589] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [428.236322] [099/137] (586s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [428.548517] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [428.580483] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.034s) [428.685816] [100/137] (586s left) kms_flip (basic-flip-vs-wf_vblank) [428.965195] Starting subtest: basic-flip-vs-wf_vblank [428.967149] Starting dynamic subtest: A-DP1 [430.457097] Dynamic subtest A-DP1: SUCCESS (1.491s) [430.478144] Starting dynamic subtest: B-DP1 [431.873272] Dynamic subtest B-DP1: SUCCESS (1.414s) [431.894560] Starting dynamic subtest: C-DP1 [433.268072] Dynamic subtest C-DP1: SUCCESS (1.395s) [433.270128] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.310s) [433.687132] [101/137] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [433.988784] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [436.277792] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.293s) [436.399530] [102/137] (578s left) kms_atomic_transition (modeset-transition-nonblocking) [436.682199] Starting subtest: modeset-transition-nonblocking [436.684175] Starting dynamic subtest: 1x-outputs [441.462773] Dynamic subtest 1x-outputs: SUCCESS (4.783s) [441.557373] Subtest modeset-transition-nonblocking: SUCCESS (4.874s) [441.884925] [103/137] (573s left) gem_softpin (evict-active-interruptible) [442.084426] Starting subtest: evict-active-interruptible [442.108782] Subtest evict-active-interruptible: SUCCESS (0.023s) [442.218415] [104/137] (572s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [442.402741] Starting subtest: multi-wait-all-for-submit-submitted-signaled [442.507058] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s) [442.600114] [105/137] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [442.893098] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [442.897218] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [442.984154] [106/137] (572s left) perf (i915-ref-count) [443.261108] Starting subtest: i915-ref-count [443.347548] Subtest i915-ref-count: SUCCESS (0.086s) [443.416917] [107/137] (571s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [443.698706] Starting subtest: basic-busy-flip-before-cursor-legacy [443.702555] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [443.783332] [108/137] (571s left) gem_exec_fence (syncobj-timeline-repeat) [444.530942] Starting subtest: syncobj-timeline-repeat [445.642482] Subtest syncobj-timeline-repeat: SUCCESS (1.111s) [445.833749] [109/137] (569s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs) [446.405136] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs [446.409639] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.001s) [446.768474] [110/137] (568s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [447.074876] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [448.410547] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.337s) [448.570474] [111/137] (566s left) syncobj_timeline (multi-wait-all-available-submitted) [448.763287] Starting subtest: multi-wait-all-available-submitted [448.765921] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s) [448.852400] [112/137] (566s left) vc4/vc4_tiling (set-bad-flags) [449.096583] Subtest set-bad-flags: SKIP (0.000s) [449.168454] [113/137] (566s left) kms_vblank (pipe-d-query-forked-busy-hang) [449.452947] Subtest pipe-D-query-forked-busy-hang: SKIP (0.000s) [449.535939] [114/137] (565s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [449.836377] Starting subtest: fbc-1p-pri-indfb-multidraw [464.946047] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (15.112s) [465.084185] [115/137] (550s left) prime_mmap_kms (buffer-sharing) [465.370492] Starting subtest: buffer-sharing [465.643972] Subtest buffer-sharing: SUCCESS (0.274s) [465.975634] [116/137] (549s left) gem_ctx_isolation (dirty-create) [466.181099] Starting subtest: dirty-create [466.183810] Starting dynamic subtest: rcs0 [467.775094] Dynamic subtest rcs0: SUCCESS (1.592s) [467.795690] Starting dynamic subtest: bcs0 [469.938790] Dynamic subtest bcs0: SUCCESS (2.162s) [469.961822] Starting dynamic subtest: vcs0 [471.522163] Dynamic subtest vcs0: SUCCESS (1.581s) [471.543189] Starting dynamic subtest: vecs0 [473.100106] Dynamic subtest vecs0: SUCCESS (1.577s) [473.102769] Subtest dirty-create: SUCCESS (6.918s) [473.289385] [117/137] (542s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs) [473.827356] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs [473.831329] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [474.235829] [118/137] (541s left) gem_pxp (create-protected-buffer) [476.941796] Subtest create-protected-buffer: SKIP (0.000s) [477.034682] [119/137] (538s left) gem_exec_balancer (parallel) [481.051391] Subtest parallel: SKIP (0.000s) [481.151198] [120/137] (534s left) core_setmaster (master-drop-set-shared-fd) [482.998901] Starting subtest: master-drop-set-shared-fd [483.043229] Subtest master-drop-set-shared-fd: SUCCESS (0.044s) [483.081692] [121/137] (532s left) syncobj_basic (bad-pad-handle-to-fd) [483.267579] Starting subtest: bad-pad-handle-to-fd [483.269914] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [483.351386] [122/137] (532s left) kms_vblank (pipe-b-accuracy-idle) [483.639132] Starting subtest: pipe-B-accuracy-idle [486.319246] Subtest pipe-B-accuracy-idle: SUCCESS (2.684s) [486.652853] [123/137] (529s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [486.949790] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [486.953750] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [487.036164] [124/137] (528s left) vc4/vc4_perfmon (destroy-invalid-perfmon) [487.280787] Subtest destroy-invalid-perfmon: SKIP (0.000s) [487.352834] [125/137] (528s left) gem_mmap_wc (read-write) [487.535692] Starting subtest: read-write [487.568348] Subtest read-write: SUCCESS (0.030s) [487.687203] [126/137] (528s left) gen9_exec_parse (batch-zero-length) [487.894230] Starting subtest: batch-zero-length [487.899794] Subtest batch-zero-length: SUCCESS (0.002s) [488.101158] [127/137] (527s left) gem_exec_reloc (basic-gtt-read-noreloc) [488.294686] Starting subtest: basic-gtt-read-noreloc [488.305764] Subtest basic-gtt-read-noreloc: SUCCESS (0.010s) [488.486830] [128/137] (527s left) sysfs_heartbeat_interval (precise) [488.679416] Starting subtest: precise [488.681945] Starting dynamic subtest: vecs0 [490.185701] Dynamic subtest vecs0: SUCCESS (1.503s) [490.208186] Starting dynamic subtest: vcs0 [491.671996] Dynamic subtest vcs0: SUCCESS (1.484s) [491.696421] Starting dynamic subtest: bcs0 [493.157733] Dynamic subtest bcs0: SUCCESS (1.484s) [493.183381] Starting dynamic subtest: rcs0 [494.655887] Dynamic subtest rcs0: SUCCESS (1.496s) [494.658159] Subtest precise: SUCCESS (5.975s) [494.735842] [129/137] (521s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [495.031069] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [495.034979] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [495.136355] [130/137] (520s left) kms_lease (lease_again) [495.419097] Starting subtest: lease_again [495.423161] Starting dynamic subtest: pipe-A-DP-1 [495.425749] Dynamic subtest pipe-A-DP-1: SUCCESS (0.005s) [495.454335] Starting dynamic subtest: pipe-B-DP-1 [495.456400] Dynamic subtest pipe-B-DP-1: SUCCESS (0.004s) [495.478706] Starting dynamic subtest: pipe-C-DP-1 [495.480647] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s) [495.482697] Subtest lease_again: SUCCESS (0.021s) [495.536196] [131/137] (520s left) drm_fdinfo (busy-check-all) [495.730046] Starting subtest: busy-check-all [495.732234] Starting dynamic subtest: rcs0 [496.261598] Dynamic subtest rcs0: SUCCESS (0.531s) [496.284099] Starting dynamic subtest: bcs0 [496.800340] Dynamic subtest bcs0: SUCCESS (0.537s) [496.821498] Starting dynamic subtest: vcs0 [497.336097] Dynamic subtest vcs0: SUCCESS (0.534s) [497.358085] Starting dynamic subtest: vecs0 [497.867277] Dynamic subtest vecs0: SUCCESS (0.529s) [497.869436] Subtest busy-check-all: SUCCESS (2.138s) [497.952063] [132/137] (518s left) syncobj_timeline (etime-single-wait-all-submitted) [498.143140] Starting subtest: etime-single-wait-all-submitted [498.244309] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [498.334825] [133/137] (517s left) kms_cursor_crc (cursor-onscreen-64x64) [498.627853] Starting subtest: cursor-onscreen-64x64 [498.637994] Starting dynamic subtest: pipe-A-DP-1 [500.977459] Dynamic subtest pipe-A-DP-1: SUCCESS (2.341s) [501.058509] Starting dynamic subtest: pipe-C-DP-1 [503.686301] Dynamic subtest pipe-C-DP-1: SUCCESS (2.650s) [503.688323] Subtest cursor-onscreen-64x64: SUCCESS (5.060s) [504.044332] [134/137] (512s left) perf_pmu (all-busy-check-all) [504.236427] Starting subtest: all-busy-check-all [504.762377] Subtest all-busy-check-all: SUCCESS (0.526s) [504.855695] [135/137] (511s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-0-25) [505.135167] Starting subtest: planes-downscale-factor-0-75-upscale-0-25 [505.137349] Starting dynamic subtest: pipe-A-DP-1 [505.215603] Dynamic subtest pipe-A-DP-1: SUCCESS (0.081s) [505.243147] Starting dynamic subtest: pipe-B-DP-1 [505.588735] Dynamic subtest pipe-B-DP-1: SUCCESS (0.369s) [505.635227] Starting dynamic subtest: pipe-C-DP-1 [505.680805] Dynamic subtest pipe-C-DP-1: SKIP (0.084s) [505.682827] Subtest planes-downscale-factor-0-75-upscale-0-25: SUCCESS (0.545s) [506.070696] [136/137] (510s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [506.364074] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [506.367915] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [506.454449] [137/137] (509s left) kms_atomic (crtc-invalid-params) [506.862813] Starting subtest: crtc-invalid-params [506.913335] Subtest crtc-invalid-params: SUCCESS (0.051s) [507.321115] Closing watchdogs Done.