[43.632462] Initializing watchdogs [43.632503] /dev/watchdog0 [43.639271] [001/130] (960s left) kms_color (legacy-gamma) [45.643085] Starting subtest: legacy-gamma [45.645267] Starting dynamic subtest: pipe-A-HDMI-A-2 [46.307387] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.674s) [46.313518] Starting dynamic subtest: pipe-B-HDMI-A-2 [46.764042] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.461s) [46.768928] Starting dynamic subtest: pipe-C-HDMI-A-2 [47.222683] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.464s) [47.227478] Starting dynamic subtest: pipe-D-HDMI-A-2 [47.702276] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.484s) [47.703220] Subtest legacy-gamma: SUCCESS (2.088s) [47.833569] [002/130] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [49.831780] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [49.833554] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [49.915171] [003/130] (954s left) syncobj_timeline (invalid-signal-zero-handles) [50.042260] Starting subtest: invalid-signal-zero-handles [50.043314] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [50.134056] [004/130] (953s left) gem_exec_reloc (basic-cpu-read-noreloc) [50.232523] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [50.266539] [005/130] (953s left) kms_properties (invalid-properties-legacy) [52.267956] Starting subtest: invalid-properties-legacy [52.457830] Subtest invalid-properties-legacy: SUCCESS (0.191s) [52.524264] [006/130] (951s left) gem_exec_capture (capture-invisible) [52.597082] Starting subtest: capture-invisible [52.598022] Starting dynamic subtest: lmem0 [52.599712] Dynamic subtest lmem0: SKIP (0.000s) [52.604636] Starting dynamic subtest: smem0 [52.606813] Dynamic subtest smem0: SKIP (0.000s) [52.609214] Subtest capture-invisible: SKIP (0.000s) [52.697505] [007/130] (951s left) kms_chamelium_color (ctm-red-to-blue) [54.713559] Subtest ctm-red-to-blue: SKIP (0.000s) [54.737225] [008/130] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [56.734275] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [56.735862] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [56.805034] [009/130] (947s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [58.896081] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [58.897007] Starting dynamic subtest: pipe-A [58.980886] Dynamic subtest pipe-A: SUCCESS (0.085s) [58.987938] Starting dynamic subtest: pipe-B [59.107694] Dynamic subtest pipe-B: SUCCESS (0.127s) [59.116814] Starting dynamic subtest: pipe-C [59.248206] Dynamic subtest pipe-C: SUCCESS (0.141s) [59.253522] Starting dynamic subtest: pipe-D [59.354098] Dynamic subtest pipe-D: SUCCESS (0.106s) [59.355114] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.459s) [59.492781] [010/130] (944s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [61.503576] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [61.528721] [011/130] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [63.506803] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [63.509216] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [63.585980] [012/130] (940s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [65.650081] Starting subtest: 2x-long-flip-vs-cursor-atomic [65.652875] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s) [65.713657] [013/130] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [67.733310] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [67.735196] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [67.816406] [014/130] (936s left) drm_fdinfo (virtual-busy-idle-all) [67.935600] Starting subtest: virtual-busy-idle-all [67.937505] Subtest virtual-busy-idle-all: SKIP (0.000s) [68.018142] [015/130] (936s left) kms_psr (psr2-sprite-blt) [70.053100] Subtest psr2-sprite-blt: SKIP (0.000s) [70.084782] [016/130] (934s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [72.088132] Starting subtest: psr-rgb101010-draw-blt [72.090212] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [72.162331] [017/130] (932s left) kms_cursor_crc (cursor-onscreen-32x10) [74.288874] Starting subtest: cursor-onscreen-32x10 [74.325295] Subtest cursor-onscreen-32x10: SKIP (0.034s) [74.613098] [018/130] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [76.654629] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [76.656270] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [76.727728] [019/130] (927s left) syncobj_wait (single-wait-all-signaled) [76.852271] Starting subtest: single-wait-all-signaled [76.853469] Subtest single-wait-all-signaled: SUCCESS (0.000s) [76.949820] [020/130] (927s left) kms_psr (fbc-psr-sprite-mmap-gtt) [79.003281] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [79.034353] [021/130] (925s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [79.089867] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [79.207039] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s) [79.280792] [022/130] (925s left) kms_writeback (writeback-fb-id) [81.293680] Subtest writeback-fb-id: SKIP (0.000s) [81.318817] [023/130] (923s left) kms_prop_blob (invalid-get-prop) [81.378034] Starting subtest: invalid-get-prop [81.379023] Subtest invalid-get-prop: SUCCESS (0.000s) [81.485398] [024/130] (922s left) gem_exec_schedule (u-submit-early-slice) [81.592070] Starting subtest: u-submit-early-slice [81.592995] Starting dynamic subtest: rcs0 [81.655150] Dynamic subtest rcs0: SUCCESS (0.063s) [81.660488] Starting dynamic subtest: bcs0 [81.695213] Dynamic subtest bcs0: SUCCESS (0.040s) [81.700476] Starting dynamic subtest: vcs0 [81.737486] Dynamic subtest vcs0: SUCCESS (0.042s) [81.742772] Starting dynamic subtest: vcs1 [81.789518] Dynamic subtest vcs1: SUCCESS (0.052s) [81.796729] Starting dynamic subtest: vecs0 [81.831839] Dynamic subtest vecs0: SUCCESS (0.042s) [81.837057] Starting dynamic subtest: vecs1 [81.872678] Dynamic subtest vecs1: SUCCESS (0.041s) [81.878084] Starting dynamic subtest: ccs0 [81.911304] Dynamic subtest ccs0: SUCCESS (0.038s) [81.912214] Subtest u-submit-early-slice: SUCCESS (0.319s) [82.301497] [025/130] (922s left) gem_exec_parallel (engines) [82.367304] Starting subtest: engines [82.368229] Starting dynamic subtest: basic [83.805762] Dynamic subtest basic: SUCCESS (1.438s) [83.811450] Starting dynamic subtest: contexts [87.620585] Dynamic subtest contexts: SUCCESS (3.813s) [87.625995] Starting dynamic subtest: fds [91.946214] Dynamic subtest fds: SUCCESS (4.324s) [91.952201] Starting dynamic subtest: userptr [93.338559] Dynamic subtest userptr: SUCCESS (1.392s) [93.339455] Subtest engines: SUCCESS (10.969s) [93.593390] [026/130] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [95.639285] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [95.641503] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [95.718551] [027/130] (908s left) kms_hdr (bpc-switch) [97.770124] Starting subtest: bpc-switch [97.772989] Subtest bpc-switch: SKIP (0.000s) [97.831693] [028/130] (906s left) gem_exec_fence (syncobj-invalid-flags) [98.379329] Starting subtest: syncobj-invalid-flags [98.380183] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [98.732026] [029/130] (905s left) kms_dsc (dsc-with-bpc) [100.725083] Starting subtest: dsc-with-bpc [100.727125] Subtest dsc-with-bpc: SKIP (0.000s) [100.782594] [030/130] (903s left) gem_wait (await) [100.909879] Starting subtest: await [100.911075] Starting dynamic subtest: all-engines [102.009469] Dynamic subtest all-engines: SUCCESS (1.099s) [102.022473] Starting dynamic subtest: rcs0 [103.067738] Dynamic subtest rcs0: SUCCESS (1.057s) [103.076568] Starting dynamic subtest: bcs0 [104.125819] Dynamic subtest bcs0: SUCCESS (1.058s) [104.136304] Starting dynamic subtest: vcs0 [105.185769] Dynamic subtest vcs0: SUCCESS (1.059s) [105.196744] Starting dynamic subtest: vcs1 [106.246763] Dynamic subtest vcs1: SUCCESS (1.060s) [106.257436] Starting dynamic subtest: vecs0 [107.310925] Dynamic subtest vecs0: SUCCESS (1.064s) [107.338408] Starting dynamic subtest: vecs1 [108.379974] Dynamic subtest vecs1: SUCCESS (1.068s) [108.390904] Starting dynamic subtest: ccs0 [109.442070] Dynamic subtest ccs0: SUCCESS (1.061s) [109.443945] Subtest await: SUCCESS (8.531s) [109.683355] [031/130] (894s left) kms_addfb_basic (bad-pitch-63) [109.735963] Starting subtest: bad-pitch-63 [109.736905] Subtest bad-pitch-63: SUCCESS (0.000s) [111.735269] [032/130] (892s left) sw_sync (sync_busy_fork_unixsocket) [111.834362] Starting subtest: sync_busy_fork_unixsocket [111.853389] Subtest sync_busy_fork_unixsocket: SUCCESS (0.019s) [111.917451] [033/130] (892s left) gem_mmap_wc (coherency) [112.014992] Subtest coherency: SKIP (0.000s) [112.042268] [034/130] (892s left) gem_mmap_offset (close-race) [112.096927] Starting subtest: close-race [132.131166] Subtest close-race: SUCCESS (20.033s) [132.211339] [035/130] (872s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [134.243337] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [134.245204] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [134.322637] [036/130] (870s left) gem_mmap_offset (ptrace) [134.443136] Starting subtest: ptrace [134.447515] Starting dynamic subtest: lmem0-fixed [134.540792] Dynamic subtest lmem0-fixed: SUCCESS (0.093s) [134.547786] Starting dynamic subtest: smem0-fixed [134.557087] Dynamic subtest smem0-fixed: SUCCESS (0.014s) [134.558095] Subtest ptrace: SUCCESS (0.115s) [134.639891] [037/130] (870s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [136.668091] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [136.669044] Starting dynamic subtest: pipe-A [136.997049] Dynamic subtest pipe-A: SKIP (0.328s) [137.002922] Starting dynamic subtest: pipe-B [137.476168] Dynamic subtest pipe-B: SKIP (0.478s) [137.482009] Starting dynamic subtest: pipe-C [137.952290] Dynamic subtest pipe-C: SKIP (0.476s) [137.958140] Starting dynamic subtest: pipe-D [138.428902] Dynamic subtest pipe-D: SKIP (0.477s) [138.430333] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (1.759s) [138.501292] [038/130] (866s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [140.488914] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [140.505944] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.016s) [140.570411] [039/130] (864s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [142.621234] Starting subtest: yf-tiled-64bpp-rotate-0 [142.622989] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [142.709582] [040/130] (862s left) kms_vblank (wait-forked-busy) [144.768177] Starting subtest: wait-forked-busy [144.770158] Starting dynamic subtest: pipe-A-HDMI-A-2 [147.191917] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.423s) [147.201152] Starting dynamic subtest: pipe-D-HDMI-A-2 [149.528064] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (2.333s) [149.528888] Subtest wait-forked-busy: SUCCESS (4.760s) [149.645292] [041/130] (855s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [151.645257] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [151.646221] Starting dynamic subtest: pipe-A-valid-mode [152.371502] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.724s) [152.372359] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (0.725s) [152.526801] [042/130] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [154.536764] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [157.044331] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.509s) [157.198508] [043/130] (847s left) kms_chamelium_frames (vga-frame-dump) [159.233801] Subtest vga-frame-dump: SKIP (0.000s) [159.290064] [044/130] (845s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [161.290359] Starting subtest: short-flip-before-cursor-toggle [162.283722] Subtest short-flip-before-cursor-toggle: SUCCESS (0.993s) [162.406705] [045/130] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [164.404104] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [164.405597] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [164.492501] [046/130] (840s left) kms_big_fb (4-tiled-64bpp-rotate-0) [166.565334] Starting subtest: 4-tiled-64bpp-rotate-0 [168.155473] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.589s) [168.301883] [047/130] (836s left) kms_prop_blob (invalid-set-prop-any) [168.362040] Starting subtest: invalid-set-prop-any [168.362861] Subtest invalid-set-prop-any: SUCCESS (0.000s) [168.459988] [048/130] (836s left) kms_dirtyfb (psr-dirtyfb-ioctl) [170.494287] Starting subtest: psr-dirtyfb-ioctl [170.496082] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [170.575469] [049/130] (834s left) syncobj_wait (invalid-signal-one-illegal-handle) [170.711785] Starting subtest: invalid-signal-one-illegal-handle [170.712781] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [170.812480] [050/130] (834s left) kms_force_connector_basic (prune-stale-modes) [170.987157] Starting subtest: prune-stale-modes [170.996828] Subtest prune-stale-modes: SKIP (0.009s) [173.070264] [051/130] (831s left) kms_psr (psr-sprite-plane-onoff) [175.076063] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [175.096281] [052/130] (829s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [177.091706] Starting subtest: fbcpsr-rgb101010-draw-blt [177.093516] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s) [177.176233] [053/130] (827s left) kms_lease (setcrtc-implicit-plane) [179.242202] Starting subtest: setcrtc-implicit-plane [179.243151] Starting dynamic subtest: pipe-A-HDMI-A-2 [179.576671] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.332s) [179.603435] Starting dynamic subtest: pipe-B-HDMI-A-2 [179.846371] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.266s) [179.853227] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.064259] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.216s) [180.071893] Starting dynamic subtest: pipe-D-HDMI-A-2 [180.251492] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.187s) [180.252465] Subtest setcrtc-implicit-plane: SUCCESS (1.009s) [180.381483] [054/130] (824s left) kms_big_fb (linear-32bpp-rotate-270) [182.410277] Starting subtest: linear-32bpp-rotate-270 [182.462099] Subtest linear-32bpp-rotate-270: SKIP (0.051s) [182.607026] [055/130] (822s left) gem_create (create-ext-cpu-access-big) [182.852528] Starting subtest: create-ext-cpu-access-big [187.988012] Disk usage limit exceeded. [276.545420] Warning: kernel log ringbuffer underflow, some records lost. [308.350522] Warning: kernel log ringbuffer underflow, some records lost. [308.397939] Timeout. Killing the current test with SIGKILL. [308.405044] Child refuses to die, tainted 0x200. Aborting. [308.407306] Closing watchdogs [308.408712] Closing watchdogs Done.