[54.003664] Initializing watchdogs
[54.003736]   /dev/watchdog0
[54.016497] [001/133] (960s left) kms_flip (2x-absolute-wf_vblank)
[54.108145] Starting subtest: 2x-absolute-wf_vblank
[54.119481] Subtest 2x-absolute-wf_vblank: SKIP (0.013s)
[54.182843] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[54.294101] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[54.298710] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[54.369416] [003/133] (960s left) gem_userptr_blits (probe)
[54.445697] Starting subtest: probe
[54.569112] Subtest probe: SUCCESS (0.122s)
[54.657782] [004/133] (959s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[54.741641] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[54.744203] Starting dynamic subtest: A-eDP1
[63.915772] Dynamic subtest A-eDP1: SUCCESS (9.175s)
[63.928082] Starting dynamic subtest: B-eDP1
[72.878909] Dynamic subtest B-eDP1: SUCCESS (8.962s)
[72.891357] Starting dynamic subtest: C-eDP1
[81.889131] Dynamic subtest C-eDP1: SUCCESS (9.009s)
[81.901195] Starting dynamic subtest: D-eDP1
[90.851659] Dynamic subtest D-eDP1: SUCCESS (8.958s)
[90.856709] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (36.116s)
[92.103712] [005/133] (922s left) prime_vgem (sync)
[92.222422] Starting subtest: sync
[92.225185] Starting dynamic subtest: rcs0
[92.264363] Dynamic subtest rcs0: SUCCESS (0.041s)
[92.276176] Starting dynamic subtest: bcs0
[92.321070] Dynamic subtest bcs0: SUCCESS (0.057s)
[92.331797] Starting dynamic subtest: vcs0
[92.380826] Dynamic subtest vcs0: SUCCESS (0.059s)
[92.391892] Starting dynamic subtest: vcs1
[92.436531] Dynamic subtest vcs1: SUCCESS (0.056s)
[92.447893] Starting dynamic subtest: vecs0
[92.491606] Dynamic subtest vecs0: SUCCESS (0.055s)
[92.502720] Starting dynamic subtest: ccs0
[92.548860] Dynamic subtest ccs0: SUCCESS (0.057s)
[92.551573] Subtest sync: SUCCESS (0.326s)
[92.649250] [006/133] (921s left) syncobj_basic (bad-destroy)
[92.709646] Starting subtest: bad-destroy
[92.712483] Subtest bad-destroy: SUCCESS (0.000s)
[92.781615] [007/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[92.891812] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[92.895806] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[92.963814] [008/133] (921s left) gem_exec_fence (nb-await)
[93.160072] Starting subtest: nb-await
[93.162609] Starting dynamic subtest: rcs0
[93.242546] Dynamic subtest rcs0: SUCCESS (0.083s)
[93.255395] Starting dynamic subtest: bcs0
[93.305514] Dynamic subtest bcs0: SUCCESS (0.063s)
[93.319148] Starting dynamic subtest: vcs0
[93.370056] Dynamic subtest vcs0: SUCCESS (0.064s)
[93.382781] Starting dynamic subtest: vcs1
[93.431436] Dynamic subtest vcs1: SUCCESS (0.061s)
[93.443438] Starting dynamic subtest: vecs0
[93.495392] Dynamic subtest vecs0: SUCCESS (0.064s)
[93.507513] Starting dynamic subtest: ccs0
[93.560175] Dynamic subtest ccs0: SUCCESS (0.064s)
[93.562429] Subtest nb-await: SUCCESS (0.401s)
[95.540153] [009/133] (919s left) gem_render_copy_redux (interruptible)
[95.604647] Starting subtest: interruptible
[95.949547] Subtest interruptible: SUCCESS (0.345s)
[96.014681] [010/133] (918s left) syncobj_wait (wait-all-for-submit-snapshot)
[96.085893] Starting subtest: wait-all-for-submit-snapshot
[96.167653] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[96.249382] [011/133] (918s left) gen9_exec_parse (basic-rejected)
[96.340673] Subtest basic-rejected: SKIP (0.000s)
[96.387426] [012/133] (918s left) gem_busy (semaphore)
[96.621159] Subtest semaphore: SKIP (0.000s)
[96.834633] [013/133] (917s left) gem_lmem_swapping (verify-random-ccs)
[96.908276] Subtest verify-random-ccs: SKIP (0.000s)
[96.933442] [014/133] (917s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[97.021977] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[97.026596] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[97.093648] [015/133] (917s left) syncobj_basic (bad-flags-handle-to-fd)
[97.163409] Starting subtest: bad-flags-handle-to-fd
[97.165822] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[97.234470] [016/133] (917s left) kms_pm_rpm (system-suspend-modeset)
[98.757947] Starting subtest: system-suspend-modeset
[126.797232] Subtest system-suspend-modeset: SUCCESS (13.218s)
[127.636798] [017/133] (902s left) kms_properties (crtc-properties-atomic)
[127.742912] Starting subtest: crtc-properties-atomic
[131.609848] Subtest crtc-properties-atomic: SUCCESS (3.867s)
[132.519369] [018/133] (897s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[132.580284] Starting subtest: multi-wait-for-submit-submitted-signaled
[132.582314] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[132.652723] [019/133] (897s left) gem_create (hog-create)
[132.714303] Starting subtest: hog-create
[132.717271] Starting dynamic subtest: smem0
[148.415847] Dynamic subtest smem0: FAIL (15.615s)
[148.417871] Subtest hog-create: FAIL (15.615s)
[150.376261] [020/133] (879s left) v3d/v3d_submit_cl (bad-bo)
[150.459913] Subtest bad-bo: SKIP (0.000s)
[150.510974] [021/133] (879s left) gem_fenced_exec_thrash (too-many-fences)
[150.591295] Subtest too-many-fences: SKIP (0.000s)
[150.632456] [022/133] (879s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[150.722223] Starting subtest: addfb25-y-tiled-legacy
[150.724152] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[150.806997] [023/133] (879s left) api_intel_allocator (reopen-fork)
[150.880644] Starting subtest: reopen-fork
[154.241986] Subtest reopen-fork: SUCCESS (3.360s)
[154.308268] [024/133] (875s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[154.400204] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[154.402698] Starting dynamic subtest: pipe-A-eDP-1
[154.412130] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[154.427554] Starting dynamic subtest: pipe-B-eDP-1
[154.433548] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[154.447484] Starting dynamic subtest: pipe-C-eDP-1
[154.453361] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[154.461474] Starting dynamic subtest: pipe-D-eDP-1
[154.467298] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[154.472170] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.056s)
[154.539706] [025/133] (875s left) drm_fdinfo (virtual-busy-hang)
[154.606588] Starting subtest: virtual-busy-hang
[154.611330] Subtest virtual-busy-hang: SKIP (0.000s)
[154.676357] [026/133] (875s left) gem_lmem_swapping (heavy-random)
[154.733273] Subtest heavy-random: SKIP (0.000s)
[154.750505] [027/133] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[154.855274] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[154.859911] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[154.945128] [028/133] (875s left) kms_psr2_su (page_flip-nv12)
[155.014175] Subtest page_flip-NV12: SKIP (0.000s)
[155.051695] [029/133] (874s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[155.156435] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[155.158799] Starting dynamic subtest: pipe-A-eDP-1
[155.165739] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[155.174644] Starting dynamic subtest: pipe-B-eDP-1
[155.181325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[155.190439] Starting dynamic subtest: pipe-C-eDP-1
[155.196893] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[155.206067] Starting dynamic subtest: pipe-D-eDP-1
[155.212423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[155.216667] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[155.236842] [030/133] (874s left) gem_exec_reloc (basic-active)
[155.304252] Subtest basic-active: SKIP (0.000s)
[155.358872] [031/133] (874s left) gem_exec_schedule (lateslice)
[155.450940] Starting subtest: lateslice
[155.453173] Starting dynamic subtest: rcs0
[155.466000] Dynamic subtest rcs0: SUCCESS (0.023s)
[155.480863] Starting dynamic subtest: bcs0
[155.489126] Dynamic subtest bcs0: SUCCESS (0.023s)
[155.503229] Starting dynamic subtest: vcs0
[155.510555] Dynamic subtest vcs0: SUCCESS (0.021s)
[155.522949] Starting dynamic subtest: vcs1
[155.532690] Dynamic subtest vcs1: SUCCESS (0.022s)
[155.545912] Starting dynamic subtest: vecs0
[155.554394] Dynamic subtest vecs0: SUCCESS (0.022s)
[155.566547] Starting dynamic subtest: ccs0
[155.573853] Dynamic subtest ccs0: SUCCESS (0.019s)
[155.576472] Subtest lateslice: SUCCESS (0.131s)
[157.347152] [032/133] (872s left) v3d/v3d_submit_csd (job-perfmon)
[157.419876] Subtest job-perfmon: SKIP (0.000s)
[157.472360] [033/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[157.578556] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[157.582689] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[157.665498] [034/133] (872s left) kms_feature_discovery (display-2x)
[157.739977] Starting subtest: display-2x
[157.744720] Subtest display-2x: SKIP (0.000s)
[157.804765] [035/133] (872s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[157.927189] Starting subtest: y-tiled-8bpp-rotate-180
[157.931607] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[158.006247] [036/133] (872s left) perf_pmu (faulting-read)
[158.068388] Starting subtest: faulting-read
[158.071292] Starting dynamic subtest: gtt
[158.076836] Dynamic subtest gtt: SKIP (0.000s)
[158.093352] Starting dynamic subtest: wb
[158.095691] Dynamic subtest wb: SUCCESS (0.002s)
[158.106396] Starting dynamic subtest: wc
[158.109204] Dynamic subtest wc: SUCCESS (0.001s)
[158.125592] Starting dynamic subtest: uc
[158.128163] Dynamic subtest uc: SUCCESS (0.001s)
[158.130536] Subtest faulting-read: SUCCESS (0.005s)
[158.158652] [037/133] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[158.270097] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[163.258137] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.995s)
[163.376398] [038/133] (866s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[163.761495] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[164.616832] [039/133] (865s left) kms_psr (pr-cursor-plane-move)
[164.711416] Starting subtest: pr-cursor-plane-move
[164.716043] Subtest pr-cursor-plane-move: SKIP (0.000s)
[164.777703] [040/133] (865s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[164.870165] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[164.872732] Starting dynamic subtest: pipe-A-eDP-1
[164.877203] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.886602] Starting dynamic subtest: pipe-B-eDP-1
[164.890212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.897272] Starting dynamic subtest: pipe-C-eDP-1
[164.901535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.908479] Starting dynamic subtest: pipe-D-eDP-1
[164.912758] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.917177] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[164.933671] [041/133] (865s left) kms_draw_crc (draw-method-render)
[164.987886] Starting subtest: draw-method-render
[164.990226] Starting dynamic subtest: xrgb8888-untiled
[165.266024] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s)
[165.281915] Starting dynamic subtest: rgb565-untiled
[165.554842] Dynamic subtest rgb565-untiled: SUCCESS (0.289s)
[165.571593] Starting dynamic subtest: xrgb2101010-untiled
[165.788896] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[165.805196] Starting dynamic subtest: xrgb8888-xtiled
[165.921259] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[165.936899] Starting dynamic subtest: rgb565-xtiled
[166.055040] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[166.069742] Starting dynamic subtest: xrgb2101010-xtiled
[166.187487] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[166.204162] Starting dynamic subtest: xrgb8888-4tiled
[166.320741] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[166.336505] Starting dynamic subtest: rgb565-4tiled
[166.454689] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[166.471309] Starting dynamic subtest: xrgb2101010-4tiled
[166.565450] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[166.567679] Subtest draw-method-render: SUCCESS (1.579s)
[166.666827] [042/133] (863s left) gem_ctx_shared (q-smoketest)
[166.753263] Starting subtest: Q-smoketest
[166.755559] Starting dynamic subtest: rcs0
[172.419939] Dynamic subtest rcs0: SUCCESS (5.557s)
[172.426639] Starting dynamic subtest: bcs0
[177.937751] Dynamic subtest bcs0: SUCCESS (5.573s)
[177.954852] Starting dynamic subtest: vcs0
[183.435275] Dynamic subtest vcs0: SUCCESS (5.491s)
[183.445463] Starting dynamic subtest: vcs1
[188.922616] Dynamic subtest vcs1: SUCCESS (5.490s)
[188.936643] Starting dynamic subtest: vecs0
[194.399553] Dynamic subtest vecs0: SUCCESS (5.479s)
[194.418931] Starting dynamic subtest: ccs0
[199.971014] Dynamic subtest ccs0: SUCCESS (5.513s)
[199.974091] Subtest Q-smoketest: SUCCESS (33.105s)
[200.077947] [043/133] (830s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[200.195598] Starting subtest: fbc-rgb101010-draw-pwrite
[204.453625] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (4.260s)
[204.564819] [044/133] (825s left) syncobj_wait (invalid-reset-zero-handles)
[204.632172] Starting subtest: invalid-reset-zero-handles
[204.634505] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[204.708434] [045/133] (825s left) gem_exec_fair (basic-none-rrul)
[204.796593] Subtest basic-none-rrul: SKIP (0.000s)
[204.821341] [046/133] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[204.943821] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[204.948094] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[205.024251] [047/133] (825s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[205.093632] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[205.096122] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[205.176250] [048/133] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[205.279357] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[208.336295] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (3.061s)
[208.458783] [049/133] (822s left) kms_getfb (getfb2-into-addfb2)
[208.544029] Starting subtest: getfb2-into-addfb2
[208.546158] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[208.633645] [050/133] (821s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[208.702937] Starting subtest: etime-single-wait-for-submit-unsubmitted
[208.807583] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[208.877862] [051/133] (821s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[208.983237] Starting subtest: yf-tiled-64bpp-rotate-180
[208.987338] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[209.071428] [052/133] (821s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[209.171139] Starting subtest: 2x-flip-vs-rmfb-interruptible
[209.188183] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.013s)
[209.258590] [053/133] (821s left) kms_pm_rpm (basic-pci-d3-state)
[211.496137] Starting subtest: basic-pci-d3-state
[215.706463] Subtest basic-pci-d3-state: SUCCESS (4.210s)
[215.822008] [054/133] (814s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[215.874330] Starting subtest: wait-all-for-submit-delayed-submit
[215.974638] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[216.049356] [055/133] (814s left) kms_cursor_crc (cursor-offscreen-512x170)
[216.373776] Starting subtest: cursor-offscreen-512x170
[216.378503] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[216.492505] [056/133] (814s left) gem_userptr_blits (coherency-unsync)
[216.578268] Subtest coherency-unsync: SKIP (0.000s)
[216.696266] [057/133] (814s left) kms_psr (fbc-pr-sprite-plane-move)
[216.817791] Starting subtest: fbc-pr-sprite-plane-move
[216.822460] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[216.876572] [058/133] (813s left) kms_chamelium_color (ctm-negative)
[216.958773] Subtest ctm-negative: SKIP (0.000s)
[216.974660] [059/133] (813s left) gem_exec_schedule (preempt-queue-contexts-chain)
[217.050435] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[217.345607] [060/133] (813s left) kms_vblank (query-idle)
[217.454583] Starting subtest: query-idle
[217.457133] Starting dynamic subtest: pipe-A-eDP-1
[219.224907] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[219.244597] Starting dynamic subtest: pipe-D-eDP-1
[221.758999] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[221.761554] Subtest query-idle: SUCCESS (4.304s)
[222.696966] [061/133] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[222.764261] Starting subtest: compare-crc-sanitycheck-nv12
[222.766775] Starting dynamic subtest: pipe-A-eDP-1
[223.473445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[223.490971] Starting dynamic subtest: pipe-B-eDP-1
[224.843221] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[224.860834] Starting dynamic subtest: pipe-C-eDP-1
[226.197647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[226.215992] Starting dynamic subtest: pipe-D-eDP-1
[227.551232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[227.553311] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.787s)
[228.457636] [062/133] (802s left) gem_exec_reloc (basic-gtt-noreloc)
[228.547581] Subtest basic-gtt-noreloc: SKIP (0.000s)
[228.611175] [063/133] (802s left) kms_color (ctm-negative)
[228.703545] Starting subtest: ctm-negative
[228.705506] Starting dynamic subtest: pipe-A
[229.438467] Dynamic subtest pipe-A: SUCCESS (0.735s)
[229.458100] Starting dynamic subtest: pipe-B
[231.020265] Dynamic subtest pipe-B: SUCCESS (1.582s)
[231.038076] Starting dynamic subtest: pipe-C
[232.467229] Dynamic subtest pipe-C: SUCCESS (1.446s)
[232.485833] Starting dynamic subtest: pipe-D
[233.941399] Dynamic subtest pipe-D: SUCCESS (1.474s)
[233.943784] Subtest ctm-negative: SUCCESS (5.239s)
[234.860144] [064/133] (796s left) gem_softpin (evict-active-interruptible)
[234.920278] Starting subtest: evict-active-interruptible
[234.928581] Subtest evict-active-interruptible: SUCCESS (0.008s)
[235.029452] [065/133] (796s left) gem_ctx_persistence (file)
[235.109551] Starting subtest: file
[235.194653] Subtest file: SUCCESS (0.086s)
[235.297942] [066/133] (795s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[235.393564] Starting subtest: primary-yf-tiled-reflect-x-270
[235.398224] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[235.459565] [067/133] (795s left) drm_fdinfo (all-busy-check-all)
[235.529762] Starting subtest: all-busy-check-all
[235.540159] Subtest all-busy-check-all: SKIP (0.007s)
[235.611176] [068/133] (795s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[238.278158] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[238.311776] [069/133] (792s left) gem_flink_race (flink_close)
[238.363112] Starting subtest: flink_close
[243.471874] Subtest flink_close: SUCCESS (5.074s)
[243.535591] [070/133] (787s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[243.628407] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[243.630958] Starting dynamic subtest: pipe-A-eDP-1
[243.635011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.645413] Starting dynamic subtest: pipe-B-eDP-1
[243.649730] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.667287] Starting dynamic subtest: pipe-C-eDP-1
[243.672628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.687592] Starting dynamic subtest: pipe-D-eDP-1
[243.692621] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.697716] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[243.721736] [071/133] (787s left) gem_tiled_partial_pwrite_pread (writes)
[243.806493] Subtest writes: SKIP (0.000s)
[243.872794] [072/133] (787s left) sysfs_preempt_timeout (idempotent)
[243.969853] Starting subtest: idempotent
[243.972650] Starting dynamic subtest: vecs0
[243.975401] Dynamic subtest vecs0: SUCCESS (0.001s)
[243.993248] Starting dynamic subtest: ccs0
[243.995910] Dynamic subtest ccs0: SUCCESS (0.001s)
[244.013741] Starting dynamic subtest: vcs0
[244.016340] Dynamic subtest vcs0: SUCCESS (0.001s)
[244.030694] Starting dynamic subtest: bcs0
[244.033343] Dynamic subtest bcs0: SUCCESS (0.001s)
[244.052131] Starting dynamic subtest: rcs0
[244.054437] Dynamic subtest rcs0: SUCCESS (0.001s)
[244.062691] Starting dynamic subtest: vcs1
[244.064647] Dynamic subtest vcs1: SUCCESS (0.001s)
[244.066564] Subtest idempotent: SUCCESS (0.009s)
[244.080790] [073/133] (787s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[244.288057] Starting subtest: cursor-rapid-movement-64x21
[244.319770] Subtest cursor-rapid-movement-64x21: SKIP (0.026s)
[244.588866] [074/133] (786s left) syncobj_timeline (multi-wait-signaled)
[244.662401] Starting subtest: multi-wait-signaled
[244.664780] Subtest multi-wait-signaled: SUCCESS (0.001s)
[244.758357] [075/133] (786s left) prime_mmap (test_map_unmap)
[244.817765] Starting subtest: test_map_unmap
[244.819996] Starting dynamic subtest: test_map_unmap-smem
[244.845464] Dynamic subtest test_map_unmap-smem: SUCCESS (0.027s)
[244.847857] Subtest test_map_unmap: SUCCESS (0.027s)
[244.930672] [076/133] (786s left) kms_atomic (plane-immutable-zpos)
[245.007080] Starting subtest: plane-immutable-zpos
[245.009089] Starting dynamic subtest: pipe-A-eDP-1
[245.661635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[245.664352] Subtest plane-immutable-zpos: SUCCESS (0.653s)
[246.599074] [077/133] (784s left) sw_sync (sync_multi_timeline_wait)
[246.648272] Starting subtest: sync_multi_timeline_wait
[246.650891] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[246.699988] [078/133] (784s left) perf (invalid-oa-exponent)
[246.849452] Starting subtest: invalid-oa-exponent
[246.864877] Subtest invalid-oa-exponent: SUCCESS (0.016s)
[246.896255] [079/133] (784s left) gem_exec_reloc (basic-wc-read-noreloc)
[246.972936] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[247.014786] [080/133] (784s left) kms_pipe_crc_basic (bad-source)
[247.119914] Starting subtest: bad-source
[247.122253] Subtest bad-source: SUCCESS (0.000s)
[247.189721] [081/133] (784s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[247.285141] Starting subtest: fbc-psr-sprite-mmap-gtt
[247.287622] Starting dynamic subtest: eDP-1
[247.291984] Dynamic subtest eDP-1: SKIP (0.000s)
[247.296302] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[247.358777] [082/133] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[247.456508] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[250.233048] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.781s)
[250.369241] [083/133] (781s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[250.453388] Starting subtest: bad-rotation-90-yf-tiled-ccs
[250.455384] Starting dynamic subtest: pipe-A-eDP-1
[250.459281] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.466546] Starting dynamic subtest: pipe-B-eDP-1
[250.470294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.477507] Starting dynamic subtest: pipe-C-eDP-1
[250.481336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.488118] Starting dynamic subtest: pipe-D-eDP-1
[250.491668] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.495180] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[250.516835] [084/133] (781s left) gem_render_copy (yf-tiled-ccs-to-linear)
[250.566113] Starting subtest: yf-tiled-ccs-to-linear
[250.569991] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[250.751959] [085/133] (780s left) gem_eio (wait-1us)
[250.998855] Starting subtest: wait-1us
[251.412903] Subtest wait-1us: SUCCESS (0.413s)
[251.527597] [086/133] (780s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[251.634136] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[252.846171] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.213s)
[252.983697] [087/133] (778s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[253.072619] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[253.077997] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[253.260291] [088/133] (778s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[253.631402] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[254.539197] [089/133] (777s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[254.653626] Starting subtest: basic-busy-flip-before-cursor-varying-size
[254.658658] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[254.790665] [090/133] (777s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[254.907560] Starting subtest: basic-flip-after-cursor-varying-size
[255.883963] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.975s)
[256.816639] [091/133] (774s left) gem_sync (basic-many-each)
[256.904558] Starting subtest: basic-many-each
[259.211771] Subtest basic-many-each: SUCCESS (2.313s)
[259.395806] [092/133] (772s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[259.512730] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[265.793583] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.287s)
[265.896593] [093/133] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[266.007615] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[266.012145] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[266.095805] [094/133] (765s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[266.156098] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[266.158935] Starting dynamic subtest: pipe-A-default-mode
[266.487875] Dynamic subtest pipe-A-default-mode: SKIP (0.329s)
[266.492575] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.330s)
[267.323727] [095/133] (764s left) perf_pmu (busy-accuracy-50)
[267.382026] Starting subtest: busy-accuracy-50
[267.384489] Starting dynamic subtest: rcs0
[268.933463] Dynamic subtest rcs0: SUCCESS (1.548s)
[268.952394] Starting dynamic subtest: bcs0
[270.486686] Dynamic subtest bcs0: SUCCESS (1.551s)
[270.505411] Starting dynamic subtest: vcs0
[272.044205] Dynamic subtest vcs0: SUCCESS (1.556s)
[272.062749] Starting dynamic subtest: vcs1
[273.600148] Dynamic subtest vcs1: SUCCESS (1.555s)
[273.619172] Starting dynamic subtest: vecs0
[275.160444] Dynamic subtest vecs0: SUCCESS (1.560s)
[275.179337] Starting dynamic subtest: ccs0
[276.724956] Dynamic subtest ccs0: SUCCESS (1.562s)
[276.728488] Subtest busy-accuracy-50: SUCCESS (9.340s)
[276.838325] [096/133] (755s left) kms_psr2_sf (fbc-cursor-plane-move-continuous-sf)
[282.091760] Starting subtest: fbc-cursor-plane-move-continuous-sf
[282.094361] Starting dynamic subtest: psr2-pipe-A-eDP-1
[282.937564] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.841s)
[282.956905] Starting dynamic subtest: psr2-pipe-B-eDP-1
[284.217568] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.277s)
[284.222559] Subtest fbc-cursor-plane-move-continuous-sf: SKIP (2.124s)
[285.477023] [097/133] (746s left) syncobj_timeline (wait-all-interrupted)
[285.544653] Starting subtest: wait-all-interrupted
[285.648083] Subtest wait-all-interrupted: SUCCESS (0.102s)
[285.724978] [098/133] (746s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[285.812366] Starting subtest: x-tiled-32bpp-rotate-180
[287.462115] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.652s)
[287.607658] [099/133] (744s left) api_intel_bb (object-noreloc-purge-cache-simple)
[287.664745] Starting subtest: object-noreloc-purge-cache-simple
[287.669907] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[287.749294] [100/133] (744s left) i915_pm_rpm (system-suspend-devices)
[289.455505] Starting subtest: system-suspend-devices
[302.263203] Subtest system-suspend-devices: SUCCESS (12.808s)
[303.063549] [101/133] (729s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[303.170779] Starting subtest: psr-rgb101010-draw-blt
[308.353802] Subtest psr-rgb101010-draw-blt: SUCCESS (5.189s)
[308.474486] [102/133] (723s left) i915_suspend (basic-s3-without-i915)
[308.529914] Starting subtest: basic-s3-without-i915
[310.101218] Subtest basic-s3-without-i915: SKIP (1.567s)
[311.325871] [103/133] (720s left) gem_mmap_offset (clear)
[311.392050] Starting subtest: clear
[311.394072] Starting dynamic subtest: smem0
[335.567489] Dynamic subtest smem0: SUCCESS (24.171s)
[335.569674] Subtest clear: SUCCESS (24.172s)
[335.721626] [104/133] (696s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[335.864964] Starting subtest: y-tiled-ccs-to-x-tiled
[335.870467] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[336.051426] [105/133] (696s left) gem_workarounds (suspend-resume-fd)
[336.157498] Starting subtest: suspend-resume-fd
[351.791189] Subtest suspend-resume-fd: SUCCESS (1.192s)
[351.885462] [106/133] (694s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[351.973230] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[351.976088] Starting dynamic subtest: pipe-A-default-mode
[352.270098] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[352.275448] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.294s)
[353.172098] [107/133] (693s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[353.272318] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[353.276789] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[353.350217] [108/133] (693s left) syncobj_timeline (invalid-wait-zero-handles)
[353.429469] Starting subtest: invalid-wait-zero-handles
[353.472872] Subtest invalid-wait-zero-handles: FAIL (0.008s)
[353.515464] [109/133] (693s left) syncobj_timeline (device-signal-unordered)
[353.585057] Starting subtest: device-signal-unordered
[353.587651] Subtest device-signal-unordered: SUCCESS (0.001s)
[353.661695] [110/133] (693s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[353.737698] Subtest destroy-valid-perfmon: SKIP (0.000s)
[353.785412] [111/133] (693s left) v3d/v3d_submit_cl (bad-multisync-in-sync)
[353.868168] Subtest bad-multisync-in-sync: SKIP (0.000s)
[353.914947] [112/133] (692s left) gem_softpin (allocator-nopin-reserve)
[353.980098] Starting subtest: allocator-nopin-reserve
[354.054536] Subtest allocator-nopin-reserve: SUCCESS (0.076s)
[354.154827] [113/133] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[354.230165] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[360.620742] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.395s)
[360.766294] [114/133] (686s left) syncobj_wait (invalid-single-wait-unsubmitted)
[360.833994] Starting subtest: invalid-single-wait-unsubmitted
[360.836673] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[360.917833] [115/133] (685s left) kms_psr (psr-cursor-blt)
[361.014593] Starting subtest: psr-cursor-blt
[361.016920] Starting dynamic subtest: eDP-1
[362.828767] Dynamic subtest eDP-1: SUCCESS (1.811s)
[362.831297] Subtest psr-cursor-blt: SUCCESS (1.813s)
[363.722411] [116/133] (683s left) gem_exec_whisper (basic-contexts-forked-all)
[363.808182] Starting subtest: basic-contexts-forked-all
[393.451743] Subtest basic-contexts-forked-all: SUCCESS (29.640s)
[393.630242] [117/133] (653s left) gem_exec_balancer (full-pulse)
[393.707905] Starting subtest: full-pulse
[398.366168] Subtest full-pulse: SUCCESS (4.658s)
[398.658571] [118/133] (648s left) kms_big_fb (x-tiled-addfb-size-overflow)
[398.748511] Starting subtest: x-tiled-addfb-size-overflow
[398.750871] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[398.828745] [119/133] (648s left) gem_ctx_persistence (processes)
[398.912152] Starting subtest: processes
[400.725838] Subtest processes: SUCCESS (1.813s)
[400.799394] [120/133] (646s left) vgem_basic (bad-flag)
[400.862854] Starting subtest: bad-flag
[400.865441] Subtest bad-flag: SUCCESS (0.000s)
[400.915558] [121/133] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[401.010821] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[403.947148] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.941s)
[404.091619] [122/133] (643s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[404.186646] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[409.018737] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.835s)
[409.128756] [123/133] (638s left) i915_pm_freq_api (freq-basic-api)
[409.223934] Starting subtest: freq-basic-api
[409.226709] Starting dynamic subtest: gt0
[409.232072] Dynamic subtest gt0: SUCCESS (0.005s)
[409.250816] Starting dynamic subtest: gt1
[409.253377] Dynamic subtest gt1: SUCCESS (0.003s)
[409.255708] Subtest freq-basic-api: SUCCESS (0.010s)
[409.325159] [124/133] (637s left) kms_sequence (get-forked-busy)
[409.424339] Starting subtest: get-forked-busy
[409.426384] Starting dynamic subtest: pipe-A-eDP-1
[411.360889] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[411.378855] Starting dynamic subtest: pipe-B-eDP-1
[414.055467] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.694s)
[414.070876] Starting dynamic subtest: pipe-C-eDP-1
[416.763393] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.702s)
[416.781512] Starting dynamic subtest: pipe-D-eDP-1
[419.424139] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[419.426773] Subtest get-forked-busy: SUCCESS (10.001s)
[420.308525] [125/133] (626s left) kms_plane (pixel-format-source-clamping)
[420.418192] Starting subtest: pixel-format-source-clamping
[420.420652] Starting dynamic subtest: pipe-A
[430.870727] Dynamic subtest pipe-A: SUCCESS (10.452s)
[430.890169] Starting dynamic subtest: pipe-B
[442.436897] Dynamic subtest pipe-B: SUCCESS (11.562s)
[442.439082] Subtest pixel-format-source-clamping: SUCCESS (22.019s)
[443.325569] [126/133] (603s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[443.383978] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[443.386493] Starting dynamic subtest: pipe-A-eDP-1
[443.420260] Dynamic subtest pipe-A-eDP-1: SKIP (0.030s)
[443.430257] Starting dynamic subtest: pipe-B-eDP-1
[443.465197] Dynamic subtest pipe-B-eDP-1: SKIP (0.045s)
[443.473526] Starting dynamic subtest: pipe-C-eDP-1
[443.519485] Dynamic subtest pipe-C-eDP-1: SKIP (0.053s)
[443.534305] Starting dynamic subtest: pipe-D-eDP-1
[443.552281] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[443.556970] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.167s)
[443.653900] [127/133] (603s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[443.737365] Starting subtest: plane-all-modeset-transition-fencing
[443.741956] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[443.808640] [128/133] (603s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[443.915682] Starting subtest: y-tiled-32bpp-rotate-0
[443.920389] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[443.992054] [129/133] (603s left) kms_lease (lease-again)
[444.082413] Starting subtest: lease-again
[444.085193] Starting dynamic subtest: pipe-A-eDP-1
[444.087826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.004s)
[444.108906] Starting dynamic subtest: pipe-B-eDP-1
[444.111535] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[444.124298] Starting dynamic subtest: pipe-C-eDP-1
[444.126557] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[444.135130] Starting dynamic subtest: pipe-D-eDP-1
[444.137572] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.003s)
[444.139864] Subtest lease-again: SUCCESS (0.023s)
[444.209193] [130/133] (603s left) kms_psr (psr-sprite-plane-move)
[444.293610] Starting subtest: psr-sprite-plane-move
[444.295548] Starting dynamic subtest: eDP-1
[446.130967] Dynamic subtest eDP-1: SUCCESS (1.832s)
[446.134310] Subtest psr-sprite-plane-move: SUCCESS (1.833s)
[447.053481] [131/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[447.154957] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[447.159203] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[447.239910] [132/133] (600s left) kms_flip (flip-vs-wf_vblank-interruptible)
[447.315152] Starting subtest: flip-vs-wf_vblank-interruptible
[447.317592] Starting dynamic subtest: A-eDP1
[449.318004] Dynamic subtest A-eDP1: SUCCESS (2.001s)
[449.340344] Starting dynamic subtest: B-eDP1
[451.304206] Dynamic subtest B-eDP1: SUCCESS (1.984s)
[451.323284] Starting dynamic subtest: C-eDP1
[453.271091] Dynamic subtest C-eDP1: SUCCESS (1.965s)
[453.289528] Starting dynamic subtest: D-eDP1
[455.256921] Dynamic subtest D-eDP1: SUCCESS (1.984s)
[455.264021] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.950s)
[456.549256] [133/133] (590s left) gem_mmap_gtt (basic-small-bo-tiledy)
[456.612250] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[456.657916] Closing watchdogs
Done.