[63.298623] Initializing watchdogs
[63.298671]   /dev/watchdog0
[63.304034] [001/130] (960s left) kms_psr (pr-suspend)
[63.361020] Starting subtest: pr-suspend
[63.362744] Subtest pr-suspend: SKIP (0.000s)
[63.405802] [002/130] (960s left) gem_tiled_wb
[70.189717] [003/130] (953s left) gem_userptr_blits (unsync-unmap-cycles)
[70.233799] Subtest unsync-unmap-cycles: SKIP (0.000s)
[70.333320] [004/130] (953s left) gem_exec_reloc (basic-range-active)
[70.373018] Subtest basic-range-active: SKIP (0.000s)
[70.421113] [005/130] (953s left) gem_spin_batch (spin-all)
[70.462052] Starting subtest: spin-all
[70.474683] Subtest spin-all: SUCCESS (0.013s)
[70.685961] [006/130] (953s left) gem_render_copy (y-tiled-to-vebox-linear)
[70.724331] Starting subtest: y-tiled-to-vebox-linear
[70.725408] Starting dynamic subtest: smem
[70.790935] Dynamic subtest smem: SUCCESS (0.066s)
[70.791793] Subtest y-tiled-to-vebox-linear: SUCCESS (0.067s)
[70.990980] [007/130] (952s left) kms_flip (plain-flip-ts-check-interruptible)
[71.054157] Starting subtest: plain-flip-ts-check-interruptible
[71.056047] Starting dynamic subtest: A-eDP1
[82.433403] Dynamic subtest A-eDP1: SUCCESS (11.363s)
[82.445752] Starting dynamic subtest: B-eDP1
[93.753742] Dynamic subtest B-eDP1: SUCCESS (11.313s)
[93.767761] Starting dynamic subtest: C-eDP1
[105.078994] Dynamic subtest C-eDP1: SUCCESS (11.322s)
[105.081696] Subtest plain-flip-ts-check-interruptible: SUCCESS (34.003s)
[106.347612] [008/130] (917s left) gem_ctx_isolation (nonpriv)
[106.387568] Starting subtest: nonpriv
[106.388627] Starting dynamic subtest: rcs0
[106.603840] Dynamic subtest rcs0: SUCCESS (0.216s)
[106.609652] Starting dynamic subtest: bcs0
[106.817747] Dynamic subtest bcs0: SUCCESS (0.214s)
[106.825720] Starting dynamic subtest: vcs0
[107.046369] Dynamic subtest vcs0: SUCCESS (0.228s)
[107.051773] Starting dynamic subtest: vecs0
[107.289335] Dynamic subtest vecs0: SUCCESS (0.243s)
[107.290125] Subtest nonpriv: SUCCESS (0.902s)
[107.482791] [009/130] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[107.541530] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[113.240275] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (5.698s)
[113.321994] [010/130] (910s left) sysfs_heartbeat_interval (mixed)
[113.356228] Starting subtest: mixed
[113.357131] Starting dynamic subtest: vecs0
[118.590724] Dynamic subtest vecs0: SUCCESS (5.233s)
[118.600339] Starting dynamic subtest: vcs0
[123.842961] Dynamic subtest vcs0: SUCCESS (5.251s)
[123.856503] Starting dynamic subtest: bcs0
[129.082629] Dynamic subtest bcs0: SUCCESS (5.238s)
[129.089953] Starting dynamic subtest: rcs0
[134.311399] Dynamic subtest rcs0: SUCCESS (5.227s)
[134.312740] Subtest mixed: SUCCESS (20.952s)
[134.410920] [011/130] (889s left) kms_psr (fbc-psr-sprite-render)
[134.475928] Starting subtest: fbc-psr-sprite-render
[134.477073] Starting dynamic subtest: eDP-1
[134.478776] Dynamic subtest eDP-1: SKIP (0.000s)
[134.480251] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[134.525415] [012/130] (889s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[134.592113] Starting subtest: yf-tiled-64bpp-rotate-0
[134.593708] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[134.646533] [013/130] (889s left) kms_atomic (crtc-invalid-params)
[134.703618] Starting subtest: crtc-invalid-params
[134.705450] Starting dynamic subtest: pipe-A-eDP-1
[135.072730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[135.073647] Subtest crtc-invalid-params: SUCCESS (0.369s)
[135.984440] [014/130] (888s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[136.021088] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[136.022486] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[136.070077] [015/130] (888s left) syncobj_wait (invalid-wait-bad-flags)
[136.104304] Starting subtest: invalid-wait-bad-flags
[136.105188] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[136.144374] [016/130] (887s left) syncobj_timeline (multi-wait-submitted-signaled)
[136.178812] Starting subtest: multi-wait-submitted-signaled
[136.179644] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[136.212391] [017/130] (887s left) gem_eio (reset-stress)
[136.352581] Starting subtest: reset-stress
[170.237982] Subtest reset-stress: SUCCESS (33.879s)
[170.318716] [018/130] (853s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[173.704998] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[173.713509] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.006s)
[174.638955] [019/130] (849s left) syncobj_wait (invalid-signal-illegal-handle)
[174.675740] Starting subtest: invalid-signal-illegal-handle
[174.676569] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[174.718482] [020/130] (849s left) gem_exec_store (dword)
[174.755515] Starting subtest: dword
[174.756480] Starting dynamic subtest: rcs0
[174.797193] Dynamic subtest rcs0: SUCCESS (0.041s)
[174.813272] Starting dynamic subtest: bcs0
[174.840063] Dynamic subtest bcs0: SUCCESS (0.042s)
[174.856235] Starting dynamic subtest: vcs0
[174.883975] Dynamic subtest vcs0: SUCCESS (0.044s)
[174.899845] Starting dynamic subtest: vecs0
[174.926767] Dynamic subtest vecs0: SUCCESS (0.042s)
[174.928256] Subtest dword: SUCCESS (0.170s)
[175.087262] [021/130] (849s left) gem_huc_copy (huc-copy)
[175.120603] Starting subtest: huc-copy
[175.123279] Subtest huc-copy: SUCCESS (0.003s)
[175.210935] [022/130] (848s left) syncobj_eventfd (invalid-illegal-handle)
[175.245184] Starting subtest: invalid-illegal-handle
[175.246016] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[175.280895] [023/130] (848s left) gem_exec_reloc (basic-write-wc)
[175.315599] Subtest basic-write-wc: SKIP (0.000s)
[175.357317] [024/130] (848s left) kms_pm_rpm (modeset-non-lpsp)
[176.537918] Starting subtest: modeset-non-lpsp
[177.679556] Subtest modeset-non-lpsp: SKIP (1.141s)
[178.024528] [025/130] (846s left) gem_mmap (short-mmap)
[178.062372] Starting subtest: short-mmap
[178.063151] Subtest short-mmap: SUCCESS (0.000s)
[178.123954] [026/130] (846s left) kms_chamelium_color (ctm-max)
[178.179437] Subtest ctm-max: SKIP (0.000s)
[178.196755] [027/130] (846s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[178.226472] Starting subtest: no-spare-fences-busy-interruptible
[180.402055] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.171s)
[180.488679] [028/130] (843s left) kms_color (ctm-0-50)
[180.548598] Starting subtest: ctm-0-50
[180.549525] Starting dynamic subtest: pipe-A-eDP-1
[183.993806] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[184.009814] Starting dynamic subtest: pipe-B-eDP-1
[188.207850] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.214s)
[188.221272] Starting dynamic subtest: pipe-C-eDP-1
[192.411865] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.203s)
[192.413210] Subtest ctm-0-50: SUCCESS (11.862s)
[193.329339] [029/130] (831s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[193.398240] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[193.400261] Starting dynamic subtest: A-eDP1
[197.244703] Dynamic subtest A-eDP1: SUCCESS (3.842s)
[197.260549] Starting dynamic subtest: B-eDP1
[200.697765] Dynamic subtest B-eDP1: SUCCESS (3.452s)
[200.712067] Starting dynamic subtest: C-eDP1
[204.146875] Dynamic subtest C-eDP1: SUCCESS (3.449s)
[204.149728] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (10.750s)
[205.037988] [030/130] (819s left) gem_exec_reloc (basic-scanout)
[205.075890] Subtest basic-scanout: SKIP (0.000s)
[205.128314] [031/130] (819s left) i915_pm_rps (thresholds)
[205.163961] Starting subtest: thresholds
[205.166130] Subtest thresholds: SKIP (0.001s)
[205.209306] [032/130] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[205.269617] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[205.271217] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[205.332699] [033/130] (819s left) vgem_basic (second-client)
[205.377046] Starting subtest: second-client
[205.394832] Subtest second-client: SUCCESS (0.017s)
[205.432764] [034/130] (818s left) syncobj_timeline (wait-any-snapshot)
[205.466343] Starting subtest: wait-any-snapshot
[205.549977] Subtest wait-any-snapshot: SUCCESS (0.083s)
[205.602054] [035/130] (818s left) api_intel_allocator (default-alignment)
[205.634265] Starting subtest: default-alignment
[205.636973] Subtest default-alignment: SUCCESS (0.002s)
[205.704768] [036/130] (818s left) kms_dp_aux_dev
[205.839964] [037/130] (818s left) i915_pciid
[205.908314] [038/130] (818s left) drm_fdinfo (virtual-idle)
[205.937818] Starting subtest: virtual-idle
[207.973173] Subtest virtual-idle: SUCCESS (2.026s)
[208.018608] [039/130] (816s left) gem_busy (parallel)
[208.180378] Starting subtest: parallel
[208.181511] Starting dynamic subtest: rcs0
[208.260659] Dynamic subtest rcs0: SUCCESS (0.087s)
[208.280334] Starting dynamic subtest: bcs0
[208.312278] Dynamic subtest bcs0: SUCCESS (0.050s)
[208.332246] Starting dynamic subtest: vcs0
[208.363703] Dynamic subtest vcs0: SUCCESS (0.050s)
[208.383344] Starting dynamic subtest: vecs0
[208.415647] Dynamic subtest vecs0: SUCCESS (0.051s)
[208.417424] Subtest parallel: SUCCESS (0.243s)
[208.630148] [040/130] (815s left) core_hotunplug (unbind-rebind)
[208.716804] Starting subtest: unbind-rebind
[212.673242] Subtest unbind-rebind: SUCCESS (3.956s)
[212.689349] [041/130] (811s left) kms_psr (psr-sprite-mmap-gtt)
[212.746854] Starting subtest: psr-sprite-mmap-gtt
[212.747809] Starting dynamic subtest: eDP-1
[214.519358] Dynamic subtest eDP-1: SUCCESS (1.771s)
[214.520161] Subtest psr-sprite-mmap-gtt: SUCCESS (1.772s)
[215.407811] [042/130] (809s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[215.471810] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[219.188965] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (3.717s)
[220.415752] [043/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[220.473479] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[220.474981] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[220.559575] [044/130] (804s left) perf_pmu (busy)
[220.592798] Starting subtest: busy
[220.593615] Starting dynamic subtest: rcs0
[221.172274] Dynamic subtest rcs0: SUCCESS (0.578s)
[221.182870] Starting dynamic subtest: bcs0
[221.722236] Dynamic subtest bcs0: SUCCESS (0.549s)
[221.740510] Starting dynamic subtest: vcs0
[222.276271] Dynamic subtest vcs0: SUCCESS (0.553s)
[222.286174] Starting dynamic subtest: vecs0
[222.826356] Dynamic subtest vecs0: SUCCESS (0.549s)
[222.828355] Subtest busy: SUCCESS (2.233s)
[222.887664] [045/130] (801s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[222.931670] Starting subtest: map-fixed-invalidate-overlap
[222.932511] Starting dynamic subtest: gtt
[223.006146] Dynamic subtest gtt: SUCCESS (0.074s)
[223.014829] Starting dynamic subtest: wb
[223.048370] Dynamic subtest wb: SUCCESS (0.042s)
[223.057609] Starting dynamic subtest: wc
[223.089926] Dynamic subtest wc: SUCCESS (0.041s)
[223.099028] Starting dynamic subtest: uc
[223.132395] Dynamic subtest uc: SUCCESS (0.042s)
[223.133219] Subtest map-fixed-invalidate-overlap: SUCCESS (0.201s)
[223.215139] [046/130] (801s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[223.246290] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[223.247143] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[223.283791] [047/130] (801s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[223.346142] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[223.347276] Starting dynamic subtest: pipe-A-default-mode
[228.650369] Dynamic subtest pipe-A-default-mode: SUCCESS (5.307s)
[228.651154] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (5.309s)
[229.552134] [048/130] (795s left) kms_cursor_crc (cursor-random-64x64)
[229.616768] Starting subtest: cursor-random-64x64
[229.622972] Starting dynamic subtest: pipe-A-eDP-1
[231.786389] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.163s)
[231.843958] Starting dynamic subtest: pipe-C-eDP-1
[234.717119] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.881s)
[234.717860] Subtest cursor-random-64x64: SUCCESS (5.102s)
[235.632512] [049/130] (789s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[235.672064] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[235.744165] [050/130] (788s left) kms_flip (dpms-off-confusion-interruptible)
[235.809972] Starting subtest: dpms-off-confusion-interruptible
[235.812495] Starting dynamic subtest: A-eDP1
[247.038342] Dynamic subtest A-eDP1: SUCCESS (11.206s)
[247.046763] Starting dynamic subtest: B-eDP1
[258.213416] Dynamic subtest B-eDP1: SUCCESS (11.192s)
[258.231170] Starting dynamic subtest: C-eDP1
[269.434610] Dynamic subtest C-eDP1: SUCCESS (11.190s)
[269.436174] Subtest dpms-off-confusion-interruptible: SUCCESS (33.595s)
[270.704223] [051/130] (754s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[270.774123] Starting subtest: x-tiled-16bpp-rotate-270
[270.792180] Subtest x-tiled-16bpp-rotate-270: SKIP (0.017s)
[270.891692] [052/130] (753s left) kms_plane_scaling (intel-max-src-size)
[270.949646] Starting subtest: intel-max-src-size
[270.951656] Subtest intel-max-src-size: SKIP (0.001s)
[271.014906] [053/130] (753s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[271.073404] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[274.770034] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (3.695s)
[276.030580] [054/130] (748s left) kms_chamelium_frames (hdmi-crc-single)
[276.388838] Subtest hdmi-crc-single: SKIP (0.000s)
[277.268762] [055/130] (747s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[277.336112] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[277.337671] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[277.396095] [056/130] (747s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[277.458885] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[284.576504] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (7.116s)
[284.666061] [057/130] (740s left) gem_exec_flush (basic-wb-set-default)
[284.704584] Starting subtest: basic-wb-set-default
[290.124178] Subtest basic-wb-set-default: SUCCESS (5.404s)
[290.275704] [058/130] (734s left) gem_exec_suspend (basic-s3-devices)
[290.313300] Starting subtest: basic-S3-devices
[290.314511] Starting dynamic subtest: smem
[300.746104] Dynamic subtest smem: SUCCESS (10.431s)
[300.747798] Subtest basic-S3-devices: SUCCESS (10.432s)
[300.913034] [059/130] (724s left) gem_exec_alignment (single)
[300.948503] Starting subtest: single
[300.953379] Subtest single: SUCCESS (0.005s)
[301.016339] [060/130] (723s left) syncobj_basic (bad-destroy)
[301.044304] Starting subtest: bad-destroy
[301.045193] Subtest bad-destroy: SUCCESS (0.000s)
[301.095743] [061/130] (723s left) kms_psr (fbc-psr2-cursor-blt)
[301.154352] Starting subtest: fbc-psr2-cursor-blt
[301.155503] Starting dynamic subtest: eDP-1
[301.157065] Dynamic subtest eDP-1: SKIP (0.000s)
[301.158422] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[301.206689] [062/130] (723s left) gem_ctx_persistence (smoketest)
[301.242692] Starting subtest: smoketest
[332.030802] Subtest smoketest: SUCCESS (30.785s)
[332.090403] [063/130] (692s left) gem_ctx_shared (q-out-order)
[332.129966] Starting subtest: Q-out-order
[332.130957] Starting dynamic subtest: rcs0
[332.245144] Dynamic subtest rcs0: SUCCESS (0.111s)
[332.254933] Starting dynamic subtest: bcs0
[332.326484] Dynamic subtest bcs0: SUCCESS (0.083s)
[332.340658] Starting dynamic subtest: vcs0
[332.412975] Dynamic subtest vcs0: SUCCESS (0.085s)
[332.425577] Starting dynamic subtest: vecs0
[332.499895] Dynamic subtest vecs0: SUCCESS (0.085s)
[332.501273] Subtest Q-out-order: SUCCESS (0.370s)
[332.739805] [064/130] (692s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[332.769889] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[332.770913] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[332.823341] [065/130] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[332.888276] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[336.333591] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.445s)
[337.601704] [066/130] (687s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[341.063704] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[341.072441] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.007s)
[341.998214] [067/130] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[342.064280] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[342.066225] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[342.129957] [068/130] (682s left) gem_exec_suspend (basic-s3)
[342.168389] Starting subtest: basic-S3
[342.169443] Starting dynamic subtest: smem
[360.229600] Dynamic subtest smem: SUCCESS (2.660s)
[360.231271] Subtest basic-S3: SUCCESS (2.661s)
[360.395672] [069/130] (680s left) kms_psr (fbc-pr-primary-render)
[360.452270] Starting subtest: fbc-pr-primary-render
[360.459363] Subtest fbc-pr-primary-render: SKIP (0.000s)
[360.504450] [070/130] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[360.564140] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[360.566031] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[360.626307] [071/130] (679s left) gem_mmap_gtt (pf-nonblock)
[360.657776] Starting subtest: pf-nonblock
[360.659575] Subtest pf-nonblock: SUCCESS (0.003s)
[360.731224] [072/130] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[360.786029] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[366.084579] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (5.270s)
[366.171569] [073/130] (674s left) api_intel_allocator (standalone)
[366.202824] Starting subtest: standalone
[366.218081] Subtest standalone: SUCCESS (0.015s)
[366.298646] [074/130] (674s left) perf (oa-formats)
[366.422661] Starting subtest: oa-formats
[366.423502] Starting dynamic subtest: 0-rcs0
[366.438663] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[366.439466] Subtest oa-formats: SUCCESS (0.017s)
[366.463089] [075/130] (674s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[366.517131] Starting subtest: compare-crc-sanitycheck-nv12
[366.518005] Starting dynamic subtest: pipe-A-eDP-1
[367.153819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[367.172180] Starting dynamic subtest: pipe-B-eDP-1
[368.587632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[368.602387] Starting dynamic subtest: pipe-C-eDP-1
[369.971130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[369.972037] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.445s)
[370.909113] [076/130] (669s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[370.945098] Starting subtest: untiled-to-tiled
[370.947042] Subtest untiled-to-tiled: SKIP (0.001s)
[371.025951] [077/130] (669s left) gem_exec_gttfill (multigpu-basic)
[371.178481] Starting subtest: multigpu-basic
[384.920889] Subtest multigpu-basic: SUCCESS (13.725s)
[384.978977] [078/130] (655s left) kms_cursor_crc (cursor-sliding-512x170)
[385.090798] Starting subtest: cursor-sliding-512x170
[385.092777] Subtest cursor-sliding-512x170: SKIP (0.001s)
[385.157968] [079/130] (655s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[385.210703] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[385.212859] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[386.404257] [080/130] (654s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[386.456914] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[386.457716] Starting dynamic subtest: pipe-A
[387.672030] Dynamic subtest pipe-A: SUCCESS (1.215s)
[387.694992] Starting dynamic subtest: pipe-B
[388.950939] Dynamic subtest pipe-B: SUCCESS (1.277s)
[388.972148] Starting dynamic subtest: pipe-C
[390.219983] Dynamic subtest pipe-C: SUCCESS (1.267s)
[390.220929] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.762s)
[391.514368] [081/130] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[391.578032] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[391.579948] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[391.656112] [082/130] (649s left) gem_cs_tlb (engines)
[391.689945] Starting subtest: engines
[391.690780] Starting dynamic subtest: rcs0
[393.852819] Dynamic subtest rcs0: SUCCESS (2.152s)
[393.863157] Starting dynamic subtest: bcs0
[396.007443] Dynamic subtest bcs0: SUCCESS (2.152s)
[396.017174] Starting dynamic subtest: vcs0
[398.186510] Dynamic subtest vcs0: SUCCESS (2.153s)
[398.196285] Starting dynamic subtest: vecs0
[400.342055] Dynamic subtest vecs0: SUCCESS (2.153s)
[400.343391] Subtest engines: SUCCESS (8.613s)
[400.411715] [083/130] (640s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[400.477316] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[400.478902] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[400.544628] [084/130] (640s left) kms_content_protection (dp-mst-type-0)
[400.604008] Starting subtest: dp-mst-type-0
[400.606044] Subtest dp-mst-type-0: SKIP (0.000s)
[400.672370] [085/130] (640s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[400.725048] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[400.725970] Starting dynamic subtest: pipe-A-eDP-1
[400.733362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[400.752635] Starting dynamic subtest: pipe-B-eDP-1
[400.759723] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[400.770408] Starting dynamic subtest: pipe-C-eDP-1
[400.777182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[400.777943] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.008s)
[403.164619] [086/130] (637s left) gem_userptr_blits (input-checking)
[403.205604] Starting subtest: input-checking
[403.206323] Subtest input-checking: SUCCESS (0.000s)
[403.297704] [087/130] (637s left) prime_vgem (wait)
[403.331641] Starting subtest: wait
[403.332574] Starting dynamic subtest: rcs0
[403.363186] Dynamic subtest rcs0: SUCCESS (0.031s)
[403.380657] Starting dynamic subtest: bcs0
[403.403473] Dynamic subtest bcs0: SUCCESS (0.039s)
[403.419712] Starting dynamic subtest: vcs0
[403.443435] Dynamic subtest vcs0: SUCCESS (0.039s)
[403.458909] Starting dynamic subtest: vecs0
[403.486036] Dynamic subtest vecs0: SUCCESS (0.041s)
[403.487456] Subtest wait: SUCCESS (0.155s)
[403.580727] [088/130] (637s left) gem_exec_balancer (sliced)
[403.618182] Starting subtest: sliced
[403.619619] Subtest sliced: SKIP (0.000s)
[404.615520] [089/130] (636s left) kms_sequence (queue-busy)
[404.671380] Starting subtest: queue-busy
[404.673469] Starting dynamic subtest: pipe-A-eDP-1
[406.185225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.511s)
[406.194681] Starting dynamic subtest: pipe-B-eDP-1
[408.522321] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.334s)
[408.537708] Starting dynamic subtest: pipe-C-eDP-1
[410.836562] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.312s)
[410.837503] Subtest queue-busy: SUCCESS (6.162s)
[411.739359] [090/130] (629s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[411.799421] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[411.800456] Starting dynamic subtest: pipe-A-default-mode
[412.102173] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[412.103700] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.303s)
[413.020120] [091/130] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[413.091231] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[413.093063] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[413.163074] [092/130] (627s left) kms_hdr (bpc-switch-dpms)
[413.219530] Starting subtest: bpc-switch-dpms
[413.222148] Subtest bpc-switch-dpms: SKIP (0.001s)
[413.274804] [093/130] (627s left) i915_suspend (fence-restore-tiled2untiled)
[413.305224] Starting subtest: fence-restore-tiled2untiled
[433.027614] Subtest fence-restore-tiled2untiled: SUCCESS (4.318s)
[433.103082] [094/130] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[433.174163] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[433.175605] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[433.256493] [095/130] (623s left) gem_exec_flush (basic-uc-ro-default)
[433.289610] Starting subtest: basic-uc-ro-default
[438.725611] Subtest basic-uc-ro-default: SUCCESS (5.401s)
[438.883321] [096/130] (617s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[438.947434] Starting subtest: 4-tiled-64bpp-rotate-0
[438.948914] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[439.008220] [097/130] (617s left) vgem_basic (sysfs)
[439.043005] Starting subtest: sysfs
[439.044120] Subtest sysfs: SUCCESS (0.000s)
[439.076624] [098/130] (617s left) drm_read (empty-nonblock)
[439.169953] Starting subtest: empty-nonblock
[439.171019] Subtest empty-nonblock: SUCCESS (0.000s)
[439.261354] [099/130] (617s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[439.289448] Starting subtest: multi-wait-all-for-submit-submitted
[439.404646] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[439.455797] [100/130] (617s left) kms_big_fb (linear-64bpp-rotate-180)
[439.516676] Starting subtest: linear-64bpp-rotate-180
[441.457708] Subtest linear-64bpp-rotate-180: SUCCESS (1.936s)
[441.595778] [101/130] (615s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[441.648144] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[441.648969] Starting dynamic subtest: pipe-A-eDP-1
[441.656587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[441.675314] Starting dynamic subtest: pipe-B-eDP-1
[441.682228] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[441.692549] Starting dynamic subtest: pipe-C-eDP-1
[441.699372] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[441.700082] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SUCCESS (0.013s)
[444.078669] [102/130] (612s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[444.145679] Starting subtest: y-tiled-8bpp-rotate-180
[445.302100] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.155s)
[445.434331] [103/130] (611s left) perf_pmu (init-wait)
[445.466329] Starting subtest: init-wait
[445.467378] Starting dynamic subtest: rcs0
[445.468194] Dynamic subtest rcs0: SUCCESS (0.001s)
[445.482954] Starting dynamic subtest: bcs0
[445.483699] Dynamic subtest bcs0: SUCCESS (0.000s)
[445.493522] Starting dynamic subtest: vcs0
[445.494340] Dynamic subtest vcs0: SUCCESS (0.001s)
[445.503520] Starting dynamic subtest: vecs0
[445.504307] Dynamic subtest vecs0: SUCCESS (0.001s)
[445.505045] Subtest init-wait: SUCCESS (0.006s)
[445.519012] [104/130] (611s left) i915_pm_freq_api (freq-basic-api)
[445.552671] Starting subtest: freq-basic-api
[445.553802] Starting dynamic subtest: gt0
[445.557203] Dynamic subtest gt0: SUCCESS (0.004s)
[445.558140] Subtest freq-basic-api: SUCCESS (0.005s)
[445.632981] [105/130] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[445.694846] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[452.565879] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.864s)
[452.655114] [106/130] (604s left) kms_flip (2x-dpms-vs-vblank-race)
[452.714305] Starting subtest: 2x-dpms-vs-vblank-race
[452.719120] Subtest 2x-dpms-vs-vblank-race: SKIP (0.004s)
[452.778625] [107/130] (604s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[452.838358] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[458.451440] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (5.607s)
[458.548394] [108/130] (598s left) gem_spin_batch (resubmit-new)
[458.587611] Starting subtest: resubmit-new
[458.588582] Starting dynamic subtest: rcs0
[458.591858] Dynamic subtest rcs0: SUCCESS (0.005s)
[458.609188] Starting dynamic subtest: bcs0
[458.609973] Dynamic subtest bcs0: SUCCESS (0.005s)
[458.619022] Starting dynamic subtest: vcs0
[458.619796] Dynamic subtest vcs0: SUCCESS (0.004s)
[458.628599] Starting dynamic subtest: vecs0
[458.629334] Dynamic subtest vecs0: SUCCESS (0.004s)
[458.630053] Subtest resubmit-new: SUCCESS (0.021s)
[458.803913] [109/130] (598s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[458.860382] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[458.861276] Starting dynamic subtest: pipe-A
[458.894020] Dynamic subtest pipe-A: SKIP (0.031s)
[458.904349] Starting dynamic subtest: pipe-B
[458.955942] Dynamic subtest pipe-B: SKIP (0.062s)
[458.967002] Starting dynamic subtest: pipe-C
[459.019731] Dynamic subtest pipe-C: SKIP (0.062s)
[459.021102] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.157s)
[459.073527] [110/130] (597s left) gem_exec_params (cliprects_ptr-dirt)
[459.103880] Starting subtest: cliprects_ptr-dirt
[459.104739] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[459.171767] [111/130] (597s left) gem_exec_balancer (indices)
[459.207544] Starting subtest: indices
[460.065007] Subtest indices: SUCCESS (0.857s)
[461.069047] [112/130] (595s left) gem_exec_await (wide-all)
[461.130481] Starting subtest: wide-all
[482.835786] Subtest wide-all: SUCCESS (21.706s)
[483.021984] [113/130] (573s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[483.149985] Starting subtest: modeset-atomic-cursor-hotspot
[483.151900] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[483.249398] [114/130] (573s left) kms_vrr (flip-dpms)
[483.309405] Starting subtest: flip-dpms
[483.312298] Starting dynamic subtest: pipe-A-eDP-1
[497.171730] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.846s)
[497.461417] Subtest flip-dpms: SUCCESS (14.147s)
[498.348183] [115/130] (558s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[498.413846] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[502.375489] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.960s)
[503.621871] [116/130] (553s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[503.677082] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[503.677996] Starting dynamic subtest: pipe-A-eDP-1
[503.685545] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[503.704686] Starting dynamic subtest: pipe-B-eDP-1
[503.712038] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[503.722474] Starting dynamic subtest: pipe-C-eDP-1
[503.729819] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[503.731182] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s)
[506.159592] [117/130] (550s left) gem_exec_fair (basic-throttle)
[506.203251] Subtest basic-throttle: SKIP (0.000s)
[506.253140] [118/130] (550s left) kms_chamelium_audio (dp-audio-edid)
[506.604706] Subtest dp-audio-edid: SKIP (0.000s)
[507.475081] [119/130] (549s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[507.561792] Starting subtest: flip-vs-cursor-legacy
[514.084197] Subtest flip-vs-cursor-legacy: SUCCESS (6.520s)
[514.991865] [120/130] (542s left) gem_ppgtt (shrink-vs-evict-any)
[515.024898] Starting subtest: shrink-vs-evict-any
[522.810735] Subtest shrink-vs-evict-any: SUCCESS (7.774s)
[522.882122] [121/130] (534s left) device_reset (unbind-reset-rebind)
[522.922730] Starting subtest: unbind-reset-rebind
[526.763064] Subtest unbind-reset-rebind: SUCCESS (3.832s)
[526.778415] [122/130] (530s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[526.843517] Starting subtest: invalid-modeset-force-ultra-joiner
[526.845185] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[526.902928] [123/130] (530s left) gem_mmap_gtt (cpuset-big-copy)
[526.937534] Starting subtest: cpuset-big-copy
[537.786645] Subtest cpuset-big-copy: SUCCESS (10.852s)
[537.878393] [124/130] (519s left) gem_pxp (create-valid-protected-context)
[540.473641] Subtest create-valid-protected-context: SKIP (0.000s)
[540.527330] [125/130] (516s left) kms_pm_rpm (i2c)
[542.044594] Starting subtest: i2c
[548.381793] Subtest i2c: SUCCESS (6.338s)
[548.524018] [126/130] (508s left) gem_exec_schedule (thriceslice)
[548.564420] Starting subtest: thriceslice
[548.565231] Starting dynamic subtest: rcs0
[548.616996] Dynamic subtest rcs0: SUCCESS (0.051s)
[548.638538] Starting dynamic subtest: bcs0
[548.647407] Dynamic subtest bcs0: SUCCESS (0.029s)
[548.668761] Starting dynamic subtest: vcs0
[548.678561] Dynamic subtest vcs0: SUCCESS (0.029s)
[548.702599] Starting dynamic subtest: vecs0
[548.710355] Dynamic subtest vecs0: SUCCESS (0.030s)
[548.711809] Subtest thriceslice: SUCCESS (0.147s)
[548.998395] [127/130] (508s left) gen9_exec_parse (bb-secure)
[549.028749] Subtest bb-secure: SKIP (0.000s)
[549.060298] [128/130] (508s left) gem_userptr_blits (forbidden-operations)
[549.097235] Starting subtest: forbidden-operations
[549.098768] Subtest forbidden-operations: SKIP (0.000s)
[549.189070] [129/130] (508s left) syncobj_wait (invalid-single-wait-unsubmitted)
[549.220546] Starting subtest: invalid-single-wait-unsubmitted
[549.221528] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[549.275731] [130/130] (508s left) kms_psr (psr-cursor-render)
[549.329019] Starting subtest: psr-cursor-render
[549.330070] Starting dynamic subtest: eDP-1
[551.084984] Dynamic subtest eDP-1: SUCCESS (1.755s)
[551.085757] Subtest psr-cursor-render: SUCCESS (1.757s)
[551.980640] Closing watchdogs
Done.