[43.215033] Initializing watchdogs
[43.215075]   /dev/watchdog0
[43.221237] [001/130] (960s left) kms_color (legacy-gamma)
[45.070069] Starting subtest: legacy-gamma
[45.071967] Starting dynamic subtest: pipe-A-HDMI-A-2
[45.721436] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.628s)
[45.726530] Starting dynamic subtest: pipe-B-HDMI-A-2
[46.182114] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.445s)
[46.187254] Starting dynamic subtest: pipe-C-HDMI-A-2
[46.661493] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.464s)
[46.666557] Starting dynamic subtest: pipe-D-HDMI-A-2
[47.144053] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.468s)
[47.144836] Subtest legacy-gamma: SUCCESS (2.009s)
[47.295292] [002/130] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[49.042144] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[49.043947] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[49.122326] [003/130] (954s left) syncobj_timeline (invalid-signal-zero-handles)
[49.238646] Starting subtest: invalid-signal-zero-handles
[49.239719] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[49.347792] [004/130] (954s left) gem_exec_reloc (basic-cpu-read-noreloc)
[49.441118] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[49.468629] [005/130] (954s left) kms_properties (invalid-properties-legacy)
[51.216027] Starting subtest: invalid-properties-legacy
[51.416496] Subtest invalid-properties-legacy: SUCCESS (0.197s)
[51.475930] [006/130] (952s left) gem_exec_capture (capture-invisible)
[51.548334] Starting subtest: capture-invisible
[51.549216] Starting dynamic subtest: lmem0
[51.550889] Dynamic subtest lmem0: SKIP (0.000s)
[51.556020] Starting dynamic subtest: smem0
[51.557963] Dynamic subtest smem0: SKIP (0.000s)
[51.560213] Subtest capture-invisible: SKIP (0.000s)
[51.651894] [007/130] (952s left) kms_chamelium_color (ctm-red-to-blue)
[53.429245] Subtest ctm-red-to-blue: SKIP (0.000s)
[53.448967] [008/130] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[55.429528] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[55.431217] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[55.492427] [009/130] (948s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[57.499947] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[57.500822] Starting dynamic subtest: pipe-A
[57.596097] Dynamic subtest pipe-A: SUCCESS (0.095s)
[57.604528] Starting dynamic subtest: pipe-B
[57.761496] Dynamic subtest pipe-B: SUCCESS (0.164s)
[57.768434] Starting dynamic subtest: pipe-C
[57.887120] Dynamic subtest pipe-C: SUCCESS (0.125s)
[57.892554] Starting dynamic subtest: pipe-D
[57.993462] Dynamic subtest pipe-D: SUCCESS (0.106s)
[57.994514] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.490s)
[58.132527] [010/130] (945s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[60.154328] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[60.169257] [011/130] (943s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[62.161557] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[62.163394] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[62.236596] [012/130] (941s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[64.281082] Starting subtest: 2x-long-flip-vs-cursor-atomic
[64.283856] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[64.341742] [013/130] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[66.392249] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[66.394093] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[66.466124] [014/130] (937s left) drm_fdinfo (virtual-busy-idle-all)
[66.577500] Starting subtest: virtual-busy-idle-all
[66.580299] Subtest virtual-busy-idle-all: SKIP (0.000s)
[66.651266] [015/130] (937s left) kms_psr (psr2-sprite-blt)
[68.686235] Subtest psr2-sprite-blt: SKIP (0.000s)
[68.711192] [016/130] (935s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[70.710095] Starting subtest: psr-rgb101010-draw-blt
[70.711690] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[70.771544] [017/130] (933s left) kms_cursor_crc (cursor-onscreen-32x10)
[72.877809] Starting subtest: cursor-onscreen-32x10
[72.916369] Subtest cursor-onscreen-32x10: SKIP (0.036s)
[73.178582] [018/130] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[75.215487] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[75.217447] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[75.293677] [019/130] (929s left) syncobj_wait (single-wait-all-signaled)
[75.411453] Starting subtest: single-wait-all-signaled
[75.412834] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[75.501440] [020/130] (928s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[77.538875] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[77.555699] [021/130] (926s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[77.613563] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[77.720090] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[77.801433] [022/130] (926s left) kms_writeback (writeback-fb-id)
[79.834300] Subtest writeback-fb-id: SKIP (0.000s)
[79.860879] [023/130] (924s left) kms_prop_blob (invalid-get-prop)
[79.916078] Starting subtest: invalid-get-prop
[79.916987] Subtest invalid-get-prop: SUCCESS (0.000s)
[80.003717] [024/130] (924s left) gem_exec_schedule (u-submit-early-slice)
[80.110235] Starting subtest: u-submit-early-slice
[80.111131] Starting dynamic subtest: rcs0
[80.172484] Dynamic subtest rcs0: SUCCESS (0.062s)
[80.178109] Starting dynamic subtest: bcs0
[80.214427] Dynamic subtest bcs0: SUCCESS (0.042s)
[80.219851] Starting dynamic subtest: vcs0
[80.256012] Dynamic subtest vcs0: SUCCESS (0.042s)
[80.261265] Starting dynamic subtest: vcs1
[80.297790] Dynamic subtest vcs1: SUCCESS (0.042s)
[80.302936] Starting dynamic subtest: vecs0
[80.344731] Dynamic subtest vecs0: SUCCESS (0.047s)
[80.353971] Starting dynamic subtest: vecs1
[80.393209] Dynamic subtest vecs1: SUCCESS (0.049s)
[80.398379] Starting dynamic subtest: ccs0
[80.433235] Dynamic subtest ccs0: SUCCESS (0.040s)
[80.434077] Subtest u-submit-early-slice: SUCCESS (0.322s)
[80.825974] [025/130] (923s left) gem_exec_parallel (engines)
[80.924716] Starting subtest: engines
[80.925641] Starting dynamic subtest: basic
[82.430961] Dynamic subtest basic: SUCCESS (1.503s)
[82.436785] Starting dynamic subtest: contexts
[85.649820] Dynamic subtest contexts: SUCCESS (3.214s)
[85.655524] Starting dynamic subtest: fds
[88.500079] Dynamic subtest fds: SUCCESS (2.846s)
[88.506187] Starting dynamic subtest: userptr
[89.875216] Dynamic subtest userptr: SUCCESS (1.374s)
[89.876140] Subtest engines: SUCCESS (8.938s)
[90.103935] [026/130] (914s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[92.146581] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[92.148471] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[92.221217] [027/130] (912s left) kms_hdr (bpc-switch)
[94.280153] Starting subtest: bpc-switch
[94.282932] Subtest bpc-switch: SKIP (0.000s)
[94.337140] [028/130] (910s left) gem_exec_fence (syncobj-invalid-flags)
[94.877116] Starting subtest: syncobj-invalid-flags
[94.877947] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[95.220057] [029/130] (909s left) kms_dsc (dsc-with-bpc)
[97.217120] Starting subtest: dsc-with-bpc
[97.219141] Subtest dsc-with-bpc: SKIP (0.000s)
[97.273652] [030/130] (907s left) gem_wait (await)
[97.391964] Starting subtest: await
[97.393642] Starting dynamic subtest: all-engines
[98.502350] Dynamic subtest all-engines: SUCCESS (1.110s)
[98.510885] Starting dynamic subtest: rcs0
[99.558508] Dynamic subtest rcs0: SUCCESS (1.055s)
[99.567595] Starting dynamic subtest: bcs0
[100.617062] Dynamic subtest bcs0: SUCCESS (1.058s)
[100.623267] Starting dynamic subtest: vcs0
[101.672600] Dynamic subtest vcs0: SUCCESS (1.054s)
[101.682726] Starting dynamic subtest: vcs1
[102.733677] Dynamic subtest vcs1: SUCCESS (1.060s)
[102.744378] Starting dynamic subtest: vecs0
[103.792715] Dynamic subtest vecs0: SUCCESS (1.058s)
[103.803357] Starting dynamic subtest: vecs1
[104.851668] Dynamic subtest vecs1: SUCCESS (1.058s)
[104.861803] Starting dynamic subtest: ccs0
[105.911705] Dynamic subtest ccs0: SUCCESS (1.059s)
[105.913514] Subtest await: SUCCESS (8.514s)
[106.135240] [031/130] (898s left) kms_addfb_basic (bad-pitch-63)
[106.183051] Starting subtest: bad-pitch-63
[106.183961] Subtest bad-pitch-63: SUCCESS (0.000s)
[108.181256] [032/130] (896s left) sw_sync (sync_busy_fork_unixsocket)
[108.262989] Starting subtest: sync_busy_fork_unixsocket
[108.278541] Subtest sync_busy_fork_unixsocket: SUCCESS (0.016s)
[108.325656] [033/130] (896s left) gem_mmap_wc (coherency)
[108.410110] Subtest coherency: SKIP (0.000s)
[108.441593] [034/130] (896s left) gem_mmap_offset (close-race)
[108.503959] Starting subtest: close-race
[128.534980] Subtest close-race: SUCCESS (20.023s)
[128.624239] [035/130] (876s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[130.655273] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[130.656913] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[130.726286] [036/130] (873s left) gem_mmap_offset (ptrace)
[130.843593] Starting subtest: ptrace
[130.846396] Starting dynamic subtest: lmem0-fixed
[130.947486] Dynamic subtest lmem0-fixed: SUCCESS (0.101s)
[130.954290] Starting dynamic subtest: smem0-fixed
[130.963688] Dynamic subtest smem0-fixed: SUCCESS (0.014s)
[130.964511] Subtest ptrace: SUCCESS (0.121s)
[131.073929] [037/130] (873s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[133.115009] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[133.115989] Starting dynamic subtest: pipe-A
[133.444668] Dynamic subtest pipe-A: SKIP (0.328s)
[133.450426] Starting dynamic subtest: pipe-B
[133.923683] Dynamic subtest pipe-B: SKIP (0.478s)
[133.929471] Starting dynamic subtest: pipe-C
[134.402146] Dynamic subtest pipe-C: SKIP (0.479s)
[134.407988] Starting dynamic subtest: pipe-D
[134.881489] Dynamic subtest pipe-D: SKIP (0.478s)
[134.883262] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (1.764s)
[134.957039] [038/130] (869s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[136.947788] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[136.964996] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.016s)
[137.026830] [039/130] (867s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[139.058279] Starting subtest: yf-tiled-64bpp-rotate-0
[139.060033] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[139.147883] [040/130] (865s left) kms_vblank (wait-forked-busy)
[141.212296] Starting subtest: wait-forked-busy
[141.213486] Starting dynamic subtest: pipe-A-HDMI-A-2
[143.619133] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.410s)
[143.629131] Starting dynamic subtest: pipe-D-HDMI-A-2
[145.974688] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (2.353s)
[145.975683] Subtest wait-forked-busy: SUCCESS (4.768s)
[146.091244] [041/130] (858s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[148.102207] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[148.103155] Starting dynamic subtest: pipe-A-valid-mode
[148.848366] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.744s)
[148.849395] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (0.746s)
[148.991760] [042/130] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[150.986732] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[153.490699] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.505s)
[153.647137] [043/130] (851s left) kms_chamelium_frames (vga-frame-dump)
[155.697058] Subtest vga-frame-dump: SKIP (0.000s)
[155.751112] [044/130] (849s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[157.755263] Starting subtest: short-flip-before-cursor-toggle
[158.743671] Subtest short-flip-before-cursor-toggle: SUCCESS (0.988s)
[158.903485] [045/130] (845s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[160.910967] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[160.912605] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[160.990228] [046/130] (843s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[163.065552] Starting subtest: 4-tiled-64bpp-rotate-0
[164.689520] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.624s)
[164.832340] [047/130] (840s left) kms_prop_blob (invalid-set-prop-any)
[164.886095] Starting subtest: invalid-set-prop-any
[164.886877] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[164.964811] [048/130] (839s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[167.000258] Starting subtest: psr-dirtyfb-ioctl
[167.002188] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[167.070515] [049/130] (837s left) syncobj_wait (invalid-signal-one-illegal-handle)
[167.174760] Starting subtest: invalid-signal-one-illegal-handle
[167.176173] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[167.278660] [050/130] (837s left) kms_force_connector_basic (prune-stale-modes)
[167.436492] Starting subtest: prune-stale-modes
[167.449873] Subtest prune-stale-modes: SKIP (0.012s)
[169.535245] [051/130] (835s left) kms_psr (psr-sprite-plane-onoff)
[171.542010] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[171.563614] [052/130] (833s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[173.549815] Starting subtest: fbcpsr-rgb101010-draw-blt
[173.551767] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[173.622113] [053/130] (831s left) kms_lease (setcrtc-implicit-plane)
[175.669069] Starting subtest: setcrtc-implicit-plane
[175.671163] Starting dynamic subtest: pipe-A-HDMI-A-2
[176.009198] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.337s)
[176.033865] Starting dynamic subtest: pipe-B-HDMI-A-2
[176.274724] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.262s)
[176.282057] Starting dynamic subtest: pipe-C-HDMI-A-2
[176.488453] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.214s)
[176.496874] Starting dynamic subtest: pipe-D-HDMI-A-2
[176.706491] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.217s)
[176.707458] Subtest setcrtc-implicit-plane: SUCCESS (1.037s)
[176.867420] [054/130] (828s left) kms_big_fb (linear-32bpp-rotate-270)
[178.864436] Starting subtest: linear-32bpp-rotate-270
[178.919884] Subtest linear-32bpp-rotate-270: SKIP (0.055s)
[179.060344] [055/130] (825s left) gem_create (create-ext-cpu-access-big)
[179.278773] Starting subtest: create-ext-cpu-access-big
[184.411426] Disk usage limit exceeded.
[241.643730] Warning: kernel log ringbuffer underflow, some records lost.
[272.885063] Warning: kernel log ringbuffer underflow, some records lost.
[273.242238] Warning: kernel log ringbuffer underflow, some records lost.
[304.789181] Timeout. Killing the current test with SIGKILL.
[304.834452] Child refuses to die, tainted 0x200. Aborting.
[304.841374] Closing watchdogs
[304.842457] Closing watchdogs
Done.