[57.758429] Initializing watchdogs
[57.758495]   /dev/watchdog0
[57.778048] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.788677] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.792424] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.794412] [001/131] (960s left) gem_exec_balancer (full)
[57.883943] Starting subtest: full
[59.856137] Subtest full: SUCCESS (1.987s)
[60.260496] [002/131] (958s left) kms_flip (wf_vblank-ts-check-interruptible)
[60.453428] Starting subtest: wf_vblank-ts-check-interruptible
[60.457799] Starting dynamic subtest: A-DP3
[68.723857] Dynamic subtest A-DP3: SUCCESS (8.295s)
[68.738431] Starting dynamic subtest: B-DP3
[76.927217] Dynamic subtest B-DP3: SUCCESS (8.211s)
[76.938190] Starting dynamic subtest: C-DP3
[84.957449] Dynamic subtest C-DP3: SUCCESS (8.027s)
[84.966083] Starting dynamic subtest: D-DP3
[92.992473] Dynamic subtest D-DP3: SUCCESS (8.033s)
[92.994394] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.574s)
[93.306527] [003/131] (925s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[93.498127] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[93.499041] Starting dynamic subtest: pipe-A-DP-3
[93.507514] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[93.515561] Starting dynamic subtest: pipe-B-DP-3
[93.524172] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[93.532210] Starting dynamic subtest: pipe-C-DP-3
[93.540545] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[93.548797] Starting dynamic subtest: pipe-D-DP-3
[93.560149] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[93.562493] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[93.951185] [004/131] (924s left) gem_exec_balancer (invalid-balancer)
[94.029874] Starting subtest: invalid-balancer
[95.545515] Subtest invalid-balancer: SUCCESS (1.515s)
[95.904619] [005/131] (922s left) syncobj_wait (multi-wait-for-submit-signaled)
[95.974371] Starting subtest: multi-wait-for-submit-signaled
[95.975239] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[96.100181] [006/131] (922s left) kms_getfb (getfb-handle-zero)
[96.286238] Starting subtest: getfb-handle-zero
[96.287187] Subtest getfb-handle-zero: SUCCESS (0.000s)
[96.427681] [007/131] (922s left) api_intel_bb (destroy-bb)
[96.496056] Starting subtest: destroy-bb
[96.534061] Subtest destroy-bb: SUCCESS (0.039s)
[96.700406] [008/131] (922s left) kms_psr (fbc-pr-sprite-plane-move)
[96.894251] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[96.947416] [009/131] (921s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[97.029479] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[97.031605] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[97.290276] [010/131] (921s left) kms_chamelium_frames (vga-frame-dump)
[97.554536] Subtest vga-frame-dump: SKIP (0.000s)
[97.697909] [011/131] (921s left) kms_writeback (writeback-fb-id)
[97.895188] Subtest writeback-fb-id: SKIP (0.000s)
[97.951750] [012/131] (921s left) gem_lmem_swapping (parallel-random-verify-ccs)
[100.647667] Starting subtest: parallel-random-verify-ccs
[100.648574] Starting dynamic subtest: lmem0
[165.534581] Dynamic subtest lmem0: SUCCESS (64.885s)
[165.535621] Subtest parallel-random-verify-ccs: SUCCESS (64.886s)
[166.745362] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[166.746830] [013/131] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[168.435431] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[168.437232] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[168.593230] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[168.596397] [014/131] (850s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[168.800912] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[168.802665] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[168.921256] [015/131] (850s left) kms_getfb (getfb2-handle-closed)
[169.108438] Starting subtest: getfb2-handle-closed
[169.109385] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[169.266673] [016/131] (849s left) gem_exec_nop (basic-parallel)
[169.354223] Starting subtest: basic-parallel
[173.744151] Subtest basic-parallel: SUCCESS (4.391s)
[174.038706] [017/131] (845s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[174.235433] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[174.281094] [018/131] (845s left) perf (enable-disable)
[174.641883] Starting subtest: enable-disable
[174.642754] Starting dynamic subtest: 0-rcs0
[176.884868] Dynamic subtest 0-rcs0: SUCCESS (2.242s)
[176.885947] Subtest enable-disable: SUCCESS (2.243s)
[176.936448] [019/131] (842s left) gem_exec_whisper (basic-contexts-priority)
[177.018742] Starting subtest: basic-contexts-priority
[199.497976] Subtest basic-contexts-priority: SUCCESS (22.478s)
[199.707968] [020/131] (819s left) kms_pm_rpm (legacy-planes)
[202.051023] Starting subtest: legacy-planes
[202.052533] Starting dynamic subtest: plane-43
[204.907293] Dynamic subtest plane-43: SUCCESS (2.855s)
[204.945494] Starting dynamic subtest: plane-53
[207.726395] Dynamic subtest plane-53: SUCCESS (2.818s)
[207.765760] Starting dynamic subtest: plane-63
[210.572067] Dynamic subtest plane-63: SUCCESS (2.844s)
[210.610785] Starting dynamic subtest: plane-73
[213.422981] Dynamic subtest plane-73: SUCCESS (2.849s)
[213.425526] Subtest legacy-planes: SUCCESS (11.372s)
[213.785442] [021/131] (805s left) gem_create (busy-create)
[213.857202] Starting subtest: busy-create
[213.858171] Starting dynamic subtest: lmem0
[246.156226] Dynamic subtest lmem0: SUCCESS (32.298s)
[246.166505] Starting dynamic subtest: smem0
[278.411278] Dynamic subtest smem0: SUCCESS (32.253s)
[278.412188] Subtest busy-create: SUCCESS (64.552s)
[278.648062] [022/131] (740s left) gem_pwrite (basic-random)
[278.717090] Subtest basic-random: SKIP (0.000s)
[278.780791] [023/131] (740s left) gem_mmap_gtt (medium-copy)
[278.855131] Subtest medium-copy: SKIP (0.000s)
[278.924792] [024/131] (740s left) kms_flip (2x-flip-vs-dpms-on-nop)
[279.111950] Starting subtest: 2x-flip-vs-dpms-on-nop
[279.126605] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.014s)
[279.225860] [025/131] (740s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[279.423114] Starting subtest: yf-tiled-8bpp-rotate-270
[279.424778] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[279.569767] [026/131] (740s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[279.764772] Starting subtest: y-tiled-16bpp-rotate-180
[279.766499] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[279.897978] [027/131] (739s left) gem_exec_schedule (preemptive-hang)
[280.092134] Starting subtest: preemptive-hang
[280.093109] Starting dynamic subtest: rcs0
[289.137417] Dynamic subtest rcs0: SUCCESS (9.045s)
[289.147523] Starting dynamic subtest: bcs0
[298.158417] Dynamic subtest bcs0: SUCCESS (9.019s)
[298.168773] Starting dynamic subtest: vcs0
[307.124370] Dynamic subtest vcs0: SUCCESS (8.966s)
[307.134259] Starting dynamic subtest: vcs1
[316.152403] Dynamic subtest vcs1: SUCCESS (9.027s)
[316.162515] Starting dynamic subtest: vecs0
[325.183367] Dynamic subtest vecs0: SUCCESS (9.030s)
[325.193236] Starting dynamic subtest: vecs1
[334.138374] Dynamic subtest vecs1: SUCCESS (8.954s)
[334.148196] Starting dynamic subtest: ccs0
[343.148063] Dynamic subtest ccs0: SUCCESS (9.009s)
[343.149014] Subtest preemptive-hang: SUCCESS (63.052s)
[343.394090] [028/131] (676s left) perf_pmu (init-wait)
[343.455649] Starting subtest: init-wait
[343.456539] Starting dynamic subtest: rcs0
[343.458405] Dynamic subtest rcs0: SUCCESS (0.002s)
[343.468034] Starting dynamic subtest: bcs0
[343.468956] Dynamic subtest bcs0: SUCCESS (0.001s)
[343.478499] Starting dynamic subtest: vcs0
[343.479515] Dynamic subtest vcs0: SUCCESS (0.000s)
[343.489470] Starting dynamic subtest: vcs1
[343.490577] Dynamic subtest vcs1: SUCCESS (0.001s)
[343.500092] Starting dynamic subtest: vecs0
[343.501215] Dynamic subtest vecs0: SUCCESS (0.000s)
[343.510639] Starting dynamic subtest: vecs1
[343.511534] Dynamic subtest vecs1: SUCCESS (0.001s)
[343.521176] Starting dynamic subtest: ccs0
[343.522153] Dynamic subtest ccs0: SUCCESS (0.000s)
[343.523383] Subtest init-wait: SUCCESS (0.008s)
[343.598848] [029/131] (676s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[343.790627] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[343.792282] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[343.948674] [030/131] (676s left) gem_exec_schedule (pi-common)
[344.159999] Starting subtest: pi-common
[344.161040] Starting dynamic subtest: rcs0
[344.305668] Dynamic subtest rcs0: SUCCESS (0.153s)
[344.321846] Starting dynamic subtest: bcs0
[344.391643] Dynamic subtest bcs0: SUCCESS (0.085s)
[344.411680] Starting dynamic subtest: vcs0
[344.479142] Dynamic subtest vcs0: SUCCESS (0.087s)
[344.498102] Starting dynamic subtest: vcs1
[344.565423] Dynamic subtest vcs1: SUCCESS (0.086s)
[344.584475] Starting dynamic subtest: vecs0
[344.651152] Dynamic subtest vecs0: SUCCESS (0.085s)
[344.668219] Starting dynamic subtest: vecs1
[344.735150] Dynamic subtest vecs1: SUCCESS (0.083s)
[344.759763] Starting dynamic subtest: ccs0
[344.825671] Dynamic subtest ccs0: SUCCESS (0.090s)
[344.826822] Subtest pi-common: SUCCESS (0.674s)
[345.092591] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[345.094376] [031/131] (674s left) syncobj_timeline (single-wait-available-submitted)
[345.172251] Starting subtest: single-wait-available-submitted
[345.173183] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[345.285497] [032/131] (674s left) perf (i915-ref-count)
[345.384028] Starting subtest: i915-ref-count
[345.516085] Subtest i915-ref-count: SUCCESS (0.131s)
[345.643115] [033/131] (674s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[345.735399] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[345.832887] [034/131] (674s left) i915_pm_rpm (gem-evict-pwrite)
[348.063134] Starting subtest: gem-evict-pwrite
[348.067138] Subtest gem-evict-pwrite: SKIP (0.000s)
[348.446041] [035/131] (671s left) gem_exec_schedule (u-independent)
[348.539693] Starting subtest: u-independent
[348.540589] Starting dynamic subtest: rcs0
[348.988497] Dynamic subtest rcs0: SUCCESS (0.448s)
[349.000185] Starting dynamic subtest: bcs0
[349.390856] Dynamic subtest bcs0: SUCCESS (0.402s)
[349.404446] Starting dynamic subtest: vcs0
[349.779374] Dynamic subtest vcs0: SUCCESS (0.388s)
[349.792540] Starting dynamic subtest: vcs1
[350.170403] Dynamic subtest vcs1: SUCCESS (0.391s)
[350.182529] Starting dynamic subtest: vecs0
[350.554367] Dynamic subtest vecs0: SUCCESS (0.383s)
[350.567909] Starting dynamic subtest: vecs1
[350.947337] Dynamic subtest vecs1: SUCCESS (0.393s)
[350.958512] Starting dynamic subtest: ccs0
[351.302576] Dynamic subtest ccs0: SUCCESS (0.355s)
[351.303732] Subtest u-independent: SUCCESS (2.763s)
[351.668609] [036/131] (668s left) kms_vblank (query-idle)
[351.864214] Starting subtest: query-idle
[351.866237] Starting dynamic subtest: pipe-A-DP-3
[354.190922] Dynamic subtest pipe-A-DP-3: SUCCESS (2.325s)
[354.207885] Starting dynamic subtest: pipe-D-DP-3
[356.436612] Dynamic subtest pipe-D-DP-3: SUCCESS (2.242s)
[356.437566] Subtest query-idle: SUCCESS (4.572s)
[356.665135] [037/131] (663s left) gem_ctx_engines (invalid-engines)
[356.754689] Starting subtest: invalid-engines
[356.789307] Subtest invalid-engines: SUCCESS (0.035s)
[357.074061] [038/131] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[357.275985] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[357.277767] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[357.395796] [039/131] (663s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[357.595325] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[357.596210] Starting dynamic subtest: pipe-A
[357.996435] Dynamic subtest pipe-A: SUCCESS (0.401s)
[358.018538] Starting dynamic subtest: pipe-B
[358.496376] Dynamic subtest pipe-B: SUCCESS (0.499s)
[358.510809] Starting dynamic subtest: pipe-C
[358.964810] Dynamic subtest pipe-C: SUCCESS (0.467s)
[358.984503] Starting dynamic subtest: pipe-D
[359.446075] Dynamic subtest pipe-D: SUCCESS (0.481s)
[359.447193] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.851s)
[359.775684] [040/131] (660s left) gem_flink_basic (bad-flink)
[359.857194] Starting subtest: bad-flink
[359.858009] Subtest bad-flink: SUCCESS (0.000s)
[360.022554] [041/131] (660s left) kms_pm_backlight (fade-with-suspend)
[360.218166] Subtest fade-with-suspend: SKIP (0.000s)
[360.270659] [042/131] (660s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[360.476061] Starting subtest: x-tiled-16bpp-rotate-270
[360.545498] Subtest x-tiled-16bpp-rotate-270: SKIP (0.069s)
[360.728037] [043/131] (660s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[360.924321] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[360.925248] Starting dynamic subtest: pipe-A-DP-3
[361.218667] Dynamic subtest pipe-A-DP-3: SUCCESS (0.276s)
[361.233368] Starting dynamic subtest: pipe-B-DP-3
[361.603216] Dynamic subtest pipe-B-DP-3: SUCCESS (0.377s)
[361.617838] Starting dynamic subtest: pipe-C-DP-3
[361.954188] Dynamic subtest pipe-C-DP-3: SUCCESS (0.345s)
[361.979245] Starting dynamic subtest: pipe-D-DP-3
[362.320135] Dynamic subtest pipe-D-DP-3: SUCCESS (0.360s)
[362.322262] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SUCCESS (1.378s)
[362.691521] [044/131] (658s left) kms_vblank (ts-continuation-modeset)
[362.889299] Starting subtest: ts-continuation-modeset
[362.891475] Starting dynamic subtest: pipe-A-DP-3
[363.366231] Dynamic subtest pipe-A-DP-3: SUCCESS (0.475s)
[363.390360] Starting dynamic subtest: pipe-D-DP-3
[363.832907] Dynamic subtest pipe-D-DP-3: SUCCESS (0.460s)
[363.833922] Subtest ts-continuation-modeset: SUCCESS (0.944s)
[364.068697] [045/131] (656s left) kms_invalid_mode (overflow-vrefresh)
[364.268081] Starting subtest: overflow-vrefresh
[364.269043] Starting dynamic subtest: pipe-A-DP-3
[364.341285] Dynamic subtest pipe-A-DP-3: SUCCESS (0.072s)
[364.354019] Starting dynamic subtest: pipe-B-DP-3
[364.355184] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[364.367497] Starting dynamic subtest: pipe-C-DP-3
[364.368439] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[364.378902] Starting dynamic subtest: pipe-D-DP-3
[364.379838] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[364.380739] Subtest overflow-vrefresh: SUCCESS (0.080s)
[364.573233] [046/131] (656s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[364.771230] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[364.823088] [047/131] (656s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[365.024463] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[365.026827] Starting dynamic subtest: pipe-A-valid-mode
[365.108658] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[365.110451] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.083s)
[365.331261] [048/131] (655s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[365.528280] Starting subtest: addfb25-y-tiled-legacy
[365.529199] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[365.648178] [049/131] (655s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[365.851130] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[365.852906] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[365.987354] [050/131] (655s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[366.065498] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[366.172283] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[366.298095] [051/131] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[366.496024] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[366.497788] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[366.647866] [052/131] (654s left) sysfs_preempt_timeout (invalid)
[366.730169] Starting subtest: invalid
[366.731159] Starting dynamic subtest: vecs0
[366.732136] Dynamic subtest vecs0: SUCCESS (0.000s)
[366.742798] Starting dynamic subtest: ccs0
[366.743662] Dynamic subtest ccs0: SUCCESS (0.000s)
[366.753795] Starting dynamic subtest: vcs0
[366.754657] Dynamic subtest vcs0: SUCCESS (0.000s)
[366.764672] Starting dynamic subtest: bcs0
[366.765554] Dynamic subtest bcs0: SUCCESS (0.000s)
[366.775998] Starting dynamic subtest: vecs1
[366.777229] Dynamic subtest vecs1: SUCCESS (0.000s)
[366.787603] Starting dynamic subtest: rcs0
[366.788812] Dynamic subtest rcs0: SUCCESS (0.000s)
[366.798840] Starting dynamic subtest: vcs1
[366.800919] Dynamic subtest vcs1: SUCCESS (0.000s)
[366.802458] Subtest invalid: SUCCESS (0.008s)
[366.847154] [053/131] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[367.045154] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[367.046890] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[367.166244] [054/131] (654s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[367.361845] Starting subtest: cursorB-vs-flipB-varying-size
[367.363588] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[367.448786] [055/131] (654s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[367.648371] Starting subtest: primary-y-tiled-reflect-x-180
[367.751561] Subtest primary-y-tiled-reflect-x-180: SKIP (0.101s)
[367.933345] [056/131] (653s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[368.127342] Starting subtest: plane-primary-overlay-mutable-zpos
[370.189380] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.060s)
[370.548272] [057/131] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[370.752173] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[370.753983] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.857950] [058/131] (651s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[371.065975] Starting subtest: psr-rgb101010-draw-pwrite
[371.067713] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[371.211189] [059/131] (650s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[371.407760] Starting subtest: basic-flip-before-cursor-varying-size
[372.441516] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.032s)
[372.699436] [060/131] (649s left) gem_ctx_create (basic-files)
[372.789882] Starting subtest: basic-files
[374.799934] Subtest basic-files: SUCCESS (2.010s)
[375.319943] [061/131] (646s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[375.524332] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[375.526186] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[375.660325] [062/131] (646s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[375.744240] Starting subtest: multi-wait-all-for-submit-available-submitted
[375.745163] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[375.908046] [063/131] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[376.109995] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[376.111682] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[376.268994] [064/131] (646s left) gem_exec_nop (basic-sequential)
[376.360796] Starting subtest: basic-sequential
[380.821723] Subtest basic-sequential: SUCCESS (4.458s)
[381.069266] [065/131] (641s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[381.148251] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[381.149216] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[381.321376] [066/131] (641s left) gem_pipe_control_store_loop (reused-buffer)
[381.409930] Starting subtest: reused-buffer
[383.589113] Subtest reused-buffer: SUCCESS (2.179s)
[383.723028] [067/131] (638s left) kms_flip_tiling (flip-change-tiling)
[383.917466] Starting subtest: flip-change-tiling
[383.919693] Starting dynamic subtest: pipe-A-DP-3-4-mc-ccs-to-4-mc-ccs
[384.172975] Dynamic subtest pipe-A-DP-3-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.253s)
[384.214968] Starting dynamic subtest: pipe-A-DP-3-4-mc-ccs-to-4-rc-ccs-cc
[384.389890] Dynamic subtest pipe-A-DP-3-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.213s)
[384.433275] Starting dynamic subtest: pipe-A-DP-3-4-mc-ccs-to-4-rc-ccs
[384.606432] Dynamic subtest pipe-A-DP-3-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.213s)
[384.648070] Starting dynamic subtest: pipe-A-DP-3-4-mc-ccs-to-4
[384.823143] Dynamic subtest pipe-A-DP-3-4-mc-ccs-to-4: SUCCESS (0.213s)
[384.866550] Starting dynamic subtest: pipe-A-DP-3-4-mc-ccs-to-x
[385.039532] Dynamic subtest pipe-A-DP-3-4-mc-ccs-to-x: SUCCESS (0.213s)
[385.080669] Starting dynamic subtest: pipe-A-DP-3-4-mc-ccs-to-linear
[385.256209] Dynamic subtest pipe-A-DP-3-4-mc-ccs-to-linear: SUCCESS (0.213s)
[385.297545] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-cc-to-4-mc-ccs
[385.473200] Dynamic subtest pipe-A-DP-3-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.213s)
[385.516173] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc
[385.656395] Dynamic subtest pipe-A-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.180s)
[385.697894] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-cc-to-4-rc-ccs
[385.873556] Dynamic subtest pipe-A-DP-3-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.213s)
[385.917056] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-cc-to-4
[386.089983] Dynamic subtest pipe-A-DP-3-4-rc-ccs-cc-to-4: SUCCESS (0.213s)
[386.131091] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-cc-to-x
[386.306459] Dynamic subtest pipe-A-DP-3-4-rc-ccs-cc-to-x: SUCCESS (0.213s)
[386.326094] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-cc-to-linear
[386.489878] Dynamic subtest pipe-A-DP-3-4-rc-ccs-cc-to-linear: SUCCESS (0.179s)
[386.532560] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-to-4-mc-ccs
[386.706844] Dynamic subtest pipe-A-DP-3-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.213s)
[386.750325] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-to-4-rc-ccs-cc
[386.923545] Dynamic subtest pipe-A-DP-3-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.213s)
[386.966059] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-to-4-rc-ccs
[387.123580] Dynamic subtest pipe-A-DP-3-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.196s)
[387.165640] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-to-4
[387.340137] Dynamic subtest pipe-A-DP-3-4-rc-ccs-to-4: SUCCESS (0.213s)
[387.359175] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-to-x
[387.539902] Dynamic subtest pipe-A-DP-3-4-rc-ccs-to-x: SUCCESS (0.196s)
[387.583628] Starting dynamic subtest: pipe-A-DP-3-4-rc-ccs-to-linear
[387.756549] Dynamic subtest pipe-A-DP-3-4-rc-ccs-to-linear: SUCCESS (0.213s)
[387.799629] Starting dynamic subtest: pipe-A-DP-3-4-to-4-mc-ccs
[387.973669] Dynamic subtest pipe-A-DP-3-4-to-4-mc-ccs: SUCCESS (0.213s)
[387.993172] Starting dynamic subtest: pipe-A-DP-3-4-to-4-rc-ccs-cc
[388.173573] Dynamic subtest pipe-A-DP-3-4-to-4-rc-ccs-cc: SUCCESS (0.196s)
[388.215346] Starting dynamic subtest: pipe-A-DP-3-4-to-4-rc-ccs
[388.390242] Dynamic subtest pipe-A-DP-3-4-to-4-rc-ccs: SUCCESS (0.213s)
[388.434284] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[388.573090] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.179s)
[388.615498] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[388.790061] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.213s)
[388.833142] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[389.006640] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.213s)
[389.048615] Starting dynamic subtest: pipe-A-DP-3-x-to-4-mc-ccs
[389.223221] Dynamic subtest pipe-A-DP-3-x-to-4-mc-ccs: SUCCESS (0.213s)
[389.264521] Starting dynamic subtest: pipe-A-DP-3-x-to-4-rc-ccs-cc
[389.439784] Dynamic subtest pipe-A-DP-3-x-to-4-rc-ccs-cc: SUCCESS (0.213s)
[389.483314] Starting dynamic subtest: pipe-A-DP-3-x-to-4-rc-ccs
[389.656612] Dynamic subtest pipe-A-DP-3-x-to-4-rc-ccs: SUCCESS (0.213s)
[389.675066] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[389.840113] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.180s)
[389.881679] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[390.023056] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.179s)
[390.066034] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[390.240369] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.213s)
[390.259401] Starting dynamic subtest: pipe-A-DP-3-linear-to-4-mc-ccs
[390.439943] Dynamic subtest pipe-A-DP-3-linear-to-4-mc-ccs: SUCCESS (0.196s)
[390.483601] Starting dynamic subtest: pipe-A-DP-3-linear-to-4-rc-ccs-cc
[390.656717] Dynamic subtest pipe-A-DP-3-linear-to-4-rc-ccs-cc: SUCCESS (0.213s)
[390.675390] Starting dynamic subtest: pipe-A-DP-3-linear-to-4-rc-ccs
[390.855750] Dynamic subtest pipe-A-DP-3-linear-to-4-rc-ccs: SUCCESS (0.196s)
[390.872597] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[391.056831] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.198s)
[391.100616] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[391.273764] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.213s)
[391.317021] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[391.456032] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.179s)
[391.518300] Starting dynamic subtest: pipe-B-DP-3-4-mc-ccs-to-4-mc-ccs
[391.841769] Dynamic subtest pipe-B-DP-3-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.333s)
[391.884860] Starting dynamic subtest: pipe-B-DP-3-4-mc-ccs-to-4-rc-ccs-cc
[392.007887] Dynamic subtest pipe-B-DP-3-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.163s)
[392.038384] Starting dynamic subtest: pipe-B-DP-3-4-mc-ccs-to-4-rc-ccs
[392.157398] Dynamic subtest pipe-B-DP-3-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[392.178713] Starting dynamic subtest: pipe-B-DP-3-4-mc-ccs-to-4
[392.307592] Dynamic subtest pipe-B-DP-3-4-mc-ccs-to-4: SUCCESS (0.149s)
[392.335976] Starting dynamic subtest: pipe-B-DP-3-4-mc-ccs-to-x
[392.457512] Dynamic subtest pipe-B-DP-3-4-mc-ccs-to-x: SUCCESS (0.148s)
[392.478425] Starting dynamic subtest: pipe-B-DP-3-4-mc-ccs-to-linear
[392.607757] Dynamic subtest pipe-B-DP-3-4-mc-ccs-to-linear: SUCCESS (0.149s)
[392.641445] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-cc-to-4-mc-ccs
[392.774411] Dynamic subtest pipe-B-DP-3-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.165s)
[392.812876] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc
[392.941495] Dynamic subtest pipe-B-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.164s)
[392.981451] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-cc-to-4-rc-ccs
[393.107660] Dynamic subtest pipe-B-DP-3-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.164s)
[393.140442] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-cc-to-4
[393.274861] Dynamic subtest pipe-B-DP-3-4-rc-ccs-cc-to-4: SUCCESS (0.165s)
[393.317147] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-cc-to-x
[393.440858] Dynamic subtest pipe-B-DP-3-4-rc-ccs-cc-to-x: SUCCESS (0.164s)
[393.468667] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-cc-to-linear
[393.591748] Dynamic subtest pipe-B-DP-3-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[393.633178] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-to-4-mc-ccs
[393.757743] Dynamic subtest pipe-B-DP-3-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.163s)
[393.785733] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-to-4-rc-ccs-cc
[393.907681] Dynamic subtest pipe-B-DP-3-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[393.935458] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-to-4-rc-ccs
[394.057638] Dynamic subtest pipe-B-DP-3-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[394.085082] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-to-4
[394.207540] Dynamic subtest pipe-B-DP-3-4-rc-ccs-to-4: SUCCESS (0.148s)
[394.234562] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-to-x
[394.357587] Dynamic subtest pipe-B-DP-3-4-rc-ccs-to-x: SUCCESS (0.149s)
[394.372555] Starting dynamic subtest: pipe-B-DP-3-4-rc-ccs-to-linear
[394.491875] Dynamic subtest pipe-B-DP-3-4-rc-ccs-to-linear: SUCCESS (0.132s)
[394.510253] Starting dynamic subtest: pipe-B-DP-3-4-to-4-mc-ccs
[394.624424] Dynamic subtest pipe-B-DP-3-4-to-4-mc-ccs: SUCCESS (0.130s)
[394.651975] Starting dynamic subtest: pipe-B-DP-3-4-to-4-rc-ccs-cc
[394.774336] Dynamic subtest pipe-B-DP-3-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[394.806650] Starting dynamic subtest: pipe-B-DP-3-4-to-4-rc-ccs
[394.941618] Dynamic subtest pipe-B-DP-3-4-to-4-rc-ccs: SUCCESS (0.165s)
[394.984993] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[395.107860] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.163s)
[395.124497] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[395.241171] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.131s)
[395.274130] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[395.408029] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.165s)
[395.446269] Starting dynamic subtest: pipe-B-DP-3-x-to-4-mc-ccs
[395.574168] Dynamic subtest pipe-B-DP-3-x-to-4-mc-ccs: SUCCESS (0.164s)
[395.592787] Starting dynamic subtest: pipe-B-DP-3-x-to-4-rc-ccs-cc
[395.707444] Dynamic subtest pipe-B-DP-3-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[395.728127] Starting dynamic subtest: pipe-B-DP-3-x-to-4-rc-ccs
[395.857767] Dynamic subtest pipe-B-DP-3-x-to-4-rc-ccs: SUCCESS (0.149s)
[395.891448] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[396.007605] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.148s)
[396.020448] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[396.141267] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.132s)
[396.157657] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[396.274530] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.132s)
[396.302564] Starting dynamic subtest: pipe-B-DP-3-linear-to-4-mc-ccs
[396.424461] Dynamic subtest pipe-B-DP-3-linear-to-4-mc-ccs: SUCCESS (0.148s)
[396.452289] Starting dynamic subtest: pipe-B-DP-3-linear-to-4-rc-ccs-cc
[396.574397] Dynamic subtest pipe-B-DP-3-linear-to-4-rc-ccs-cc: SUCCESS (0.148s)
[396.589907] Starting dynamic subtest: pipe-B-DP-3-linear-to-4-rc-ccs
[396.707748] Dynamic subtest pipe-B-DP-3-linear-to-4-rc-ccs: SUCCESS (0.132s)
[396.735334] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[396.858073] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.148s)
[396.871615] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[396.991302] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.132s)
[397.023978] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[397.157982] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.165s)
[397.202051] Starting dynamic subtest: pipe-C-DP-3-4-mc-ccs-to-4-mc-ccs
[397.525909] Dynamic subtest pipe-C-DP-3-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.332s)
[397.568644] Starting dynamic subtest: pipe-C-DP-3-4-mc-ccs-to-4-rc-ccs-cc
[397.692515] Dynamic subtest pipe-C-DP-3-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.163s)
[397.723349] Starting dynamic subtest: pipe-C-DP-3-4-mc-ccs-to-4-rc-ccs
[397.841331] Dynamic subtest pipe-C-DP-3-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[397.856527] Starting dynamic subtest: pipe-C-DP-3-4-mc-ccs-to-4
[397.974744] Dynamic subtest pipe-C-DP-3-4-mc-ccs-to-4: SUCCESS (0.132s)
[398.003103] Starting dynamic subtest: pipe-C-DP-3-4-mc-ccs-to-x
[398.124666] Dynamic subtest pipe-C-DP-3-4-mc-ccs-to-x: SUCCESS (0.148s)
[398.152363] Starting dynamic subtest: pipe-C-DP-3-4-mc-ccs-to-linear
[398.274673] Dynamic subtest pipe-C-DP-3-4-mc-ccs-to-linear: SUCCESS (0.148s)
[398.298516] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-cc-to-4-mc-ccs
[398.424933] Dynamic subtest pipe-C-DP-3-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s)
[398.457631] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc
[398.574709] Dynamic subtest pipe-C-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[398.602294] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-cc-to-4-rc-ccs
[398.724789] Dynamic subtest pipe-C-DP-3-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[398.757456] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-cc-to-4
[398.874727] Dynamic subtest pipe-C-DP-3-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[398.898647] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-cc-to-x
[399.024766] Dynamic subtest pipe-C-DP-3-4-rc-ccs-cc-to-x: SUCCESS (0.148s)
[399.052451] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-cc-to-linear
[399.174718] Dynamic subtest pipe-C-DP-3-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[399.191656] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-to-4-mc-ccs
[399.332068] Dynamic subtest pipe-C-DP-3-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.149s)
[399.366618] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-to-4-rc-ccs-cc
[399.491667] Dynamic subtest pipe-C-DP-3-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.165s)
[399.524337] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-to-4-rc-ccs
[399.658247] Dynamic subtest pipe-C-DP-3-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.165s)
[399.674436] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-to-4
[399.791704] Dynamic subtest pipe-C-DP-3-4-rc-ccs-to-4: SUCCESS (0.132s)
[399.807670] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-to-x
[399.941713] Dynamic subtest pipe-C-DP-3-4-rc-ccs-to-x: SUCCESS (0.148s)
[399.980259] Starting dynamic subtest: pipe-C-DP-3-4-rc-ccs-to-linear
[400.108256] Dynamic subtest pipe-C-DP-3-4-rc-ccs-to-linear: SUCCESS (0.165s)
[400.135208] Starting dynamic subtest: pipe-C-DP-3-4-to-4-mc-ccs
[400.258407] Dynamic subtest pipe-C-DP-3-4-to-4-mc-ccs: SUCCESS (0.148s)
[400.290988] Starting dynamic subtest: pipe-C-DP-3-4-to-4-rc-ccs-cc
[400.408167] Dynamic subtest pipe-C-DP-3-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[400.431261] Starting dynamic subtest: pipe-C-DP-3-4-to-4-rc-ccs
[400.558421] Dynamic subtest pipe-C-DP-3-4-to-4-rc-ccs: SUCCESS (0.149s)
[400.585913] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[400.708293] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.148s)
[400.731744] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[400.858316] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.149s)
[400.873871] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[400.991411] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.132s)
[401.010598] Starting dynamic subtest: pipe-C-DP-3-x-to-4-mc-ccs
[401.124915] Dynamic subtest pipe-C-DP-3-x-to-4-mc-ccs: SUCCESS (0.132s)
[401.145432] Starting dynamic subtest: pipe-C-DP-3-x-to-4-rc-ccs-cc
[401.275236] Dynamic subtest pipe-C-DP-3-x-to-4-rc-ccs-cc: SUCCESS (0.149s)
[401.313872] Starting dynamic subtest: pipe-C-DP-3-x-to-4-rc-ccs
[401.441741] Dynamic subtest pipe-C-DP-3-x-to-4-rc-ccs: SUCCESS (0.164s)
[401.474446] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[401.608459] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.165s)
[401.643036] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[401.775253] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.165s)
[401.807985] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[401.941789] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.165s)
[401.974960] Starting dynamic subtest: pipe-C-DP-3-linear-to-4-mc-ccs
[402.091422] Dynamic subtest pipe-C-DP-3-linear-to-4-mc-ccs: SUCCESS (0.148s)
[402.106174] Starting dynamic subtest: pipe-C-DP-3-linear-to-4-rc-ccs-cc
[402.225071] Dynamic subtest pipe-C-DP-3-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[402.257671] Starting dynamic subtest: pipe-C-DP-3-linear-to-4-rc-ccs
[402.392479] Dynamic subtest pipe-C-DP-3-linear-to-4-rc-ccs: SUCCESS (0.165s)
[402.434111] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[402.559341] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.163s)
[402.599485] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[402.725254] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.163s)
[402.757882] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[402.875111] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.148s)
[402.919836] Starting dynamic subtest: pipe-D-DP-3-4-mc-ccs-to-4-mc-ccs
[403.242962] Dynamic subtest pipe-D-DP-3-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.332s)
[403.284718] Starting dynamic subtest: pipe-D-DP-3-4-mc-ccs-to-4-rc-ccs-cc
[403.408904] Dynamic subtest pipe-D-DP-3-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.162s)
[403.442032] Starting dynamic subtest: pipe-D-DP-3-4-mc-ccs-to-4-rc-ccs
[403.575405] Dynamic subtest pipe-D-DP-3-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.165s)
[403.614439] Starting dynamic subtest: pipe-D-DP-3-4-mc-ccs-to-4
[403.741936] Dynamic subtest pipe-D-DP-3-4-mc-ccs-to-4: SUCCESS (0.164s)
[403.775445] Starting dynamic subtest: pipe-D-DP-3-4-mc-ccs-to-x
[403.908571] Dynamic subtest pipe-D-DP-3-4-mc-ccs-to-x: SUCCESS (0.165s)
[403.941820] Starting dynamic subtest: pipe-D-DP-3-4-mc-ccs-to-linear
[404.075434] Dynamic subtest pipe-D-DP-3-4-mc-ccs-to-linear: SUCCESS (0.165s)
[404.109444] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-cc-to-4-mc-ccs
[404.241960] Dynamic subtest pipe-D-DP-3-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.164s)
[404.276441] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc
[404.391753] Dynamic subtest pipe-D-DP-3-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[404.419644] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-cc-to-4-rc-ccs
[404.541847] Dynamic subtest pipe-D-DP-3-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[404.575189] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-cc-to-4
[404.691724] Dynamic subtest pipe-D-DP-3-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[404.719090] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-cc-to-x
[404.841818] Dynamic subtest pipe-D-DP-3-4-rc-ccs-cc-to-x: SUCCESS (0.149s)
[404.865428] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-cc-to-linear
[404.992037] Dynamic subtest pipe-D-DP-3-4-rc-ccs-cc-to-linear: SUCCESS (0.149s)
[405.025090] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-to-4-mc-ccs
[405.158598] Dynamic subtest pipe-D-DP-3-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.165s)
[405.191551] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-to-4-rc-ccs-cc
[405.334300] Dynamic subtest pipe-D-DP-3-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.165s)
[405.369062] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-to-4-rc-ccs
[405.491879] Dynamic subtest pipe-D-DP-3-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.165s)
[405.515973] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-to-4
[405.641967] Dynamic subtest pipe-D-DP-3-4-rc-ccs-to-4: SUCCESS (0.148s)
[405.669729] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-to-x
[405.808875] Dynamic subtest pipe-D-DP-3-4-rc-ccs-to-x: SUCCESS (0.165s)
[405.825517] Starting dynamic subtest: pipe-D-DP-3-4-rc-ccs-to-linear
[405.941901] Dynamic subtest pipe-D-DP-3-4-rc-ccs-to-linear: SUCCESS (0.131s)
[405.965294] Starting dynamic subtest: pipe-D-DP-3-4-to-4-mc-ccs
[406.091961] Dynamic subtest pipe-D-DP-3-4-to-4-mc-ccs: SUCCESS (0.148s)
[406.118941] Starting dynamic subtest: pipe-D-DP-3-4-to-4-rc-ccs-cc
[406.241987] Dynamic subtest pipe-D-DP-3-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[406.265759] Starting dynamic subtest: pipe-D-DP-3-4-to-4-rc-ccs
[406.392058] Dynamic subtest pipe-D-DP-3-4-to-4-rc-ccs: SUCCESS (0.148s)
[406.415633] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[406.542130] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.148s)
[406.569552] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[406.708790] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.165s)
[406.747508] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[406.875432] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.165s)
[406.907937] Starting dynamic subtest: pipe-D-DP-3-x-to-4-mc-ccs
[407.042356] Dynamic subtest pipe-D-DP-3-x-to-4-mc-ccs: SUCCESS (0.165s)
[407.074684] Starting dynamic subtest: pipe-D-DP-3-x-to-4-rc-ccs-cc
[407.208920] Dynamic subtest pipe-D-DP-3-x-to-4-rc-ccs-cc: SUCCESS (0.164s)
[407.242057] Starting dynamic subtest: pipe-D-DP-3-x-to-4-rc-ccs
[407.375555] Dynamic subtest pipe-D-DP-3-x-to-4-rc-ccs: SUCCESS (0.164s)
[407.408427] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[407.542137] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.164s)
[407.558723] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[407.692434] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.148s)
[407.736063] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[407.858732] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.164s)
[407.882970] Starting dynamic subtest: pipe-D-DP-3-linear-to-4-mc-ccs
[408.008753] Dynamic subtest pipe-D-DP-3-linear-to-4-mc-ccs: SUCCESS (0.148s)
[408.024752] Starting dynamic subtest: pipe-D-DP-3-linear-to-4-rc-ccs-cc
[408.142194] Dynamic subtest pipe-D-DP-3-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[408.157761] Starting dynamic subtest: pipe-D-DP-3-linear-to-4-rc-ccs
[408.275572] Dynamic subtest pipe-D-DP-3-linear-to-4-rc-ccs: SUCCESS (0.132s)
[408.303274] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[408.425417] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.148s)
[408.448942] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[408.575802] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.148s)
[408.600409] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[408.725439] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.148s)
[408.758402] Subtest flip-change-tiling: SUCCESS (24.840s)
[409.118858] [068/131] (613s left) perf (mi-rpc)
[409.302383] Starting subtest: mi-rpc
[409.304565] Subtest mi-rpc: SKIP (0.000s)
[409.366897] [069/131] (613s left) gem_eio (in-flight-contexts-10ms)
[409.737356] Starting subtest: in-flight-contexts-10ms
[422.952059] Subtest in-flight-contexts-10ms: SUCCESS (13.214s)
[423.184130] [070/131] (599s left) kms_atomic_interruptible (legacy-cursor)
[423.383434] Starting subtest: legacy-cursor
[423.384381] Starting dynamic subtest: pipe-A-DP-3
[429.702352] Dynamic subtest pipe-A-DP-3: SUCCESS (6.317s)
[429.703442] Subtest legacy-cursor: SUCCESS (6.319s)
[429.956926] [071/131] (592s left) gem_mmap_gtt (isolation)
[430.035276] Subtest isolation: SKIP (0.000s)
[430.116380] [072/131] (592s left) api_intel_bb (render-ccs)
[430.194479] Starting subtest: render-ccs
[430.288059] Subtest render-ccs: SUCCESS (0.095s)
[430.442334] [073/131] (592s left) gem_madvise (dontneed-before-exec)
[430.490500] Starting subtest: dontneed-before-exec
[430.521248] Subtest dontneed-before-exec: SKIP (0.031s)
[430.604869] [074/131] (592s left) kms_psr (fbc-psr-sprite-blt)
[430.802133] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[430.864663] [075/131] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[431.064054] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[433.804407] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.740s)
[434.036743] [076/131] (589s left) kms_plane_alpha_blend (alpha-7efc)
[434.233497] Starting subtest: alpha-7efc
[434.493130] Starting dynamic subtest: pipe-A-DP-3
[435.029490] Dynamic subtest pipe-A-DP-3: SUCCESS (0.535s)
[435.068056] Starting dynamic subtest: pipe-D-DP-3
[435.746063] Dynamic subtest pipe-D-DP-3: SUCCESS (0.687s)
[435.746985] Subtest alpha-7efc: SUCCESS (1.512s)
[436.003374] [077/131] (587s left) kms_flip (busy-flip)
[436.205059] Starting subtest: busy-flip
[436.209577] Starting dynamic subtest: A-DP3
[437.066257] Dynamic subtest A-DP3: SUCCESS (0.856s)
[437.081518] Starting dynamic subtest: B-DP3
[437.845036] Dynamic subtest B-DP3: SUCCESS (0.777s)
[437.858565] Starting dynamic subtest: C-DP3
[438.622031] Dynamic subtest C-DP3: SUCCESS (0.776s)
[438.636680] Starting dynamic subtest: D-DP3
[439.393215] Dynamic subtest D-DP3: SUCCESS (0.770s)
[439.395525] Subtest busy-flip: SUCCESS (3.190s)
[439.709285] [078/131] (583s left) vgem_basic (dmabuf-export)
[439.776016] Starting subtest: dmabuf-export
[439.817823] Subtest dmabuf-export: SUCCESS (0.042s)
[439.950913] [079/131] (583s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[440.150115] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[440.154945] Starting dynamic subtest: A-DP3
[441.124452] Dynamic subtest A-DP3: SUCCESS (0.969s)
[441.139836] Starting dynamic subtest: B-DP3
[441.880278] Dynamic subtest B-DP3: SUCCESS (0.754s)
[441.907570] Starting dynamic subtest: C-DP3
[442.641793] Dynamic subtest C-DP3: SUCCESS (0.759s)
[442.652930] Starting dynamic subtest: D-DP3
[443.384940] Dynamic subtest D-DP3: SUCCESS (0.740s)
[443.388746] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.237s)
[443.681526] [080/131] (579s left) gem_spin_batch (resubmit)
[443.776413] Starting subtest: resubmit
[443.777368] Starting dynamic subtest: rcs0
[443.809175] Dynamic subtest rcs0: SUCCESS (0.032s)
[443.820962] Starting dynamic subtest: bcs0
[443.821991] Dynamic subtest bcs0: SUCCESS (0.003s)
[443.833618] Starting dynamic subtest: vcs0
[443.834787] Dynamic subtest vcs0: SUCCESS (0.004s)
[443.845903] Starting dynamic subtest: vcs1
[443.847128] Dynamic subtest vcs1: SUCCESS (0.002s)
[443.857809] Starting dynamic subtest: vecs0
[443.858705] Dynamic subtest vecs0: SUCCESS (0.002s)
[443.869480] Starting dynamic subtest: vecs1
[443.870604] Dynamic subtest vecs1: SUCCESS (0.002s)
[443.881330] Starting dynamic subtest: ccs0
[443.882615] Dynamic subtest ccs0: SUCCESS (0.002s)
[443.883732] Subtest resubmit: SUCCESS (0.053s)
[444.128265] [081/131] (579s left) prime_busy (hang-wait)
[444.211153] Starting subtest: hang-wait
[444.213444] Starting dynamic subtest: rcs0
[470.512817] Dynamic subtest rcs0: SUCCESS (26.297s)
[470.524180] Starting dynamic subtest: bcs0
[477.624717] Dynamic subtest bcs0: SUCCESS (7.112s)
[477.636223] Starting dynamic subtest: vcs0
[484.655758] Dynamic subtest vcs0: SUCCESS (7.030s)
[484.667228] Starting dynamic subtest: vcs1
[491.636814] Dynamic subtest vcs1: SUCCESS (6.979s)
[491.648253] Starting dynamic subtest: vecs0
[498.606974] Dynamic subtest vecs0: SUCCESS (6.968s)
[498.618400] Starting dynamic subtest: vecs1
[505.648161] Dynamic subtest vecs1: SUCCESS (7.041s)
[505.659672] Starting dynamic subtest: ccs0
[519.484283] Dynamic subtest ccs0: SUCCESS (13.835s)
[519.485179] Subtest hang-wait: SUCCESS (75.272s)
[519.620808] [082/131] (503s left) kms_content_protection (lic-type-0)
[519.880375] Starting subtest: lic-type-0
[519.917493] Starting dynamic subtest: pipe-A-DP-3
[643.002900] Dynamic subtest pipe-A-DP-3: FAIL (122.924s)
[643.004225] Subtest lic-type-0: FAIL (123.062s)
[643.217734] [083/131] (380s left) kms_addfb_basic (too-wide)
[643.418620] Starting subtest: too-wide
[643.419465] Subtest too-wide: SUCCESS (0.000s)
[643.545368] [084/131] (380s left) kms_cursor_crc (cursor-random-512x512)
[644.015891] Starting subtest: cursor-random-512x512
[644.017619] Subtest cursor-random-512x512: SKIP (0.001s)
[644.278890] [085/131] (379s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[644.478911] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[644.480711] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[644.622943] [086/131] (379s left) kms_addfb_basic (bad-pitch-256)
[644.703924] Starting subtest: bad-pitch-256
[644.704861] Subtest bad-pitch-256: SUCCESS (0.000s)
[644.945898] [087/131] (379s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[645.143510] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[645.146167] Starting dynamic subtest: pipe-A-DP-3
[647.111152] Dynamic subtest pipe-A-DP-3: SUCCESS (1.963s)
[647.123051] Starting dynamic subtest: pipe-B-DP-3
[647.131176] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[647.142673] Starting dynamic subtest: pipe-C-DP-3
[647.150393] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[647.161651] Starting dynamic subtest: pipe-D-DP-3
[647.170136] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s)
[647.171356] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SUCCESS (1.978s)
[647.628079] [088/131] (376s left) kms_psr (psr2-cursor-mmap-cpu)
[647.823164] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[647.889894] [089/131] (376s left) gem_exec_fence (parallel)
[648.128628] Starting subtest: parallel
[648.134032] Starting dynamic subtest: rcs0
[650.283795] Dynamic subtest rcs0: SUCCESS (2.154s)
[650.295107] Starting dynamic subtest: bcs0
[652.439665] Dynamic subtest bcs0: SUCCESS (2.155s)
[652.451394] Starting dynamic subtest: vcs0
[654.589360] Dynamic subtest vcs0: SUCCESS (2.149s)
[654.600822] Starting dynamic subtest: vcs1
[656.742574] Dynamic subtest vcs1: SUCCESS (2.152s)
[656.753967] Starting dynamic subtest: vecs0
[658.895659] Dynamic subtest vecs0: SUCCESS (2.153s)
[658.907462] Starting dynamic subtest: vecs1
[661.051925] Dynamic subtest vecs1: SUCCESS (2.155s)
[661.063338] Starting dynamic subtest: ccs0
[663.209170] Dynamic subtest ccs0: SUCCESS (2.156s)
[663.210115] Subtest parallel: SUCCESS (15.082s)
[663.963662] [090/131] (360s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[664.160902] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[676.354260] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (12.193s)
[676.633237] [091/131] (347s left) kms_joiner (invalid-modeset-force-big-joiner)
[676.836340] Starting subtest: invalid-modeset-force-big-joiner
[676.837119] Starting dynamic subtest: big_joiner_on_last_pipe
[677.054218] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.219s)
[677.055243] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.220s)
[677.317041] [092/131] (347s left) i915_drm_fdinfo (busy-idle)
[677.387483] Starting subtest: busy-idle
[677.388308] Starting dynamic subtest: rcs0
[677.417211] Dynamic subtest rcs0: SKIP (0.028s)
[677.429988] Starting dynamic subtest: bcs0
[677.432207] Dynamic subtest bcs0: SKIP (0.000s)
[677.444844] Starting dynamic subtest: vcs0
[677.447092] Dynamic subtest vcs0: SKIP (0.000s)
[677.459753] Starting dynamic subtest: vcs1
[677.462132] Dynamic subtest vcs1: SKIP (0.000s)
[677.477210] Starting dynamic subtest: vecs0
[677.479589] Dynamic subtest vecs0: SKIP (0.000s)
[677.490930] Starting dynamic subtest: vecs1
[677.493129] Dynamic subtest vecs1: SKIP (0.000s)
[677.504174] Starting dynamic subtest: ccs0
[677.506631] Dynamic subtest ccs0: SKIP (0.000s)
[677.508933] Subtest busy-idle: SKIP (0.038s)
[677.555467] [093/131] (346s left) kms_cursor_edge_walk (128x128-top-edge)
[677.750556] Starting subtest: 128x128-top-edge
[677.752949] Starting dynamic subtest: pipe-A-DP-3
[681.200487] Dynamic subtest pipe-A-DP-3: SUCCESS (3.447s)
[681.218195] Starting dynamic subtest: pipe-D-DP-3
[684.518657] Dynamic subtest pipe-D-DP-3: SUCCESS (3.316s)
[684.519794] Subtest 128x128-top-edge: SUCCESS (6.768s)
[684.809758] [094/131] (339s left) kms_frontbuffer_tracking (fbc-suspend)
[685.013210] Starting subtest: fbc-suspend
[726.383993] Subtest fbc-suspend: SUCCESS (11.082s)
[726.594771] [095/131] (297s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[726.792130] Starting subtest: fb-8bpc-vs-panel-8bpc
[726.794608] Starting dynamic subtest: pipe-A-DP-3
[727.183677] Dynamic subtest pipe-A-DP-3: SUCCESS (0.389s)
[727.188329] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.393s)
[727.419878] [096/131] (297s left) gem_exec_fence (syncobj-invalid-flags)
[727.962863] Starting subtest: syncobj-invalid-flags
[727.963793] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[728.353045] [097/131] (296s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[728.552599] Starting subtest: psr-1p-primscrn-cur-indfb-move
[728.554563] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[728.707562] [098/131] (296s left) kms_chamelium_edid (hdmi-edid-read)
[728.987354] Subtest hdmi-edid-read: SKIP (0.000s)
[729.144561] [099/131] (295s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[729.227022] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[729.229286] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[729.481221] [100/131] (295s left) i915_drm_fdinfo (memory-info-active)
[729.551091] Starting subtest: memory-info-active
[729.552064] Starting dynamic subtest: lmem0
[733.178529] Dynamic subtest lmem0: SUCCESS (3.626s)
[733.200797] Starting dynamic subtest: smem0
[737.723803] Dynamic subtest smem0: SUCCESS (4.541s)
[737.724799] Subtest memory-info-active: SUCCESS (8.173s)
[737.818758] [101/131] (287s left) gem_eio (wait-10ms)
[738.106326] Starting subtest: wait-10ms
[738.683985] Subtest wait-10ms: SUCCESS (0.578s)
[738.912471] [102/131] (286s left) gem_exec_params (sol-reset-invalid)
[738.994953] Starting subtest: sol-reset-invalid
[738.998206] Subtest sol-reset-invalid: SUCCESS (0.003s)
[739.194096] [103/131] (285s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[739.400896] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[739.402695] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[739.541769] [104/131] (285s left) kms_color (ctm-green-to-red)
[739.734136] Starting subtest: ctm-green-to-red
[739.735059] Starting dynamic subtest: pipe-A-DP-3
[740.413905] Dynamic subtest pipe-A-DP-3: SUCCESS (0.679s)
[740.442943] Starting dynamic subtest: pipe-B-DP-3
[740.998119] Dynamic subtest pipe-B-DP-3: SUCCESS (0.582s)
[741.014009] Starting dynamic subtest: pipe-C-DP-3
[741.606974] Dynamic subtest pipe-C-DP-3: SUCCESS (0.607s)
[741.627491] Starting dynamic subtest: pipe-D-DP-3
[742.243088] Dynamic subtest pipe-D-DP-3: SUCCESS (0.635s)
[742.244035] Subtest ctm-green-to-red: SUCCESS (2.508s)
[742.486247] [105/131] (282s left) gem_ctx_persistence (legacy-engines-mixed)
[742.574362] Starting subtest: legacy-engines-mixed
[742.575270] Starting dynamic subtest: render
[742.682945] Dynamic subtest render: SUCCESS (0.107s)
[742.700411] Starting dynamic subtest: bsd1
[742.726929] Dynamic subtest bsd1: SUCCESS (0.042s)
[742.744920] Starting dynamic subtest: bsd2
[742.774010] Dynamic subtest bsd2: SUCCESS (0.045s)
[742.791614] Starting dynamic subtest: blt
[742.846196] Dynamic subtest blt: SUCCESS (0.070s)
[742.863023] Starting dynamic subtest: vebox
[742.902974] Dynamic subtest vebox: SUCCESS (0.054s)
[742.904020] Subtest legacy-engines-mixed: SUCCESS (0.329s)
[743.106397] [106/131] (282s left) gen9_exec_parse (batch-invalid-length)
[743.189835] Subtest batch-invalid-length: SKIP (0.000s)
[743.296447] [107/131] (282s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[743.493591] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[743.495458] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[743.653495] [108/131] (281s left) kms_addfb_basic (size-max)
[743.851195] Starting subtest: size-max
[743.852109] Subtest size-max: SUCCESS (0.000s)
[743.998257] [109/131] (281s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[744.196868] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[744.198603] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[744.354207] [110/131] (281s left) kms_sequence (get-busy)
[744.554130] Starting subtest: get-busy
[744.556573] Starting dynamic subtest: pipe-A-DP-3
[747.126933] Dynamic subtest pipe-A-DP-3: SUCCESS (2.570s)
[747.143439] Starting dynamic subtest: pipe-B-DP-3
[749.599875] Dynamic subtest pipe-B-DP-3: SUCCESS (2.471s)
[749.613510] Starting dynamic subtest: pipe-C-DP-3
[752.074134] Dynamic subtest pipe-C-DP-3: SUCCESS (2.473s)
[752.088771] Starting dynamic subtest: pipe-D-DP-3
[754.575078] Dynamic subtest pipe-D-DP-3: SUCCESS (2.500s)
[754.576049] Subtest get-busy: SUCCESS (10.021s)
[754.849003] [111/131] (270s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[755.278082] Starting subtest: cursor-rapid-movement-256x256
[755.283080] Starting dynamic subtest: pipe-A-DP-3
[755.724379] Dynamic subtest pipe-A-DP-3: SUCCESS (0.440s)
[755.778409] Starting dynamic subtest: pipe-D-DP-3
[756.172102] Dynamic subtest pipe-D-DP-3: SUCCESS (0.406s)
[756.173034] Subtest cursor-rapid-movement-256x256: SUCCESS (0.893s)
[756.532651] [112/131] (269s left) prime_self_import (basic-llseek-size)
[756.580517] Starting subtest: basic-llseek-size
[756.609392] Subtest basic-llseek-size: SUCCESS (0.030s)
[756.794321] [113/131] (269s left) gem_create (create-invalid-size)
[756.871065] Starting subtest: create-invalid-size
[756.872036] Subtest create-invalid-size: SUCCESS (0.000s)
[757.111284] [114/131] (268s left) gem_ctx_persistence (heartbeat-hostile)
[757.196704] Starting subtest: heartbeat-hostile
[757.198788] Subtest heartbeat-hostile: SKIP (0.000s)
[757.335924] [115/131] (268s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[757.415807] Starting subtest: multi-wait-available-unsubmitted-signaled
[757.416790] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[757.609650] [116/131] (268s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[757.809186] Starting subtest: bad-pixel-format-y-tiled-ccs
[757.811567] Starting dynamic subtest: pipe-A-DP-3
[757.820156] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[757.833391] Starting dynamic subtest: pipe-B-DP-3
[757.841877] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[757.854902] Starting dynamic subtest: pipe-C-DP-3
[757.863991] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[757.877261] Starting dynamic subtest: pipe-D-DP-3
[757.888545] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[757.890403] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[758.262052] [117/131] (268s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[758.470660] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[759.760058] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.288s)
[759.972646] [118/131] (266s left) kms_big_fb (4-tiled-addfb-size-overflow)
[760.181671] Starting subtest: 4-tiled-addfb-size-overflow
[760.184040] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.001s)
[760.352021] [119/131] (266s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[760.554161] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[760.555116] Starting dynamic subtest: pipe-A-DP-3
[760.564558] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[760.578162] Starting dynamic subtest: pipe-B-DP-3
[760.587126] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[760.600535] Starting dynamic subtest: pipe-C-DP-3
[760.612717] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[760.625818] Starting dynamic subtest: pipe-D-DP-3
[760.638160] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[760.640201] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[760.991482] [120/131] (265s left) i915_pm_rpm (sysfs-read)
[763.327504] Starting subtest: sysfs-read
[763.718271] Subtest sysfs-read: SUCCESS (0.392s)
[764.064017] [121/131] (262s left) fbdev (info)
[764.112598] Starting subtest: info
[764.113549] Subtest info: SUCCESS (0.000s)
[764.261288] [122/131] (262s left) perf (rc6-disable)
[764.447437] Starting subtest: rc6-disable
[764.649175] Subtest rc6-disable: SUCCESS (0.201s)
[764.764424] [123/131] (262s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[764.959148] Starting subtest: coverage-vs-premult-vs-constant
[765.221602] Starting dynamic subtest: pipe-A-DP-3
[765.703797] Dynamic subtest pipe-A-DP-3: SUCCESS (0.481s)
[765.720274] Starting dynamic subtest: pipe-D-DP-3
[766.202576] Dynamic subtest pipe-D-DP-3: SUCCESS (0.497s)
[766.203513] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.243s)
[766.462275] [124/131] (260s left) gem_mmap_offset (oob-read)
[766.541975] Starting subtest: oob-read
[766.542937] Subtest oob-read: SUCCESS (0.000s)
[766.684335] [125/131] (260s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[766.890812] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[766.949954] [126/131] (260s left) kms_async_flips (alternate-sync-async-flip-atomic)
[767.141306] Starting subtest: alternate-sync-async-flip-atomic
[767.369395] Starting dynamic subtest: pipe-A-DP-3
[769.658735] Dynamic subtest pipe-A-DP-3: SUCCESS (2.288s)
[769.906269] Starting dynamic subtest: pipe-B-DP-3
[772.002013] Dynamic subtest pipe-B-DP-3: SUCCESS (2.110s)
[772.200105] Starting dynamic subtest: pipe-C-DP-3
[774.323786] Dynamic subtest pipe-C-DP-3: SUCCESS (2.136s)
[774.536994] Starting dynamic subtest: pipe-D-DP-3
[776.645341] Dynamic subtest pipe-D-DP-3: SUCCESS (2.120s)
[776.646768] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.504s)
[777.109644] [127/131] (249s left) kms_psr (psr2-sprite-mmap-gtt)
[777.306774] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[777.375494] [128/131] (249s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[777.572401] Starting subtest: 2x-flip-vs-cursor-legacy
[777.575599] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[777.694461] [129/131] (249s left) kms_flip (nonblocking-read)
[777.887686] Starting subtest: nonblocking-read
[777.888597] Subtest nonblocking-read: SUCCESS (0.000s)
[778.047946] [130/131] (249s left) gem_exec_flush (basic-wb-set-default)
[778.132103] Subtest basic-wb-set-default: SKIP (0.000s)
[778.211166] [131/131] (249s left) kms_prop_blob (blob-prop-validate)
[778.289016] Starting subtest: blob-prop-validate
[778.289974] Subtest blob-prop-validate: SUCCESS (0.000s)
[778.448258] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_chamelium_frames
results: parsing output: 10/ for test: kms_writeback
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: gem_exec_nop
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_exec_whisper
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: gem_create
results: parsing output: 21/ for test: gem_pwrite
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: gem_ctx_engines
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: gem_flink_basic
results: parsing output: 40/ for test: kms_pm_backlight
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: sysfs_preempt_timeout
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_ctx_create
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_nop
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_pipe_control_store_loop
results: parsing output: 66/ for test: kms_flip_tiling
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_atomic_interruptible
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: gem_madvise
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_alpha_blend
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: vgem_basic
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: prime_busy
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: kms_cursor_edge_walk
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_dither
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_edid
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_sequence
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: prime_self_import
results: parsing output: 112/ for test: gem_create
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: fbdev
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_plane_alpha_blend
results: parsing output: 123/ for test: gem_mmap_offset
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_flush
results: parsing output: 130/ for test: kms_prop_blob
Done.