[41.552174] Initializing watchdogs
[41.552228]   /dev/watchdog0
[41.558084] [001/143] (960s left) kms_async_flips (async-flip-with-page-flip-events)
[43.552017] Starting subtest: async-flip-with-page-flip-events
[43.698448] Starting dynamic subtest: pipe-A-HDMI-A-2-4-mc-ccs
[43.962011] Dynamic subtest pipe-A-HDMI-A-2-4-mc-ccs: SKIP (0.263s)
[43.966562] Starting dynamic subtest: pipe-A-HDMI-A-2-4-rc-ccs-cc
[44.111894] Dynamic subtest pipe-A-HDMI-A-2-4-rc-ccs-cc: SKIP (0.150s)
[44.116364] Starting dynamic subtest: pipe-A-HDMI-A-2-4-rc-ccs
[44.245849] Dynamic subtest pipe-A-HDMI-A-2-4-rc-ccs: SKIP (0.134s)
[44.250168] Starting dynamic subtest: pipe-A-HDMI-A-2-4
[46.354213] Dynamic subtest pipe-A-HDMI-A-2-4: SUCCESS (2.109s)
[46.359369] Starting dynamic subtest: pipe-A-HDMI-A-2-x
[48.504059] Dynamic subtest pipe-A-HDMI-A-2-x: SUCCESS (2.150s)
[48.508555] Starting dynamic subtest: pipe-A-HDMI-A-2-linear
[50.654982] Dynamic subtest pipe-A-HDMI-A-2-linear: SUCCESS (2.150s)
[50.790666] Starting dynamic subtest: pipe-B-HDMI-A-2-4-mc-ccs
[50.956565] Dynamic subtest pipe-B-HDMI-A-2-4-mc-ccs: SKIP (0.169s)
[50.961166] Starting dynamic subtest: pipe-B-HDMI-A-2-4-rc-ccs-cc
[51.088624] Dynamic subtest pipe-B-HDMI-A-2-4-rc-ccs-cc: SKIP (0.132s)
[51.093142] Starting dynamic subtest: pipe-B-HDMI-A-2-4-rc-ccs
[51.224534] Dynamic subtest pipe-B-HDMI-A-2-4-rc-ccs: SKIP (0.135s)
[51.229083] Starting dynamic subtest: pipe-B-HDMI-A-2-4
[53.332296] Dynamic subtest pipe-B-HDMI-A-2-4: SUCCESS (2.109s)
[53.336849] Starting dynamic subtest: pipe-B-HDMI-A-2-x
[55.465505] Dynamic subtest pipe-B-HDMI-A-2-x: SUCCESS (2.133s)
[55.470321] Starting dynamic subtest: pipe-B-HDMI-A-2-linear
[57.600034] Dynamic subtest pipe-B-HDMI-A-2-linear: SUCCESS (2.134s)
[57.719044] Starting dynamic subtest: pipe-C-HDMI-A-2-4-mc-ccs
[57.865537] Dynamic subtest pipe-C-HDMI-A-2-4-mc-ccs: SKIP (0.149s)
[57.870501] Starting dynamic subtest: pipe-C-HDMI-A-2-4-rc-ccs-cc
[58.011344] Dynamic subtest pipe-C-HDMI-A-2-4-rc-ccs-cc: SKIP (0.147s)
[58.016276] Starting dynamic subtest: pipe-C-HDMI-A-2-4-rc-ccs
[58.163783] Dynamic subtest pipe-C-HDMI-A-2-4-rc-ccs: SKIP (0.150s)
[58.168460] Starting dynamic subtest: pipe-C-HDMI-A-2-4
[60.288243] Dynamic subtest pipe-C-HDMI-A-2-4: SUCCESS (2.127s)
[60.293057] Starting dynamic subtest: pipe-C-HDMI-A-2-x
[62.421385] Dynamic subtest pipe-C-HDMI-A-2-x: SUCCESS (2.133s)
[62.426148] Starting dynamic subtest: pipe-C-HDMI-A-2-linear
[64.556076] Dynamic subtest pipe-C-HDMI-A-2-linear: SUCCESS (2.134s)
[64.668206] Starting dynamic subtest: pipe-D-HDMI-A-2-4-mc-ccs
[64.813134] Dynamic subtest pipe-D-HDMI-A-2-4-mc-ccs: SKIP (0.147s)
[64.818020] Starting dynamic subtest: pipe-D-HDMI-A-2-4-rc-ccs-cc
[64.944399] Dynamic subtest pipe-D-HDMI-A-2-4-rc-ccs-cc: SKIP (0.132s)
[64.949051] Starting dynamic subtest: pipe-D-HDMI-A-2-4-rc-ccs
[65.078542] Dynamic subtest pipe-D-HDMI-A-2-4-rc-ccs: SKIP (0.134s)
[65.083067] Starting dynamic subtest: pipe-D-HDMI-A-2-4
[67.187985] Dynamic subtest pipe-D-HDMI-A-2-4: SUCCESS (2.111s)
[67.192801] Starting dynamic subtest: pipe-D-HDMI-A-2-x
[69.304724] Dynamic subtest pipe-D-HDMI-A-2-x: SUCCESS (2.117s)
[69.309644] Starting dynamic subtest: pipe-D-HDMI-A-2-linear
[71.438325] Dynamic subtest pipe-D-HDMI-A-2-linear: SUCCESS (2.133s)
[71.439729] Subtest async-flip-with-page-flip-events: SUCCESS (27.886s)
[71.729225] [002/143] (930s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[73.684456] Starting subtest: modeset-atomic-cursor-hotspot
[73.686292] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[73.744348] [003/143] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[75.708145] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[75.709751] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[75.779762] [004/143] (926s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-ccs)
[77.847436] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-ccs
[77.849213] Subtest pipe-B-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[77.977237] [005/143] (924s left) gem_exec_balancer (nohangcheck)
[78.288673] Starting subtest: nohangcheck
[79.143116] Subtest nohangcheck: SUCCESS (0.857s)
[79.257453] [006/143] (922s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[81.295964] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[81.721191] Subtest pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (0.425s)
[81.910995] [007/143] (920s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[84.023910] Starting subtest: cursor-rapid-movement-512x170
[84.026698] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[84.132415] [008/143] (918s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[84.215997] Starting subtest: yf-tiled-ccs-to-y-tiled
[84.218083] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[84.397810] [009/143] (917s left) v3d/v3d_wait_bo (bad-bo)
[84.512823] Subtest bad-bo: SKIP (0.000s)
[84.557782] [010/143] (917s left) gem_lmem_swapping (smem-oom)
[89.620104] Starting subtest: smem-oom
[89.620936] Starting dynamic subtest: lmem0
[109.779463] Dynamic subtest lmem0: SUCCESS (20.158s)
[109.780413] Subtest smem-oom: SUCCESS (20.160s)
[110.893161] [011/143] (891s left) gem_softpin (allocator-basic)
[114.470863] Starting subtest: allocator-basic
[114.637244] Subtest allocator-basic: SUCCESS (0.166s)
[114.703588] [012/143] (887s left) api_intel_allocator (default-alignment)
[114.763143] Starting subtest: default-alignment
[114.765710] Subtest default-alignment: SUCCESS (0.003s)
[114.870029] [013/143] (887s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[116.853557] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[116.855474] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[116.942531] [014/143] (885s left) gem_eio (in-flight-internal-10ms)
[117.237331] Starting subtest: in-flight-internal-10ms
[118.412410] Subtest in-flight-internal-10ms: SUCCESS (1.176s)
[120.373301] [015/143] (881s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[122.380689] Starting subtest: cursorB-vs-flipB-legacy
[122.382519] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[122.438408] [016/143] (879s left) gem_mmap_gtt (basic-small-bo-tiledy)
[122.518584] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[122.561523] [017/143] (879s left) fbdev (unaligned-read)
[122.657630] Starting subtest: unaligned-read
[122.665465] Subtest unaligned-read: SUCCESS (0.008s)
[122.705623] [018/143] (879s left) vc4/vc4_label_bo (set-bad-name)
[122.790584] Subtest set-bad-name: SKIP (0.000s)
[122.839222] [019/143] (879s left) gem_huc_copy (huc-copy)
[122.903137] Starting subtest: huc-copy
[122.908304] Subtest huc-copy: SUCCESS (0.005s)
[123.030335] [020/143] (879s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[123.084116] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[123.085023] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[123.140761] [021/143] (879s left) syncobj_timeline (invalid-query-bad-pad)
[123.187540] Starting subtest: invalid-query-bad-pad
[123.188420] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[123.247050] [022/143] (879s left) syncobj_basic (bad-destroy)
[123.319365] Starting subtest: bad-destroy
[123.320265] Subtest bad-destroy: SUCCESS (0.000s)
[123.369820] [023/143] (879s left) kms_pm_rpm (modeset-stress-extra-wait)
[127.532235] Starting subtest: modeset-stress-extra-wait
[180.115507] Subtest modeset-stress-extra-wait: SUCCESS (52.582s)
[180.276759] [024/143] (822s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[182.218114] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[182.219919] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.295423] [025/143] (820s left) i915_pm_rps (basic-api)
[182.416551] Starting subtest: basic-api
[182.418956] Subtest basic-api: SKIP (0.001s)
[182.478094] [026/143] (820s left) gem_mmap_offset (oob-read)
[182.533963] Starting subtest: oob-read
[182.534803] Subtest oob-read: SUCCESS (0.000s)
[182.628247] [027/143] (819s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[182.708170] Starting subtest: etime-multi-wait-all-for-submit-submitted
[182.816693] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[182.890990] [028/143] (819s left) kms_cdclk (mode-transition-all-outputs)
[184.828087] Starting subtest: mode-transition-all-outputs
[184.867280] Subtest mode-transition-all-outputs: SKIP (0.038s)
[184.955099] [029/143] (817s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[186.953581] Starting subtest: psr-farfromfence-mmap-gtt
[186.955230] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[187.021770] [030/143] (815s left) gem_exec_fair (basic-pace-solo)
[187.133263] Subtest basic-pace-solo: SKIP (0.000s)
[187.208398] [031/143] (815s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[189.183412] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[189.184964] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[189.257605] [032/143] (813s left) syncobj_timeline (transfer-timeline-point)
[189.361950] Starting subtest: transfer-timeline-point
[189.363427] Subtest transfer-timeline-point: SUCCESS (0.001s)
[189.441913] [033/143] (813s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-mc-ccs)
[191.586266] Starting subtest: pipe-D-crc-primary-basic-4-tiled-dg2-mc-ccs
[196.647516] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (5.060s)
[196.838156] [034/143] (805s left) kms_color (deep-color)
[198.781268] Starting subtest: deep-color
[198.786877] Subtest deep-color: SKIP (0.003s)
[198.850841] [035/143] (803s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[200.837600] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[200.839257] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[200.921149] [036/143] (801s left) gem_exec_schedule (submit-early-slice)
[201.049553] Starting subtest: submit-early-slice
[201.050465] Starting dynamic subtest: rcs0
[201.130070] Dynamic subtest rcs0: SUCCESS (0.081s)
[201.137725] Starting dynamic subtest: bcs0
[201.195934] Dynamic subtest bcs0: SUCCESS (0.065s)
[201.206779] Starting dynamic subtest: vcs0
[201.262687] Dynamic subtest vcs0: SUCCESS (0.067s)
[201.269894] Starting dynamic subtest: vcs1
[201.325679] Dynamic subtest vcs1: SUCCESS (0.063s)
[201.332868] Starting dynamic subtest: vecs0
[201.393022] Dynamic subtest vecs0: SUCCESS (0.067s)
[201.403559] Starting dynamic subtest: vecs1
[201.460734] Dynamic subtest vecs1: SUCCESS (0.067s)
[201.467891] Starting dynamic subtest: ccs0
[201.533635] Dynamic subtest ccs0: SUCCESS (0.073s)
[201.541921] Starting dynamic subtest: ccs1
[201.602251] Dynamic subtest ccs1: SUCCESS (0.068s)
[201.611956] Starting dynamic subtest: ccs2
[201.665096] Dynamic subtest ccs2: SUCCESS (0.063s)
[201.672336] Starting dynamic subtest: ccs3
[201.726811] Dynamic subtest ccs3: SUCCESS (0.061s)
[201.727891] Subtest submit-early-slice: SUCCESS (0.677s)
[202.150226] [037/143] (800s left) prime_vgem (busy)
[202.250369] Starting subtest: busy
[202.251237] Starting dynamic subtest: rcs0
[202.303398] Dynamic subtest rcs0: SUCCESS (0.052s)
[202.310621] Starting dynamic subtest: bcs0
[202.345865] Dynamic subtest bcs0: SUCCESS (0.043s)
[202.356250] Starting dynamic subtest: vcs0
[202.388449] Dynamic subtest vcs0: SUCCESS (0.042s)
[202.413889] Starting dynamic subtest: vcs1
[202.433045] Dynamic subtest vcs1: SUCCESS (0.044s)
[202.457289] Starting dynamic subtest: vecs0
[202.475232] Dynamic subtest vecs0: SUCCESS (0.042s)
[202.490079] Starting dynamic subtest: vecs1
[202.517989] Dynamic subtest vecs1: SUCCESS (0.042s)
[202.543621] Starting dynamic subtest: ccs0
[202.562994] Dynamic subtest ccs0: SUCCESS (0.044s)
[202.587131] Starting dynamic subtest: ccs1
[202.604168] Dynamic subtest ccs1: SUCCESS (0.041s)
[202.619499] Starting dynamic subtest: ccs2
[202.647998] Dynamic subtest ccs2: SUCCESS (0.043s)
[202.675106] Starting dynamic subtest: ccs3
[202.690934] Dynamic subtest ccs3: SUCCESS (0.042s)
[202.692345] Subtest busy: SUCCESS (0.440s)
[202.816990] [038/143] (799s left) kms_plane (plane-position-hole)
[204.787444] Starting subtest: plane-position-hole
[204.788406] Starting dynamic subtest: pipe-A
[206.634781] Dynamic subtest pipe-A: SUCCESS (1.847s)
[206.643959] Starting dynamic subtest: pipe-B
[208.217147] Dynamic subtest pipe-B: SUCCESS (1.581s)
[208.218025] Subtest plane-position-hole: SUCCESS (3.431s)
[208.362706] [039/143] (794s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-mc-ccs)
[210.366576] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-mc-ccs
[210.368334] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[210.526328] [040/143] (792s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[212.478149] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[212.501221] [041/143] (790s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[214.441497] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[214.442456] Starting dynamic subtest: pipe-A-valid-mode
[214.485181] Dynamic subtest pipe-A-valid-mode: SKIP (0.041s)
[214.487084] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.042s)
[214.571501] [042/143] (788s left) gem_render_copy (x-tiled)
[214.672241] Starting subtest: x-tiled
[214.673377] Starting dynamic subtest: smem
[214.765884] Dynamic subtest smem: SUCCESS (0.093s)
[214.773127] Starting dynamic subtest: lmem0
[216.338900] Dynamic subtest lmem0: SUCCESS (1.572s)
[216.339754] Subtest x-tiled: SUCCESS (1.667s)
[216.520373] [043/143] (786s left) gen7_exec_parse (basic-rejected)
[216.569310] Subtest basic-rejected: SKIP (0.000s)
[216.597106] [044/143] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[218.544776] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[218.546511] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[218.625843] [045/143] (784s left) gem_create (create-ext-cpu-access-sanity-check)
[218.858242] Starting subtest: create-ext-cpu-access-sanity-check
[218.874852] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.017s)
[218.980995] [046/143] (783s left) gem_exec_alignment (pi)