[44.191681] Initializing watchdogs
[44.191747]   /dev/watchdog0
[44.199949] [001/138] (960s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[44.252854] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[44.364684] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[44.464757] [002/138] (960s left) i915_getparams_basic (basic-subslice-total)
[44.532557] Starting subtest: basic-subslice-total
[44.534413] Subtest basic-subslice-total: SUCCESS (0.000s)
[44.584948] [003/138] (960s left) kms_content_protection (uevent)
[46.595956] Starting subtest: uevent
[46.871527] Subtest uevent: SKIP (0.274s)
[47.020871] [004/138] (957s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[48.974525] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[48.979755] Starting dynamic subtest: pipe-A-HDMI-A-4
[49.129835] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.151s)
[49.141417] Starting dynamic subtest: pipe-B-HDMI-A-4
[49.290662] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.155s)
[49.299765] Starting dynamic subtest: pipe-C-HDMI-A-4
[49.412025] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.117s)
[49.420924] Starting dynamic subtest: pipe-D-HDMI-A-4
[49.534988] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.118s)
[49.535925] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.561s)
[49.653285] [005/138] (955s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[51.608057] Starting subtest: plane-downscale-factor-0-5-with-rotation
[51.610763] Starting dynamic subtest: pipe-A-HDMI-A-4
[51.765577] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.154s)
[51.781116] Starting dynamic subtest: pipe-B-HDMI-A-4
[51.925865] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.152s)
[51.932964] Starting dynamic subtest: pipe-C-HDMI-A-4
[52.045706] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.116s)
[52.053943] Starting dynamic subtest: pipe-D-HDMI-A-4
[52.151095] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.100s)
[52.155672] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.544s)
[52.281265] [006/138] (952s left) gem_exec_create (legacy)
[52.341535] Starting subtest: legacy
[52.342435] Starting dynamic subtest: smem
[54.442753] Dynamic subtest smem: SUCCESS (2.101s)
[54.448323] Starting dynamic subtest: lmem0
[56.540047] Dynamic subtest lmem0: SUCCESS (2.097s)
[56.541025] Subtest legacy: SUCCESS (4.198s)
[56.735608] [007/138] (948s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[58.691896] Starting subtest: psr-rgb565-draw-mmap-wc
[58.693992] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[58.767863] [008/138] (946s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[60.781571] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[60.784251] Starting dynamic subtest: pipe-A-valid-mode
[61.500185] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.718s)
[61.501084] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SUCCESS (0.719s)
[61.619563] [009/138] (943s left) prime_vgem (basic-fence-flip)
[61.728109] Starting subtest: basic-fence-flip
[63.653322] Subtest basic-fence-flip: SKIP (1.925s)
[63.742187] [010/138] (941s left) syncobj_wait (multi-wait-all-submitted)
[63.888959] Starting subtest: multi-wait-all-submitted
[63.994070] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[64.086275] [011/138] (940s left) gem_exec_whisper (basic-normal)
[64.182821] Starting subtest: basic-normal
[65.862743] Subtest basic-normal: SUCCESS (1.679s)
[66.043288] [012/138] (938s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[68.021288] Starting subtest: plane-primary-overlay-mutable-zpos
[69.094830] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.073s)
[69.225567] [013/138] (935s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[71.218866] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[71.269817] [014/138] (933s left) drm_fdinfo (isolation)
[71.319764] Starting subtest: isolation
[71.320753] Starting dynamic subtest: rcs0
[71.322668] Dynamic subtest rcs0: SKIP (0.000s)
[71.327994] Starting dynamic subtest: bcs0
[71.329810] Dynamic subtest bcs0: SKIP (0.000s)
[71.334723] Starting dynamic subtest: vcs0
[71.337229] Dynamic subtest vcs0: SKIP (0.000s)
[71.342392] Starting dynamic subtest: vcs1
[71.344636] Dynamic subtest vcs1: SKIP (0.000s)
[71.349801] Starting dynamic subtest: vecs0
[71.352153] Dynamic subtest vecs0: SKIP (0.000s)
[71.353921] Subtest isolation: SKIP (0.001s)
[71.374728] [015/138] (933s left) gem_exec_suspend (basic)
[71.430950] Starting subtest: basic
[71.431950] Starting dynamic subtest: smem
[72.555826] Dynamic subtest smem: SUCCESS (1.125s)
[72.563909] Starting dynamic subtest: lmem0
[73.627339] Dynamic subtest lmem0: SUCCESS (1.071s)
[73.628222] Subtest basic: SUCCESS (2.196s)
[73.810879] [016/138] (931s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[75.770624] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[75.772684] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[75.843497] [017/138] (929s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[77.886666] Starting subtest: psr-shrfb-scaledprimary
[77.888261] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[77.960844] [018/138] (927s left) kms_psr (psr2_cursor_render)
[78.065379] Subtest psr2_cursor_render: SKIP (0.000s)
[78.100617] [019/138] (926s left) syncobj_timeline (invalid-wait-illegal-handle)
[78.156498] Starting subtest: invalid-wait-illegal-handle
[78.157459] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[78.214297] [020/138] (926s left) kms_cursor_crc (cursor-random-128x128)
[80.301980] Starting subtest: cursor-random-128x128
[80.309201] Starting dynamic subtest: pipe-A-HDMI-A-4
[84.896313] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.588s)
[84.919555] Starting dynamic subtest: pipe-D-HDMI-A-4
[89.356794] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.441s)
[89.357838] Subtest cursor-random-128x128: SUCCESS (9.055s)
[89.657278] [021/138] (915s left) gem_mmap_gtt (big-bo-tiledy)
[89.708226] Subtest big-bo-tiledY: SKIP (0.000s)
[89.732299] [022/138] (915s left) kms_flip (2x-dpms-vs-vblank-race)
[90.741026] Starting subtest: 2x-dpms-vs-vblank-race
[90.766044] Subtest 2x-dpms-vs-vblank-race: SKIP (0.025s)
[90.839017] [023/138] (914s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-rc-ccs)
[92.878995] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs
[92.882569] Subtest pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[93.053721] [024/138] (912s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-rc-ccs)
[95.162014] Starting subtest: pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs
[95.163818] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[95.268172] [025/138] (909s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-mtl-rc-ccs)
[97.288570] Starting subtest: pipe-A-random-ccs-data-4-tiled-mtl-rc-ccs
[97.291043] Subtest pipe-A-random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[97.501773] [026/138] (907s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[97.554294] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[97.555306] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[97.660047] [027/138] (907s left) gen7_exec_parse (cmd-crossing-page)
[97.742303] Subtest cmd-crossing-page: SKIP (0.000s)
[97.779211] [028/138] (907s left) gem_pxp (create-valid-protected-context)
[100.366280] Subtest create-valid-protected-context: SKIP (0.000s)
[100.426346] [029/138] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[102.383729] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[102.385554] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[102.454307] [030/138] (902s left) kms_cursor_edge_walk (64x64-top-bottom)
[104.484494] Starting subtest: 64x64-top-bottom
[104.485400] Starting dynamic subtest: pipe-A-HDMI-A-4
[107.767908] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.282s)
[107.774262] Starting dynamic subtest: pipe-D-HDMI-A-4
[110.970086] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.200s)
[110.970982] Subtest 64x64-top-bottom: SUCCESS (6.486s)
[111.094121] [031/138] (894s left) kms_vblank (wait-forked-hang)
[113.050521] Starting subtest: wait-forked-hang
[113.053138] Starting dynamic subtest: pipe-A-HDMI-A-4
[126.898475] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (13.846s)
[126.906866] Starting dynamic subtest: pipe-D-HDMI-A-4
[151.839961] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.937s)
[151.840968] Subtest wait-forked-hang: SUCCESS (38.790s)
[151.949586] [032/138] (853s left) kms_flip (dpms-off-confusion-interruptible)
[152.959510] Starting subtest: dpms-off-confusion-interruptible
[152.970980] Starting dynamic subtest: A-HDMI-A4
[160.688419] Dynamic subtest A-HDMI-A4: SUCCESS (7.717s)
[160.694740] Starting dynamic subtest: B-HDMI-A4
[168.345757] Dynamic subtest B-HDMI-A4: SUCCESS (7.655s)
[168.354854] Starting dynamic subtest: C-HDMI-A4
[176.001398] Dynamic subtest C-HDMI-A4: SUCCESS (7.652s)
[176.014438] Starting dynamic subtest: D-HDMI-A4
[183.654952] Dynamic subtest D-HDMI-A4: SUCCESS (7.651s)
[183.655997] Subtest dpms-off-confusion-interruptible: SUCCESS (30.695s)
[183.792655] [033/138] (821s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-mc-ccs)
[185.859840] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-mc-ccs
[185.861467] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[186.008233] [034/138] (819s left) kms_sequence (get-busy)
[187.956758] Starting subtest: get-busy
[187.957847] Starting dynamic subtest: pipe-A-HDMI-A-4
[190.466174] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.508s)
[190.473601] Starting dynamic subtest: pipe-B-HDMI-A-4
[192.832850] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.364s)
[192.838101] Starting dynamic subtest: pipe-C-HDMI-A-4
[195.214055] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.380s)
[195.219470] Starting dynamic subtest: pipe-D-HDMI-A-4
[197.601808] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.386s)
[197.602730] Subtest get-busy: SUCCESS (9.645s)
[197.720171] [035/138] (807s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[199.673541] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[199.676241] Starting dynamic subtest: pipe-A-valid-mode
[200.593810] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.917s)
[200.595052] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.919s)
[200.704356] [036/138] (804s left) gem_tiled_swapping (non-threaded)
[200.754914] Subtest non-threaded: SKIP (0.000s)
[200.780780] [037/138] (804s left) gem_exec_schedule (u-semaphore-noskip)
[200.842108] Starting subtest: u-semaphore-noskip
[201.261160] Subtest u-semaphore-noskip: SUCCESS (0.415s)
[201.602866] [038/138] (803s left) kms_prop_blob (invalid-set-prop-any)
[201.648636] Starting subtest: invalid-set-prop-any
[201.649481] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[201.705445] [039/138] (803s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[203.665614] Starting subtest: fbcpsr-slowdraw
[203.667389] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[203.742314] [040/138] (801s left) kms_flip (2x-flip-vs-modeset)
[204.827331] Starting subtest: 2x-flip-vs-modeset
[204.850711] Subtest 2x-flip-vs-modeset: SKIP (0.025s)
[204.923839] [041/138] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[206.938029] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[206.940178] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[207.026598] [042/138] (798s left) api_intel_bb (reset-flags)
[207.163075] Starting subtest: reset-flags
[207.186377] Subtest reset-flags: SUCCESS (0.024s)
[207.306617] [043/138] (798s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[209.300113] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[212.040429] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.742s)
[212.182860] [044/138] (793s left) syncobj_timeline (wait-all-for-submit-snapshot)
[212.239194] Starting subtest: wait-all-for-submit-snapshot
[212.322247] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[212.406640] [045/138] (793s left) gem_exec_flush (basic-uc-ro-default)
[212.467169] Subtest basic-uc-ro-default: SKIP (0.000s)
[212.515358] [046/138] (792s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[214.548747] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[214.550673] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[214.752879] [047/138] (790s left) gem_ctx_persistence (hostile)
[214.810632] Starting subtest: hostile
[224.926594] Subtest hostile: SUCCESS (10.110s)
[225.020088] [048/138] (780s left) perf (invalid-oa-format-id)
[225.135304] Starting subtest: invalid-oa-format-id
[225.155423] Subtest invalid-oa-format-id: SUCCESS (0.019s)
[225.183435] [049/138] (780s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-mc-ccs)
[227.283725] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-mc-ccs
[227.285601] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[227.400872] [050/138] (778s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[229.356154] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[230.359501] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.004s)
[230.485220] [051/138] (775s left) kms_content_protection (dp-mst-type-0)
[232.495304] Starting subtest: dp-mst-type-0
[232.497302] Subtest dp-mst-type-0: SKIP (0.000s)
[232.594595] [052/138] (773s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[237.377805] Starting subtest: gem-execbuf-stress-pc8
[237.450928] Subtest gem-execbuf-stress-pc8: SKIP (0.071s)
[238.529930] [053/138] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[240.504360] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[240.506159] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[240.606117] [054/138] (765s left) syncobj_timeline (single-wait-available-submitted)
[240.748923] Starting subtest: single-wait-available-submitted
[240.749786] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[240.813684] [055/138] (764s left) kms_lease (multimaster-lease)
[242.776718] Starting subtest: multimaster-lease
[242.779751] Subtest multimaster-lease: SUCCESS (0.003s)
[242.848577] [056/138] (762s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[243.888108] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[243.898670] Starting dynamic subtest: A-HDMI-A4
[244.644205] Dynamic subtest A-HDMI-A4: SUCCESS (0.746s)
[244.649914] Starting dynamic subtest: B-HDMI-A4
[245.278980] Dynamic subtest B-HDMI-A4: SUCCESS (0.634s)
[245.285034] Starting dynamic subtest: C-HDMI-A4
[245.910291] Dynamic subtest C-HDMI-A4: SUCCESS (0.629s)
[245.915810] Starting dynamic subtest: D-HDMI-A4
[246.539163] Dynamic subtest D-HDMI-A4: SUCCESS (0.629s)
[246.540112] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.652s)
[246.663817] [057/138] (759s left) gem_tiled_pread_basic
[246.740254] [058/138] (758s left) sysfs_preempt_timeout (invalid)
[246.796567] Starting subtest: invalid
[246.797666] Starting dynamic subtest: vecs0
[246.798763] Dynamic subtest vecs0: SUCCESS (0.000s)
[246.804972] Starting dynamic subtest: vcs0
[246.806121] Dynamic subtest vcs0: SUCCESS (0.000s)
[246.811985] Starting dynamic subtest: bcs0
[246.814566] Dynamic subtest bcs0: SUCCESS (0.000s)
[246.836100] Starting dynamic subtest: rcs0
[246.838104] Dynamic subtest rcs0: SUCCESS (0.001s)
[246.852942] Starting dynamic subtest: vcs1
[246.854410] Dynamic subtest vcs1: SUCCESS (0.000s)
[246.855831] Subtest invalid: SUCCESS (0.008s)
[246.874215] [059/138] (758s left) gem_exec_fence (syncobj-timeline-unused-fence)
[247.484841] Starting subtest: syncobj-timeline-unused-fence
[247.500364] Subtest syncobj-timeline-unused-fence: SUCCESS (0.019s)
[247.748216] [060/138] (758s left) syncobj_wait (single-wait-for-submit-submitted)
[247.796094] Starting subtest: single-wait-for-submit-submitted
[247.900109] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[247.980200] [061/138] (757s left) gem_vm_create (create-ext)
[248.030365] Starting subtest: create-ext
[248.034226] Subtest create-ext: SUCCESS (0.004s)
[248.135572] [062/138] (757s left) gem_mmap_offset (bad-flags)
[248.194754] Starting subtest: bad-flags
[248.195668] Subtest bad-flags: SUCCESS (0.000s)
[248.315740] [063/138] (757s left) gem_exec_reloc (basic-gtt-read-noreloc)
[248.405834] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[248.458600] [064/138] (757s left) perf_pmu (module-unload)
[248.530947] Starting subtest: module-unload
[291.198022] Subtest module-unload: SUCCESS (42.664s)
[291.211747] [065/138] (714s left) gem_userptr_blits (access-control)
[292.706401] Starting subtest: access-control
[292.707927] Subtest access-control: SKIP (0.000s)
[294.595859] [066/138] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[296.559291] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[296.561149] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[296.653721] [067/138] (709s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[298.778069] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[298.780178] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[298.979708] [068/138] (706s left) gem_exec_capture (capture)
[299.030972] Starting subtest: capture
[299.031972] Starting dynamic subtest: rcs0-smem
[299.884916] Dynamic subtest rcs0-smem: SUCCESS (0.852s)
[299.891315] Starting dynamic subtest: rcs0-lmem0
[301.227471] Dynamic subtest rcs0-lmem0: SUCCESS (1.341s)
[301.233454] Starting dynamic subtest: bcs0-smem
[302.070420] Dynamic subtest bcs0-smem: SUCCESS (0.842s)
[302.076405] Starting dynamic subtest: bcs0-lmem0
[303.422388] Dynamic subtest bcs0-lmem0: SUCCESS (1.350s)
[303.428323] Starting dynamic subtest: vcs0-smem
[304.274539] Dynamic subtest vcs0-smem: SUCCESS (0.850s)
[304.280495] Starting dynamic subtest: vcs0-lmem0
[305.133320] Dynamic subtest vcs0-lmem0: SUCCESS (0.858s)
[305.139233] Starting dynamic subtest: vcs1-smem
[305.985911] Dynamic subtest vcs1-smem: SUCCESS (0.853s)
[305.993437] Starting dynamic subtest: vcs1-lmem0
[307.347797] Dynamic subtest vcs1-lmem0: SUCCESS (1.360s)
[307.353811] Starting dynamic subtest: vecs0-smem
[308.201881] Dynamic subtest vecs0-smem: SUCCESS (0.854s)
[308.209324] Starting dynamic subtest: vecs0-lmem0
[309.563336] Dynamic subtest vecs0-lmem0: SUCCESS (1.360s)
[309.564240] Subtest capture: SUCCESS (10.532s)
[309.675563] [069/138] (696s left) gem_exec_schedule (preempt-other)
[309.736419] Starting subtest: preempt-other
[309.737332] Starting dynamic subtest: rcs0
[309.855340] Dynamic subtest rcs0: SUCCESS (0.118s)
[309.861525] Starting dynamic subtest: bcs0
[309.958317] Dynamic subtest bcs0: SUCCESS (0.102s)
[309.964664] Starting dynamic subtest: vcs0
[310.060428] Dynamic subtest vcs0: SUCCESS (0.101s)
[310.067751] Starting dynamic subtest: vcs1
[310.163602] Dynamic subtest vcs1: SUCCESS (0.102s)
[310.169627] Starting dynamic subtest: vecs0
[310.265791] Dynamic subtest vecs0: SUCCESS (0.101s)
[310.266738] Subtest preempt-other: SUCCESS (0.530s)
[310.673814] [070/138] (695s left) vc4/vc4_wait_bo (unused-bo-0ns)
[310.746735] Subtest unused-bo-0ns: SKIP (0.000s)
[310.797102] [071/138] (695s left) gem_eio (kms)
[312.877732] Starting subtest: kms
[329.925400] Subtest kms: FAIL (16.998s)
[330.045812] [072/138] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[332.019396] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[332.021311] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[332.094359] [073/138] (673s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs)
[334.207967] Starting subtest: pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs
[334.210552] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[334.312171] [074/138] (671s left) prime_vgem (sync)
[334.368409] Starting subtest: sync
[334.369292] Starting dynamic subtest: rcs0
[334.423422] Dynamic subtest rcs0: SUCCESS (0.054s)
[334.434018] Starting dynamic subtest: bcs0
[334.467682] Dynamic subtest bcs0: SUCCESS (0.042s)
[334.481396] Starting dynamic subtest: vcs0
[334.510464] Dynamic subtest vcs0: SUCCESS (0.040s)
[334.536349] Starting dynamic subtest: vcs1
[334.554608] Dynamic subtest vcs1: SUCCESS (0.040s)
[334.579254] Starting dynamic subtest: vecs0
[334.594949] Dynamic subtest vecs0: SUCCESS (0.037s)
[334.596235] Subtest sync: SUCCESS (0.227s)
[334.744332] [075/138] (671s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[336.824202] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[336.826303] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[336.979112] [076/138] (669s left) kms_pm_rpm (pm-caching)
[341.406193] Starting subtest: pm-caching
[341.410638] Subtest pm-caching: SKIP (0.000s)
[342.575327] [077/138] (663s left) gem_ctx_sseu (invalid-args)
[342.640023] Subtest invalid-args: SKIP (0.000s)
[342.667843] [078/138] (663s left) gem_tiled_pread_pwrite
[342.767670] [079/138] (663s left) gem_mmap_gtt (fault-concurrent-x)
[342.828237] Subtest fault-concurrent-X: SKIP (0.000s)
[342.850225] [080/138] (663s left) v3d/v3d_submit_cl (bad-perfmon)
[342.940304] Subtest bad-perfmon: SKIP (0.000s)
[342.990740] [081/138] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[344.960156] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[344.962139] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[345.069675] [082/138] (661s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-rc-ccs)
[347.203529] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs
[347.205502] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[347.407607] [083/138] (658s left) syncobj_wait (invalid-reset-one-illegal-handle)
[347.459031] Starting subtest: invalid-reset-one-illegal-handle
[347.459926] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[347.558160] [084/138] (658s left) kms_rotation_crc (sprite-rotation-180)
[349.536920] Starting subtest: sprite-rotation-180
[357.485707] Subtest sprite-rotation-180: SUCCESS (7.949s)
[357.667918] [085/138] (648s left) kms_ccs (pipe-b-crc-primary-basic-yf-tiled-ccs)
[359.714595] Starting subtest: pipe-B-crc-primary-basic-yf-tiled-ccs
[359.716557] Subtest pipe-B-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[359.901848] [086/138] (646s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[361.868735] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[361.870942] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[361.938627] [087/138] (644s left) gem_userptr_blits (relocations)
[362.039775] Starting subtest: relocations
[362.042482] Subtest relocations: SKIP (0.001s)
[362.198095] [088/138] (644s left) gen3_render_tiledy_blits
[362.310609] [089/138] (644s left) kms_pm_rpm (dpms-non-lpsp)
[367.432098] Starting subtest: dpms-non-lpsp
[367.522424] Subtest dpms-non-lpsp: SUCCESS (0.091s)
[368.638438] [090/138] (637s left) gem_exec_params (invalid-bsd2-flag-on-render)
[368.735240] Starting subtest: invalid-bsd2-flag-on-render
[368.738595] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[368.847146] [091/138] (637s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[368.932114] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[368.933050] Starting dynamic subtest: smem
[369.024699] Dynamic subtest smem: SUCCESS (0.092s)
[369.031738] Starting dynamic subtest: lmem0
[370.141997] Dynamic subtest lmem0: SUCCESS (1.113s)
[370.142849] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.207s)
[370.382815] [092/138] (636s left) drm_read (short-buffer-wakeup)
[372.405905] Starting subtest: short-buffer-wakeup
[404.620430] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[404.766310] [093/138] (601s left) gem_create (create-ext-cpu-access-big)
[404.978247] Starting subtest: create-ext-cpu-access-big
[406.121247] Subtest create-ext-cpu-access-big: SUCCESS (1.144s)
[406.267207] [094/138] (600s left) kms_ccs (pipe-c-random-ccs-data-y-tiled-ccs)
[408.374409] Starting subtest: pipe-C-random-ccs-data-y-tiled-ccs
[408.377079] Subtest pipe-C-random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[408.517304] [095/138] (598s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-rc-ccs)
[410.543753] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs
[410.652562] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-rc-ccs: SUCCESS (0.108s)
[410.913834] [096/138] (595s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[412.870065] Starting subtest: flip-vs-cursor-varying-size
[422.599614] Subtest flip-vs-cursor-varying-size: SUCCESS (9.732s)
[422.717863] [097/138] (583s left) kms_big_fb (x-tiled-addfb-size-overflow)
[424.679918] Starting subtest: x-tiled-addfb-size-overflow
[424.681071] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[424.774962] [098/138] (581s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[424.928498] Starting subtest: yf-tiled-ccs-to-yf-tiled
[424.929494] Starting dynamic subtest: smem
[425.034206] Dynamic subtest smem: SUCCESS (0.103s)
[425.043307] Starting dynamic subtest: lmem0
[425.971165] Dynamic subtest lmem0: SUCCESS (0.934s)
[425.972079] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (1.040s)
[426.190257] [099/138] (580s left) i915_module_load (reload)
[426.237935] Starting subtest: reload
[431.026537] Subtest reload: SUCCESS (4.789s)
[431.041526] [100/138] (575s left) kms_atomic_interruptible (legacy-pageflip)
[433.046762] Starting subtest: legacy-pageflip
[433.047745] Starting dynamic subtest: pipe-A-HDMI-A-4
[439.257795] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.209s)
[439.258716] Subtest legacy-pageflip: SUCCESS (6.211s)
[439.366305] [101/138] (567s left) gem_render_copy (x-tiled)
[439.418269] Starting subtest: x-tiled
[439.419177] Starting dynamic subtest: smem
[439.499827] Dynamic subtest smem: SUCCESS (0.081s)
[439.507122] Starting dynamic subtest: lmem0
[440.263915] Dynamic subtest lmem0: SUCCESS (0.760s)
[440.264967] Subtest x-tiled: SUCCESS (0.843s)
[440.469783] [102/138] (566s left) gem_ctx_exec (basic-norecovery)
[440.519876] Starting subtest: basic-norecovery
[440.687492] Subtest basic-norecovery: SUCCESS (0.167s)
[440.819958] [103/138] (565s left) gem_userptr_blits (unsync-unmap-after-close)
[440.904300] Subtest unsync-unmap-after-close: SKIP (0.000s)
[441.045860] [104/138] (565s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[442.997992] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[443.000823] Starting dynamic subtest: pipe-A-valid-mode
[443.039098] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s)
[443.041056] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.040s)
[443.124835] [105/138] (563s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[445.097139] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[445.099209] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[445.159415] [106/138] (561s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[447.203054] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[447.204892] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[447.278336] [107/138] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[449.314883] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[449.316967] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[449.418929] [108/138] (557s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-mc-ccs)
[451.653332] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs
[451.656499] Subtest pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[451.757209] [109/138] (555s left) syncobj_wait (invalid-wait-illegal-handle)
[451.805987] Starting subtest: invalid-wait-illegal-handle
[451.806829] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[451.887368] [110/138] (555s left) kms_hdr (bpc-switch-suspend)
[453.874073] Starting subtest: bpc-switch-suspend
[453.876135] Subtest bpc-switch-suspend: SKIP (0.000s)
[453.943167] [111/138] (552s left) gem_exec_reloc (basic-wc-cpu)
[454.040847] Subtest basic-wc-cpu: SKIP (0.000s)
[454.108199] [112/138] (552s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[456.115624] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[456.168568] [113/138] (550s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[458.132701] Starting subtest: 4-tiled-64bpp-rotate-90
[458.135037] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[458.212500] [114/138] (548s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[460.251290] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[460.253382] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[460.350026] [115/138] (546s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[462.406818] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[463.591721] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.185s)
[463.725948] [116/138] (543s left) gem_exec_gttfill (all-engines)
[463.820378] Starting subtest: all-engines
[490.929400] Subtest all-engines: SUCCESS (27.106s)
[491.171137] [117/138] (515s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[493.311096] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[493.314348] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[493.440656] [118/138] (513s left) v3d/v3d_wait_bo (unused-bo-0ns)
[493.540799] Subtest unused-bo-0ns: SKIP (0.000s)
[493.593110] [119/138] (513s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[495.560525] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[495.562799] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[495.627153] [120/138] (511s left) vc4/vc4_create_bo (create-bo-0)
[495.758176] Subtest create-bo-0: SKIP (0.000s)
[495.807517] [121/138] (511s left) perf (global-sseu-config-invalid)
[495.941943] Starting subtest: global-sseu-config-invalid
[495.943043] Starting dynamic subtest: 0-rcs0
[495.956273] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[495.957359] Subtest global-sseu-config-invalid: SUCCESS (0.016s)
[495.991418] [122/138] (511s left) gem_partial_pwrite_pread (reads)
[496.053819] Subtest reads: SKIP (0.000s)
[496.129653] [123/138] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[498.118291] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[498.120127] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[498.195115] [124/138] (509s left) kms_lease (atomic-implicit-crtc)
[500.242362] Starting subtest: atomic-implicit-crtc
[500.246393] Starting dynamic subtest: pipe-A-HDMI-A-4
[500.247591] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[500.255672] Starting dynamic subtest: pipe-B-HDMI-A-4
[500.256705] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.006s)
[500.264524] Starting dynamic subtest: pipe-C-HDMI-A-4
[500.265536] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.006s)
[500.273343] Starting dynamic subtest: pipe-D-HDMI-A-4
[500.274410] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.006s)
[500.275534] Subtest atomic-implicit-crtc: SUCCESS (0.028s)
[500.361584] [125/138] (506s left) api_intel_allocator (two-level-inception)
[500.474284] Starting subtest: two-level-inception
[505.909332] Subtest two-level-inception: SUCCESS (5.432s)
[506.001989] [126/138] (501s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[508.057480] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[508.059576] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[508.148972] [127/138] (499s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[510.227270] Starting subtest: fbc-rgb565-draw-mmap-gtt
[510.229411] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[510.313332] [128/138] (497s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[512.352775] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[513.005572] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.652s)
[513.192481] [129/138] (494s left) i915_query (test-query-geometry-subslices)
[513.274558] Starting subtest: test-query-geometry-subslices
[513.276264] Subtest test-query-geometry-subslices: SKIP (0.000s)
[513.343182] [130/138] (494s left) gem_flink_basic (double-flink)
[513.391173] Starting subtest: double-flink
[513.392017] Subtest double-flink: SUCCESS (0.000s)
[513.500886] [131/138] (493s left) gem_ctx_param (invalid-param-get)
[513.557979] Starting subtest: invalid-param-get
[513.558893] Subtest invalid-param-get: SUCCESS (0.001s)
[513.649136] [132/138] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[515.616365] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[515.618356] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[515.714809] [133/138] (491s left) kms_plane_multiple (tiling-x)
[517.773736] Starting subtest: tiling-x
[517.776750] Starting dynamic subtest: pipe-A-HDMI-A-4
[518.629112] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.853s)
[518.638302] Starting dynamic subtest: pipe-B-HDMI-A-4
[519.314338] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.683s)
[519.323573] Starting dynamic subtest: pipe-C-HDMI-A-4
[519.969932] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.653s)
[519.979132] Starting dynamic subtest: pipe-D-HDMI-A-4
[520.619563] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.648s)
[520.620390] Subtest tiling-x: SUCCESS (2.846s)
[520.733657] [134/138] (486s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[522.767487] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[522.771627] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[522.969993] [135/138] (484s left) gem_exec_reloc (basic-write-read-noreloc)
[523.023605] Subtest basic-write-read-noreloc: SKIP (0.000s)
[523.079685] [136/138] (484s left) gem_lmem_swapping (parallel-random-verify-ccs)
[526.878267] Starting subtest: parallel-random-verify-ccs
[526.879079] Starting dynamic subtest: lmem0
[526.880896] Dynamic subtest lmem0: SKIP (0.000s)
[526.882623] Subtest parallel-random-verify-ccs: SKIP (0.001s)
[528.936768] [137/138] (478s left) prime_vgem (fence-read-hang)
[531.409094] Subtest fence-read-hang: SKIP (0.000s)
[532.371240] [138/138] (475s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[532.422986] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[532.532065] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[532.643676] Closing watchdogs
Done.