[43.580069] Initializing watchdogs
[43.580124]   /dev/watchdog0
[43.585837] [001/142] (960s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm)
[45.528339] Starting subtest: pipe-B-ts-continuation-modeset-rpm
[48.114865] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (2.588s)
[48.264999] [002/142] (955s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[49.290239] Starting subtest: syncobj-timeline-invalid-flags
[49.291737] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[49.530387] [003/142] (954s left) kms_flip (2x-absolute-wf_vblank)
[50.531338] Starting subtest: 2x-absolute-wf_vblank
[50.545319] Subtest 2x-absolute-wf_vblank: SKIP (0.015s)
[50.609226] [004/142] (953s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[50.727722] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[50.789609] [005/142] (953s left) gem_exec_schedule (in-order)
[50.880569] Starting subtest: in-order
[50.881360] Starting dynamic subtest: rcs0
[51.139713] Dynamic subtest rcs0: SUCCESS (0.250s)
[51.144351] Starting dynamic subtest: bcs0
[51.315086] Dynamic subtest bcs0: SUCCESS (0.175s)
[51.319946] Starting dynamic subtest: vcs0
[51.505387] Dynamic subtest vcs0: SUCCESS (0.190s)
[51.510137] Starting dynamic subtest: vcs1
[51.695380] Dynamic subtest vcs1: SUCCESS (0.190s)
[51.700251] Starting dynamic subtest: vecs0
[51.887202] Dynamic subtest vecs0: SUCCESS (0.192s)
[51.891983] Starting dynamic subtest: vecs1
[52.080568] Dynamic subtest vecs1: SUCCESS (0.193s)
[52.085485] Starting dynamic subtest: ccs0
[52.267201] Dynamic subtest ccs0: SUCCESS (0.187s)
[52.271899] Starting dynamic subtest: ccs1
[52.511955] Dynamic subtest ccs1: SUCCESS (0.245s)
[52.516846] Starting dynamic subtest: ccs2
[52.699816] Dynamic subtest ccs2: SUCCESS (0.188s)
[52.704610] Starting dynamic subtest: ccs3
[52.885039] Dynamic subtest ccs3: SUCCESS (0.185s)
[52.886134] Subtest in-order: SUCCESS (1.995s)
[53.255556] [006/142] (950s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[53.350046] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[53.369085] [007/142] (950s left) syncobj_timeline (multi-wait-submitted-signaled)
[53.416698] Starting subtest: multi-wait-submitted-signaled
[53.417562] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[53.474266] [008/142] (950s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[55.424072] Starting subtest: x-tiled-8bpp-rotate-270
[55.463685] Subtest x-tiled-8bpp-rotate-270: SKIP (0.039s)
[55.574267] [009/142] (948s left) kms_content_protection (content_type_change)
[57.621976] Starting subtest: content_type_change
[57.887555] Subtest content_type_change: SKIP (0.263s)
[58.074988] [010/142] (946s left) vc4/vc4_purgeable_bo (mark-purgeable)
[58.158473] Subtest mark-purgeable: SKIP (0.000s)
[58.203859] [011/142] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[60.152995] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[62.542132] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.391s)
[62.687652] [012/142] (941s left) kms_vblank (pipe-d-accuracy-idle)
[64.624155] Starting subtest: pipe-D-accuracy-idle
[66.971740] Subtest pipe-D-accuracy-idle: SUCCESS (2.347s)
[67.091850] [013/142] (937s left) debugfs_test (read_all_entries_display_off)
[69.043047] Starting subtest: read_all_entries_display_off
[69.565958] Subtest read_all_entries_display_off: SUCCESS (0.521s)
[69.651873] [014/142] (934s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[69.706712] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[69.727012] [015/142] (934s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[71.675051] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[72.371150] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.696s)
[72.507792] [016/142] (931s left) drm_read (invalid-buffer)
[74.521350] Starting subtest: invalid-buffer
[74.522276] Subtest invalid-buffer: SUCCESS (0.000s)
[74.675658] [017/142] (929s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[76.665381] Starting subtest: fbcpsr-rgb565-draw-pwrite
[76.667062] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[76.736916] [018/142] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[78.744860] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[78.746631] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[78.820615] [019/142] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[80.833398] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[80.835172] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[80.903981] [020/142] (923s left) i915_pm_rpm (pm-caching)
[85.464971] Starting subtest: pm-caching
[85.467056] Subtest pm-caching: SKIP (0.000s)
[86.632198] [021/142] (917s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[88.618403] Starting subtest: y-tiled-16bpp-rotate-180
[88.620455] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[88.682512] [022/142] (915s left) kms_psr (psr2_sprite_plane_move)
[88.790508] Subtest psr2_sprite_plane_move: SKIP (0.000s)
[88.832251] [023/142] (915s left) kms_cursor_edge_walk (128x128-right-edge)
[90.804174] Starting subtest: 128x128-right-edge
[90.805123] Starting dynamic subtest: pipe-A-HDMI-A-3
[94.076140] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.271s)
[94.081372] Starting dynamic subtest: pipe-D-HDMI-A-3
[97.259186] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.183s)
[97.260179] Subtest 128x128-right-edge: SUCCESS (6.455s)
[97.388712] [024/142] (907s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[99.338134] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[99.339884] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[99.532400] [025/142] (904s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm)
[101.488256] Starting subtest: pipe-A-ts-continuation-dpms-rpm
[103.954065] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (2.466s)
[104.149152] [026/142] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[106.162058] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[106.163755] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[106.226605] [027/142] (898s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[108.352734] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[108.354461] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[108.440435] [028/142] (896s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[110.439934] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[110.442237] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[110.590788] [029/142] (893s left) kms_fbcon_fbt (psr-suspend)
[110.652359] Starting subtest: psr-suspend
[110.654194] Subtest psr-suspend: SKIP (0.000s)
[110.722877] [030/142] (893s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[112.797559] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[112.799290] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[112.896836] [031/142] (891s left) gem_mmap_gtt (basic-write-gtt)
[112.956489] Subtest basic-write-gtt: SKIP (0.000s)
[112.972534] [032/142] (891s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[113.015963] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[113.128651] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[113.200145] [033/142] (891s left) gem_exec_whisper (basic-contexts-all)
[113.289797] Starting subtest: basic-contexts-all
[135.456686] Subtest basic-contexts-all: SUCCESS (22.156s)
[135.616618] [034/142] (869s left) vc4/vc4_wait_bo (bad-pad)
[135.684069] Subtest bad-pad: SKIP (0.000s)
[135.728380] [035/142] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[137.674404] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[137.676167] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[137.748781] [036/142] (866s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[139.765332] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[139.766914] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[139.852075] [037/142] (864s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[141.867140] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[160.883365] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (4.239s)
[162.998306] [038/142] (858s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[164.986370] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[164.988133] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[165.136715] [039/142] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[167.097239] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[167.098753] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[167.171495] [040/142] (854s left) kms_invalid_mode (int-max-clock)
[169.184068] Starting subtest: int-max-clock
[169.185040] Starting dynamic subtest: HDMI-A-3-pipe-A
[169.227188] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (0.043s)
[169.233957] Starting dynamic subtest: HDMI-A-3-pipe-B
[169.235038] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (0.001s)
[169.241478] Starting dynamic subtest: HDMI-A-3-pipe-C
[169.242352] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (0.000s)
[169.248762] Starting dynamic subtest: HDMI-A-3-pipe-D
[169.249573] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (0.001s)
[169.250396] Subtest int-max-clock: SUCCESS (0.048s)
[169.349132] [041/142] (852s left) gem_exec_reloc (basic-range)
[169.445573] Subtest basic-range: SKIP (0.000s)
[169.485237] [042/142] (852s left) kms_ccs (pipe-b-crc-primary-rotation-180-yf_tiled_ccs)
[171.505494] Starting subtest: pipe-B-crc-primary-rotation-180-yf_tiled_ccs
[171.507361] Subtest pipe-B-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[171.653762] [043/142] (849s left) gem_exec_whisper (basic-contexts-priority)
[171.729460] Starting subtest: basic-contexts-priority
[194.373127] Subtest basic-contexts-priority: SUCCESS (22.633s)
[194.538053] [044/142] (827s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[196.479450] Starting subtest: addfb25-yf-tiled-legacy
[196.480288] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[196.544590] [045/142] (825s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[198.549953] Starting subtest: psr-rgb101010-draw-render
[198.551525] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[198.630074] [046/142] (823s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[198.741828] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[198.743045] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[198.829134] [047/142] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[200.823463] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[200.825168] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[200.895655] [048/142] (820s left) gem_ctx_param (set-priority-range)
[201.004653] Starting subtest: set-priority-range
[201.034084] Subtest set-priority-range: SUCCESS (0.030s)
[201.096211] [049/142] (820s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[201.163712] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[201.203043] [050/142] (820s left) kms_pm_dc (dc9-dpms)
[204.162715] Starting subtest: dc9-dpms
[204.463484] Subtest dc9-dpms: SUCCESS (0.300s)
[205.456099] [051/142] (816s left) api_intel_bb (simple-bb)
[205.543005] Starting subtest: simple-bb
[205.597267] Subtest simple-bb: SUCCESS (0.055s)
[205.716665] [052/142] (816s left) kms_atomic (atomic-invalid-params)
[208.073599] Starting subtest: atomic-invalid-params
[208.158346] Subtest atomic-invalid-params: SUCCESS (0.091s)
[208.334025] [053/142] (813s left) v3d/v3d_wait_bo (map-bo-0ns)
[208.400611] Subtest map-bo-0ns: SKIP (0.000s)
[208.447555] [054/142] (813s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[210.441776] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[210.508127] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.066s)
[210.730232] [055/142] (811s left) gem_mmap_wc (write-read)
[210.797095] Subtest write-read: SKIP (0.000s)
[210.816286] [056/142] (811s left) gem_softpin (evict-prime-sanity-check)
[210.865214] Starting subtest: evict-prime-sanity-check
[210.866101] Starting dynamic subtest: rcs0
[211.990720] Dynamic subtest rcs0: SUCCESS (1.125s)
[212.000673] Starting dynamic subtest: bcs0
[213.100318] Dynamic subtest bcs0: SUCCESS (1.106s)
[213.114045] Starting dynamic subtest: vcs0
[214.202574] Dynamic subtest vcs0: SUCCESS (1.104s)
[214.209237] Starting dynamic subtest: vcs1
[215.304381] Dynamic subtest vcs1: SUCCESS (1.102s)
[215.313971] Starting dynamic subtest: vecs0
[216.405236] Dynamic subtest vecs0: SUCCESS (1.101s)
[216.411836] Starting dynamic subtest: vecs1
[217.496146] Dynamic subtest vecs1: SUCCESS (1.091s)
[217.502880] Starting dynamic subtest: ccs0
[218.622770] Dynamic subtest ccs0: SUCCESS (1.126s)
[218.632594] Starting dynamic subtest: ccs1
[219.727337] Dynamic subtest ccs1: SUCCESS (1.104s)
[219.736424] Starting dynamic subtest: ccs2
[220.837125] Dynamic subtest ccs2: SUCCESS (1.110s)
[220.843983] Starting dynamic subtest: ccs3
[221.939278] Dynamic subtest ccs3: SUCCESS (1.102s)
[221.946112] Starting dynamic subtest: all
[223.044246] Dynamic subtest all: SUCCESS (1.105s)
[223.045364] Subtest evict-prime-sanity-check: SUCCESS (12.179s)
[223.108925] [057/142] (798s left) gem_userptr_blits (invalid-null-pointer)
[223.162141] Starting subtest: invalid-null-pointer
[223.163039] Subtest invalid-null-pointer: SUCCESS (0.001s)
[223.279905] [058/142] (798s left) perf (gen12-group-exclusive-stream-sample-oa)
[223.623492] Starting subtest: gen12-group-exclusive-stream-sample-oa
[223.640127] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.016s)
[223.655815] [059/142] (798s left) i915_module_load (resize-bar)
[223.699125] Starting subtest: resize-bar
[272.479826] Subtest resize-bar: SUCCESS (48.772s)
[272.492243] [060/142] (749s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[277.697857] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[277.699475] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[277.770384] [061/142] (744s left) syncobj_wait (wait-for-submit-complex)
[277.884001] Starting subtest: wait-for-submit-complex
[277.947234] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[278.025832] [062/142] (743s left) kms_addfb_basic (too-high)
[280.009175] Starting subtest: too-high
[280.010096] Subtest too-high: SUCCESS (0.001s)
[280.069046] [063/142] (741s left) fbdev (unaligned-read)
[280.172854] Starting subtest: unaligned-read
[280.192968] Subtest unaligned-read: SUCCESS (0.020s)
[280.257716] [064/142] (741s left) gem_exec_schedule (preempt-hang)
[280.496745] Starting subtest: preempt-hang
[280.498326] Starting dynamic subtest: rcs0
[280.821594] Dynamic subtest rcs0: SUCCESS (0.333s)
[280.828448] Starting dynamic subtest: bcs0
[281.112669] Dynamic subtest bcs0: SUCCESS (0.290s)
[281.119602] Starting dynamic subtest: vcs0
[281.401246] Dynamic subtest vcs0: SUCCESS (0.288s)
[281.407908] Starting dynamic subtest: vcs1
[281.719121] Dynamic subtest vcs1: SUCCESS (0.317s)
[281.725533] Starting dynamic subtest: vecs0
[282.051665] Dynamic subtest vecs0: SUCCESS (0.315s)
[282.057987] Starting dynamic subtest: vecs1
[282.372224] Dynamic subtest vecs1: SUCCESS (0.331s)
[282.378814] Starting dynamic subtest: ccs0
[282.719907] Dynamic subtest ccs0: SUCCESS (0.334s)
[282.730571] Starting dynamic subtest: ccs1
[283.037249] Dynamic subtest ccs1: SUCCESS (0.311s)
[283.053160] Starting dynamic subtest: ccs2
[283.349936] Dynamic subtest ccs2: SUCCESS (0.320s)
[283.356362] Starting dynamic subtest: ccs3
[283.672228] Dynamic subtest ccs3: SUCCESS (0.330s)
[283.673023] Subtest preempt-hang: SUCCESS (3.176s)
[283.937526] [065/142] (738s left) i915_pm_rpm (system-suspend)
[288.265536] Starting subtest: system-suspend
[309.288862] Subtest system-suspend: SUCCESS (5.462s)
[311.422448] [066/142] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[313.370422] Starting subtest: fbcpsr-2p-rte
[313.371973] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[313.443174] [067/142] (725s left) kms_big_fb (yf-tiled-addfb)
[315.464432] Starting subtest: yf-tiled-addfb
[315.466480] Subtest yf-tiled-addfb: SKIP (0.000s)
[315.544931] [068/142] (723s left) gem_ctx_shared (q-smoketest)
[315.677284] Starting subtest: Q-smoketest
[315.678332] Starting dynamic subtest: rcs0
[321.159468] Dynamic subtest rcs0: SUCCESS (5.444s)
[321.166554] Starting dynamic subtest: bcs0
[326.544891] Dynamic subtest bcs0: SUCCESS (5.409s)
[326.551781] Starting dynamic subtest: vcs0
[331.962124] Dynamic subtest vcs0: SUCCESS (5.417s)
[331.969121] Starting dynamic subtest: vcs1
[337.378359] Dynamic subtest vcs1: SUCCESS (5.415s)
[337.385307] Starting dynamic subtest: vecs0
[342.788472] Dynamic subtest vecs0: SUCCESS (5.410s)
[342.795359] Starting dynamic subtest: vecs1
[348.227619] Dynamic subtest vecs1: SUCCESS (5.413s)
[348.234487] Starting dynamic subtest: ccs0
[353.636573] Dynamic subtest ccs0: SUCCESS (5.409s)
[353.643526] Starting dynamic subtest: ccs1
[359.046781] Dynamic subtest ccs1: SUCCESS (5.409s)
[359.053741] Starting dynamic subtest: ccs2
[364.451916] Dynamic subtest ccs2: SUCCESS (5.404s)
[364.460778] Starting dynamic subtest: ccs3
[369.867647] Dynamic subtest ccs3: SUCCESS (5.413s)
[369.868579] Subtest Q-smoketest: SUCCESS (54.150s)
[370.039889] [069/142] (668s left) kms_vblank (pipe-c-query-forked-busy-hang)
[372.015932] Starting subtest: pipe-C-query-forked-busy-hang
[386.355212] Subtest pipe-C-query-forked-busy-hang: SUCCESS (14.340s)
[386.458981] [070/142] (652s left) gem_pxp (fail-invalid-protected-context)
[389.068661] Subtest fail-invalid-protected-context: SKIP (0.000s)
[389.093592] [071/142] (649s left) gem_exec_fence (invalid-timeline-fence-array)
[390.010567] Starting subtest: invalid-timeline-fence-array
[390.014490] Subtest invalid-timeline-fence-array: SUCCESS (0.013s)
[390.318599] [072/142] (648s left) gem_exec_balancer (parallel)
[390.611018] Starting subtest: parallel
[391.604188] Subtest parallel: SUCCESS (0.993s)
[391.655422] [073/142] (647s left) api_intel_allocator (fork-simple-once)
[391.700813] Starting subtest: fork-simple-once
[391.732707] Subtest fork-simple-once: SUCCESS (0.032s)
[391.852700] [074/142] (646s left) gem_ctx_param (basic-default)
[391.900718] Starting subtest: basic-default
[391.901677] Subtest basic-default: SUCCESS (0.000s)
[391.959048] [075/142] (646s left) gem_ctx_exec (basic-close-race)
[392.025605] Starting subtest: basic-close-race
[397.497306] Subtest basic-close-race: SUCCESS (5.438s)
[397.615370] [076/142] (641s left) kms_color (ctm-0-25)
[399.615714] Starting subtest: ctm-0-25
[399.616548] Starting dynamic subtest: pipe-A
[401.064103] Dynamic subtest pipe-A: SUCCESS (1.448s)
[401.073958] Starting dynamic subtest: pipe-B
[402.313709] Dynamic subtest pipe-B: SUCCESS (1.249s)
[402.325831] Starting dynamic subtest: pipe-C
[403.585985] Dynamic subtest pipe-C: SUCCESS (1.271s)
[403.594079] Starting dynamic subtest: pipe-D
[404.869217] Dynamic subtest pipe-D: SUCCESS (1.283s)
[404.870111] Subtest ctm-0-25: SUCCESS (5.254s)
[404.997714] [077/142] (633s left) syncobj_wait (invalid-signal-one-illegal-handle)
[405.046760] Starting subtest: invalid-signal-one-illegal-handle
[405.047815] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[405.127922] [078/142] (633s left) v3d/v3d_get_param (get-bad-param)
[405.229463] Subtest get-bad-param: SKIP (0.000s)
[405.277813] [079/142] (633s left) api_intel_bb (blit-noreloc-purge-cache)
[405.332827] Starting subtest: blit-noreloc-purge-cache
[405.357504] Subtest blit-noreloc-purge-cache: SUCCESS (0.025s)
[405.429907] [080/142] (633s left) gem_exec_reloc (basic-wc-read)
[405.481047] Subtest basic-wc-read: SKIP (0.000s)
[405.521000] [081/142] (633s left) i915_fb_tiling
[405.587430] [082/142] (633s left) perf_pmu (all-busy-idle-check-all)
[405.634490] Starting subtest: all-busy-idle-check-all
[406.318055] Subtest all-busy-idle-check-all: SUCCESS (0.683s)
[406.385816] [083/142] (632s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[408.323699] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[408.325558] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[408.380776] [084/142] (630s left) kms_flip (flip-vs-fences)
[409.402259] Starting subtest: flip-vs-fences
[409.403861] Subtest flip-vs-fences: SKIP (0.000s)
[409.504944] [085/142] (629s left) prime_vgem (basic-gtt)
[409.645663] Starting subtest: basic-gtt
[409.647807] Subtest basic-gtt: SKIP (0.000s)
[409.755115] [086/142] (629s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[411.724982] Starting subtest: basic-max-pipe-crc-check
[411.727128] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[411.756949] [087/142] (627s left) gem_userptr_blits (sync-unmap-after-close)
[411.825690] Starting subtest: sync-unmap-after-close
[411.847311] Subtest sync-unmap-after-close: SUCCESS (0.021s)
[411.973968] [088/142] (627s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[414.053308] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[414.056222] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[414.164148] [089/142] (624s left) gem_mmap_wc (write-prefaulted)
[414.221734] Subtest write-prefaulted: SKIP (0.000s)
[414.240646] [090/142] (624s left) kms_flip (2x-dpms-vs-vblank-race)
[415.242944] Starting subtest: 2x-dpms-vs-vblank-race
[415.256475] Subtest 2x-dpms-vs-vblank-race: SKIP (0.014s)
[415.334643] [091/142] (623s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[416.405859] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[416.426903] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[416.482292] [092/142] (622s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[418.469259] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[418.470950] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[418.554801] [093/142] (620s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[420.563767] Starting subtest: cursorA-vs-flipA-legacy
[431.452247] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.889s)
[431.587541] [094/142] (607s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[433.657229] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs
[433.659920] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[433.756939] [095/142] (605s left) kms_cursor_crc (cursor-offscreen-max-size)
[435.905517] Starting subtest: cursor-offscreen-max-size
[435.910070] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[436.045452] [096/142] (603s left) kms_atomic_transition (plane-toggle-modeset-transition)
[438.025083] Starting subtest: plane-toggle-modeset-transition
[438.026050] Starting dynamic subtest: pipe-A-HDMI-A-3
[439.244229] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.219s)
[439.253547] Starting dynamic subtest: pipe-B-HDMI-A-3
[440.270792] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.025s)
[440.271751] Subtest plane-toggle-modeset-transition: SUCCESS (2.248s)
[440.380725] [097/142] (598s left) gem_workarounds (suspend-resume-fd)
[440.445430] Starting subtest: suspend-resume-fd
[459.636159] Subtest suspend-resume-fd: SUCCESS (3.527s)
[462.767796] [098/142] (595s left) perf_pmu (busy-start)
[462.819413] Starting subtest: busy-start
[462.820233] Starting dynamic subtest: rcs0
[465.384359] Dynamic subtest rcs0: SUCCESS (2.562s)
[465.395779] Starting dynamic subtest: bcs0
[467.933359] Dynamic subtest bcs0: SUCCESS (2.546s)
[467.944726] Starting dynamic subtest: vcs0
[470.482264] Dynamic subtest vcs0: SUCCESS (2.546s)
[470.493740] Starting dynamic subtest: vcs1
[473.031285] Dynamic subtest vcs1: SUCCESS (2.546s)
[473.042817] Starting dynamic subtest: vecs0
[475.578622] Dynamic subtest vecs0: SUCCESS (2.545s)
[475.590360] Starting dynamic subtest: vecs1
[478.126274] Dynamic subtest vecs1: SUCCESS (2.544s)
[478.137871] Starting dynamic subtest: ccs0
[480.673884] Dynamic subtest ccs0: SUCCESS (2.545s)
[480.685347] Starting dynamic subtest: ccs1
[483.222081] Dynamic subtest ccs1: SUCCESS (2.546s)
[483.237312] Starting dynamic subtest: ccs2
[485.770729] Dynamic subtest ccs2: SUCCESS (2.545s)
[485.782009] Starting dynamic subtest: ccs3
[488.318219] Dynamic subtest ccs3: SUCCESS (2.545s)
[488.320032] Subtest busy-start: SUCCESS (25.498s)
[488.379800] [099/142] (569s left) gem_ctx_persistence (hang)
[488.428492] Starting subtest: hang
[488.430063] Subtest hang: SKIP (0.000s)
[488.520079] [100/142] (569s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[490.476042] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[490.477661] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[490.546289] [101/142] (567s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[492.567241] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[494.842422] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.277s)
[494.988958] [102/142] (563s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[496.936525] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[496.938097] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[497.012855] [103/142] (561s left) gem_ccs (suspend-resume)
[497.132326] Starting subtest: suspend-resume
[497.135397] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[515.782639] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.794s)
[515.790773] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[533.899383] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.543s)
[533.908562] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[551.800561] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.437s)
[551.809175] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[569.899993] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.533s)
[569.909543] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[587.877997] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.485s)
[587.886241] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[605.930194] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.543s)
[605.939505] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[623.832410] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.434s)
[623.840999] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[641.915836] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.537s)
[641.916543] Subtest suspend-resume: SUCCESS (28.314s)
[646.180821] [104/142] (532s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[648.133745] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[648.135580] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[648.200052] [105/142] (530s left) syncobj_wait (reset-signaled)
[648.310726] Starting subtest: reset-signaled
[648.312153] Subtest reset-signaled: SUCCESS (0.001s)
[648.412939] [106/142] (530s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[648.499104] Starting subtest: y-tiled-ccs-to-yf-tiled
[648.500764] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[648.716075] [107/142] (530s left) gem_exec_flush (basic-wb-rw-before-default)
[648.794828] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[648.842638] [108/142] (529s left) kms_flip (nonblocking-read)
[649.850575] Starting subtest: nonblocking-read
[649.851493] Subtest nonblocking-read: SUCCESS (0.000s)
[649.935652] [109/142] (528s left) kms_cursor_crc (cursor-random-128x42)
[652.078557] Starting subtest: cursor-random-128x42
[652.082725] Starting dynamic subtest: pipe-A-HDMI-A-3
[656.404592] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.321s)
[656.437179] Starting dynamic subtest: pipe-D-HDMI-A-3
[660.531987] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.103s)
[660.532926] Subtest cursor-random-128x42: SUCCESS (8.453s)
[660.789661] [110/142] (518s left) drm_fdinfo (virtual-busy-hang)
[660.867175] Starting subtest: virtual-busy-hang
[660.869362] Subtest virtual-busy-hang: SKIP (0.000s)
[660.938450] [111/142] (517s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[662.959073] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs
[662.960984] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[663.066641] [112/142] (515s left) sysfs_preempt_timeout (timeout)
[663.124962] Starting subtest: timeout
[663.125781] Starting dynamic subtest: ccs2
[664.972209] Dynamic subtest ccs2: SUCCESS (1.846s)
[664.980980] Starting dynamic subtest: vecs0
[666.595339] Dynamic subtest vecs0: SUCCESS (1.622s)
[666.604299] Starting dynamic subtest: ccs0
[668.294338] Dynamic subtest ccs0: SUCCESS (1.699s)
[668.303305] Starting dynamic subtest: vcs0
[669.907287] Dynamic subtest vcs0: SUCCESS (1.611s)
[669.916268] Starting dynamic subtest: bcs0
[671.515488] Dynamic subtest bcs0: SUCCESS (1.607s)
[671.524553] Starting dynamic subtest: ccs3
[673.154265] Dynamic subtest ccs3: SUCCESS (1.637s)
[673.163083] Starting dynamic subtest: vecs1
[674.751365] Dynamic subtest vecs1: SUCCESS (1.597s)
[674.760399] Starting dynamic subtest: ccs1
[676.423518] Dynamic subtest ccs1: SUCCESS (1.672s)
[676.432505] Starting dynamic subtest: rcs0
[678.037271] Dynamic subtest rcs0: SUCCESS (1.613s)
[678.045937] Starting dynamic subtest: vcs1
[679.619373] Dynamic subtest vcs1: SUCCESS (1.581s)
[679.620339] Subtest timeout: SUCCESS (16.494s)
[679.716032] [113/142] (499s left) syncobj_wait (multi-wait-all-submitted)
[679.761875] Starting subtest: multi-wait-all-submitted
[679.867445] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[679.950314] [114/142] (498s left) gem_lmem_swapping (heavy-verify-random)
[685.759460] Starting subtest: heavy-verify-random
[685.760232] Starting dynamic subtest: lmem0
[700.420263] Dynamic subtest lmem0: SUCCESS (14.626s)
[700.421259] Subtest heavy-verify-random: SUCCESS (14.627s)
[701.856994] [115/142] (477s left) kms_getfb (getfb-handle-valid)
[706.619607] Starting subtest: getfb-handle-valid
[706.620338] Subtest getfb-handle-valid: SUCCESS (0.000s)
[708.503730] [116/142] (470s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs)
[710.526068] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs
[710.633669] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs: SUCCESS (0.106s)
[710.825655] [117/142] (468s left) gem_linear_blits (normal)
[711.493195] Starting subtest: normal
[717.927311] Subtest normal: SUCCESS (6.434s)
[718.085284] [118/142] (460s left) kms_plane_lowres (tiling-yf)
[722.375371] Starting subtest: tiling-yf
[722.376860] Subtest tiling-yf: SKIP (0.000s)
[722.435478] [119/142] (456s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[725.251047] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[725.251880] Starting dynamic subtest: pipe-A-valid-mode
[726.045918] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.795s)
[726.046778] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (0.796s)
[726.182569] [120/142] (452s left) kms_invalid_mode (bad-htotal)
[728.150895] Starting subtest: bad-htotal
[728.151892] Starting dynamic subtest: HDMI-A-3-pipe-A
[728.196437] Dynamic subtest HDMI-A-3-pipe-A: SUCCESS (0.045s)
[728.205399] Starting dynamic subtest: HDMI-A-3-pipe-B
[728.206212] Dynamic subtest HDMI-A-3-pipe-B: SUCCESS (0.001s)
[728.214375] Starting dynamic subtest: HDMI-A-3-pipe-C
[728.215189] Dynamic subtest HDMI-A-3-pipe-C: SUCCESS (0.001s)
[728.224115] Starting dynamic subtest: HDMI-A-3-pipe-D
[728.224964] Dynamic subtest HDMI-A-3-pipe-D: SUCCESS (0.001s)
[728.225766] Subtest bad-htotal: SUCCESS (0.052s)
[728.349952] [121/142] (450s left) kms_chamelium_audio (hdmi-audio)
[730.369269] Subtest hdmi-audio: SKIP (0.000s)
[730.427544] [122/142] (448s left) v3d/v3d_submit_cl (multi-and-single-sync)
[730.549010] Subtest multi-and-single-sync: SKIP (0.000s)
[730.624611] [123/142] (448s left) gem_exec_balancer (bonded-semaphore)
[730.713525] Starting subtest: bonded-semaphore
[730.715581] Subtest bonded-semaphore: SKIP (0.000s)
[731.015306] [124/142] (448s left) gen9_exec_parse (basic-rejected)
[731.063983] Subtest basic-rejected: SKIP (0.000s)
[731.090963] [125/142] (448s left) kms_flip (flip-vs-suspend-interruptible)
[732.098094] Starting subtest: flip-vs-suspend-interruptible
[732.105028] Starting dynamic subtest: A-HDMI-A3
[770.710812] Dynamic subtest A-HDMI-A3: SUCCESS (7.177s)
[770.752433] Starting dynamic subtest: B-HDMI-A3
[809.741879] Dynamic subtest B-HDMI-A3: SUCCESS (6.716s)
[809.760713] Starting dynamic subtest: C-HDMI-A3
[848.701512] Dynamic subtest C-HDMI-A3: SUCCESS (6.681s)
[848.720280] Starting dynamic subtest: D-HDMI-A3
[887.679399] Dynamic subtest D-HDMI-A3: SUCCESS (6.674s)
[887.680614] Subtest flip-vs-suspend-interruptible: SUCCESS (27.263s)
[891.895634] [126/142] (419s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[891.946476] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[893.927035] [127/142] (417s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[894.047678] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[894.049493] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[894.103587] [128/142] (417s left) perf (blocking)
[894.421342] Starting subtest: blocking
[894.422271] Starting dynamic subtest: 0-rcs0
[904.497885] Dynamic subtest 0-rcs0: SUCCESS (10.043s)
[904.499413] Subtest blocking: SUCCESS (10.043s)
[904.514480] [129/142] (407s left) gem_spin_batch (resubmit-new-all)
[904.569992] Starting subtest: resubmit-new-all
[904.570924] Starting dynamic subtest: rcs0
[904.598022] Dynamic subtest rcs0: SUCCESS (0.028s)
[904.606848] Starting dynamic subtest: bcs0
[904.607656] Dynamic subtest bcs0: SUCCESS (0.007s)
[904.616643] Starting dynamic subtest: vcs0
[904.617501] Dynamic subtest vcs0: SUCCESS (0.007s)
[904.626366] Starting dynamic subtest: vcs1
[904.627254] Dynamic subtest vcs1: SUCCESS (0.006s)
[904.636054] Starting dynamic subtest: vecs0
[904.636874] Dynamic subtest vecs0: SUCCESS (0.008s)
[904.645813] Starting dynamic subtest: vecs1
[904.646662] Dynamic subtest vecs1: SUCCESS (0.007s)
[904.655524] Starting dynamic subtest: ccs0
[904.656350] Dynamic subtest ccs0: SUCCESS (0.007s)
[904.665170] Starting dynamic subtest: ccs1
[904.666032] Dynamic subtest ccs1: SUCCESS (0.007s)
[904.674707] Starting dynamic subtest: ccs2
[904.675553] Dynamic subtest ccs2: SUCCESS (0.008s)
[904.683998] Starting dynamic subtest: ccs3
[904.684838] Dynamic subtest ccs3: SUCCESS (0.007s)
[904.685788] Subtest resubmit-new-all: SUCCESS (0.098s)
[904.959087] [130/142] (406s left) kms_getfb (getfb-handle-zero)
[905.012762] Starting subtest: getfb-handle-zero
[905.013670] Subtest getfb-handle-zero: SUCCESS (0.000s)
[905.096281] [131/142] (406s left) gem_exec_params (sol-reset-not-gen7)
[905.183577] Starting subtest: sol-reset-not-gen7
[905.185820] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[905.285226] [132/142] (406s left) kms_psr (primary_render)
[905.364582] Subtest primary_render: SKIP (0.000s)
[905.381035] [133/142] (406s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs)
[907.384353] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs
[907.387187] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[907.521069] [134/142] (404s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[907.579967] Starting subtest: etime-multi-wait-for-submit-submitted
[907.689300] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[907.785254] [135/142] (403s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[909.779159] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[909.780980] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[909.938962] [136/142] (401s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[911.902735] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[913.097273] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.186s)
[913.223477] [137/142] (398s left) kms_chamelium_hpd (common-hpd-after-suspend)
[915.210746] Subtest common-hpd-after-suspend: SKIP (0.000s)
[915.268135] [138/142] (396s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[917.215070] Starting subtest: 4-tiled-32bpp-rotate-90
[917.273315] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.058s)
[917.402045] [139/142] (394s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[919.467375] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[919.469239] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[919.590685] [140/142] (392s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[921.545319] Starting subtest: plane-downscale-with-rotation-factor-0-25
[921.546301] Starting dynamic subtest: pipe-A-HDMI-A-3
[921.596504] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.048s)
[921.605358] Starting dynamic subtest: pipe-B-HDMI-A-3
[921.632667] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.035s)
[921.641870] Starting dynamic subtest: pipe-C-HDMI-A-3
[921.669015] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.035s)
[921.677858] Starting dynamic subtest: pipe-D-HDMI-A-3
[921.704969] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.035s)
[921.706649] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.159s)
[921.815523] [141/142] (390s left) kms_vblank (pipe-d-query-forked-hang)
[923.790139] Starting subtest: pipe-D-query-forked-hang
[937.807769] Subtest pipe-D-query-forked-hang: SUCCESS (14.018s)
[937.909691] [142/142] (374s left) kms_plane_scaling (planes-upscale-factor-0-25)
[939.855009] Starting subtest: planes-upscale-factor-0-25
[939.855954] Starting dynamic subtest: pipe-A-HDMI-A-3
[939.940262] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.085s)
[939.955184] Starting dynamic subtest: pipe-B-HDMI-A-3
[940.066858] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.124s)
[940.082439] Starting dynamic subtest: pipe-C-HDMI-A-3
[940.192661] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.123s)
[940.203467] Starting dynamic subtest: pipe-D-HDMI-A-3
[940.299015] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.105s)
[940.300035] Subtest planes-upscale-factor-0-25: SUCCESS (0.446s)
[940.428161] Closing watchdogs
Done.