[40.383807] Initializing watchdogs
[40.383970]   /dev/watchdog0
[40.400579] [001/137] (960s left) gem_exec_reloc (basic-scanout)
[40.699940] Starting subtest: basic-scanout
[40.704188] Starting dynamic subtest: rcs0
[41.383412] Dynamic subtest rcs0: SUCCESS (0.699s)
[41.399107] Starting dynamic subtest: bcs0
[41.580247] Dynamic subtest bcs0: SUCCESS (0.182s)
[41.597377] Starting dynamic subtest: vcs0
[41.746707] Dynamic subtest vcs0: SUCCESS (0.182s)
[41.761485] Starting dynamic subtest: vecs0
[41.929991] Dynamic subtest vecs0: SUCCESS (0.183s)
[41.934501] Subtest basic-scanout: SUCCESS (1.248s)
[42.136853] [002/137] (958s left) kms_sequence (get-busy)
[42.374974] Starting subtest: get-busy
[42.378843] Starting dynamic subtest: HDMI-A-1-pipe-A
[45.185226] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (2.823s)
[45.199641] Starting dynamic subtest: HDMI-A-2-pipe-A
[47.809842] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (2.607s)
[47.826752] Starting dynamic subtest: HDMI-A-1-pipe-B
[50.601136] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (2.786s)
[50.618196] Starting dynamic subtest: HDMI-A-2-pipe-B
[53.366268] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (2.750s)
[53.398837] Starting dynamic subtest: HDMI-A-1-pipe-C
[56.207487] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (2.872s)
[56.221455] Starting dynamic subtest: HDMI-A-2-pipe-C
[59.120579] Dynamic subtest HDMI-A-2-pipe-C: SUCCESS (2.911s)
[59.135786] Subtest get-busy: SUCCESS (16.761s)
[59.357308] [003/137] (941s left) gem_tiled_blits (basic)
[60.407898] Starting subtest: basic
[60.455382] Subtest basic: SUCCESS (0.037s)
[60.585857] [004/137] (940s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[60.978247] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[60.985171] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[61.059648] [005/137] (940s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[61.278372] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[61.283049] Starting dynamic subtest: pipe-A-valid-mode
[62.218721] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.932s)
[62.222488] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.934s)
[62.478924] [006/137] (938s left) gem_mmap_gtt (big-bo-tiledy)
[62.635039] Starting subtest: big-bo-tiledY
[62.984264] Subtest big-bo-tiledY: SUCCESS (0.349s)
[63.137367] [007/137] (938s left) kms_flip (2x-plain-flip-interruptible)
[63.451354] Starting subtest: 2x-plain-flip-interruptible
[63.455087] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[65.033996] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.580s)
[65.054421] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[66.379751] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.333s)
[66.400468] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[67.722532] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.317s)
[67.737287] Subtest 2x-plain-flip-interruptible: SUCCESS (4.261s)
[68.253087] [008/137] (932s left) gem_pread (display)
[68.406214] Starting subtest: display
[72.278339] Subtest display: SUCCESS (3.862s)
[72.350598] [009/137] (928s left) syncobj_wait (wait-any-interrupted)
[72.507768] Starting subtest: wait-any-interrupted
[72.625449] Subtest wait-any-interrupted: SUCCESS (0.106s)
[72.699920] [010/137] (928s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[72.958099] Starting subtest: yf-tiled-8bpp-rotate-0
[72.979403] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[73.059946] [011/137] (928s left) kms_cursor_crc (cursor-random-64x21)
[73.307744] Starting subtest: cursor-random-64x21
[73.356785] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.506877] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.148s)
[77.572445] Starting dynamic subtest: pipe-B-HDMI-A-2
[81.523700] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.963s)
[81.604720] Starting dynamic subtest: pipe-C-HDMI-A-1
[85.788303] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.205s)
[85.792991] Subtest cursor-random-64x21: SUCCESS (12.476s)
[86.052932] [012/137] (915s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[86.255470] Subtest get-values-invalid-pointer: SKIP (0.000s)
[86.318103] [013/137] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[86.580448] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[86.587790] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[86.652135] [014/137] (914s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[86.910212] Starting subtest: x-tiled-32bpp-rotate-90
[87.183717] Subtest x-tiled-32bpp-rotate-90: SKIP (0.276s)
[87.368321] [015/137] (914s left) gem_exec_balancer (full-late-pulse)
[87.547843] Starting subtest: full-late-pulse
[90.560373] Subtest full-late-pulse: SUCCESS (3.008s)
[93.566383] [016/137] (907s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[93.818985] Starting subtest: fbcpsr-stridechange
[93.826338] Subtest fbcpsr-stridechange: SKIP (0.000s)
[93.885171] [017/137] (907s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[94.542503] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[95.580736] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (1.039s)
[96.238070] [018/137] (905s left) kms_busy (extended-modeset-hang-newfb)
[96.516583] Starting subtest: extended-modeset-hang-newfb
[96.520376] Starting dynamic subtest: pipe-A
[99.938276] Dynamic subtest pipe-A: SUCCESS (3.402s)
[99.970426] Starting dynamic subtest: pipe-C
[103.100386] Dynamic subtest pipe-C: SUCCESS (3.163s)
[103.110696] Subtest extended-modeset-hang-newfb: SUCCESS (6.581s)
[103.331253] [019/137] (898s left) vc4/vc4_tiling (get-bad-modifier)
[103.583555] Subtest get-bad-modifier: SKIP (0.000s)
[103.628718] [020/137] (897s left) tools_test (tools_test)
[103.844600] Starting subtest: tools_test
[104.090915] Subtest tools_test: SUCCESS (0.276s)
[104.155463] [021/137] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[104.399346] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[104.419328] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[104.479506] [022/137] (897s left) i915_pm_rpm (pm-caching)
[106.484100] Starting subtest: pm-caching
[108.141125] Subtest pm-caching: SUCCESS (1.655s)
[108.549276] [023/137] (893s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[108.791479] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[108.796408] Starting dynamic subtest: pipe-A-valid-mode
[109.361776] Dynamic subtest pipe-A-valid-mode: SKIP (0.567s)
[109.398017] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.569s)
[109.726999] [024/137] (892s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_mc_ccs)
[110.378787] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs
[110.386523] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[110.681449] [025/137] (891s left) kms_plane (plane-panning-bottom-right-suspend)
[110.928761] Starting subtest: plane-panning-bottom-right-suspend
[110.932313] Starting dynamic subtest: pipe-A-planes
[129.052030] Dynamic subtest pipe-A-planes: SUCCESS (2.634s)
[129.115221] Starting dynamic subtest: pipe-B-planes
[147.037599] Dynamic subtest pipe-B-planes: SUCCESS (2.463s)
[147.052359] Subtest plane-panning-bottom-right-suspend: SUCCESS (5.110s)
[152.288370] [026/137] (885s left) kms_cursor_legacy (single-bo)
[153.573917] Starting subtest: single-bo
[153.590359] Starting dynamic subtest: pipe-A
[174.139155] Dynamic subtest pipe-A: SUCCESS (21.518s)
[174.155520] Starting dynamic subtest: pipe-B
[195.647559] Dynamic subtest pipe-B: SUCCESS (21.505s)
[195.667220] Starting dynamic subtest: pipe-C
[217.145087] Dynamic subtest pipe-C: SUCCESS (21.497s)
[217.174092] Starting dynamic subtest: all-pipes
[238.632143] Dynamic subtest all-pipes: SUCCESS (21.499s)
[238.637559] Subtest single-bo: SUCCESS (86.022s)
[238.716091] [027/137] (799s left) prime_busy (hang)
[238.872248] Starting subtest: hang
[238.875727] Starting dynamic subtest: rcs0
[245.372248] Dynamic subtest rcs0: SUCCESS (6.496s)
[245.390087] Starting dynamic subtest: bcs0
[252.406052] Dynamic subtest bcs0: SUCCESS (7.038s)
[252.424399] Starting dynamic subtest: vcs0
[259.389894] Dynamic subtest vcs0: SUCCESS (6.976s)
[259.407749] Starting dynamic subtest: vecs0
[266.365016] Dynamic subtest vecs0: SUCCESS (6.975s)
[266.369877] Subtest hang: SUCCESS (27.489s)
[266.450237] [028/137] (771s left) gem_mmap_gtt (basic-write-read)
[266.594054] Starting subtest: basic-write-read
[266.607613] Subtest basic-write-read: SUCCESS (0.012s)
[266.699809] [029/137] (771s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[266.961322] Starting subtest: 4-tiled-8bpp-rotate-90
[266.970324] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[267.045393] [030/137] (770s left) gem_exec_reloc (basic-wc-read)
[267.205914] Starting subtest: basic-wc-read
[267.228525] Subtest basic-wc-read: SUCCESS (0.016s)
[267.396626] [031/137] (770s left) gem_partial_pwrite_pread (write-uncached)
[267.554023] Starting subtest: write-uncached
[280.250445] Subtest write-uncached: SUCCESS (12.702s)
[280.358369] [032/137] (757s left) gem_exec_fence (syncobj-timeline-unused-fence)
[281.077830] Starting subtest: syncobj-timeline-unused-fence
[281.081449] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[281.284151] [033/137] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[281.542204] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[281.549658] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[281.626148] [034/137] (756s left) gem_mmap_wc (bad-size)
[281.785314] Starting subtest: bad-size
[281.789166] Subtest bad-size: SUCCESS (0.001s)
[281.875101] [035/137] (756s left) gem_ctx_param (get-priority-new-ctx)
[282.046760] Starting subtest: get-priority-new-ctx
[282.051062] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[282.128858] [036/137] (756s left) gem_ctx_shared (exec-single-timeline)
[282.287445] Starting subtest: exec-single-timeline
[282.291622] Starting dynamic subtest: rcs0
[283.315360] Dynamic subtest rcs0: SUCCESS (1.024s)
[283.337804] Starting dynamic subtest: bcs0
[284.344172] Dynamic subtest bcs0: SUCCESS (1.023s)
[284.367191] Starting dynamic subtest: vcs0
[285.364362] Dynamic subtest vcs0: SUCCESS (1.023s)
[285.388224] Starting dynamic subtest: vecs0
[286.387854] Dynamic subtest vecs0: SUCCESS (1.023s)
[286.391586] Subtest exec-single-timeline: SUCCESS (4.097s)
[286.600502] [037/137] (751s left) kms_frontbuffer_tracking (fbc-suspend)
[286.838104] Starting subtest: fbc-suspend
[325.067287] Subtest fbc-suspend: SUCCESS (6.245s)
[329.311172] [038/137] (745s left) api_intel_bb (blit-reloc-purge-cache)
[329.568622] Starting subtest: blit-reloc-purge-cache
[329.580312] Subtest blit-reloc-purge-cache: SUCCESS (0.016s)
[329.682730] [039/137] (744s left) i915_hangman (error-state-basic)
[329.888747] Starting subtest: error-state-basic
[329.898412] Subtest error-state-basic: SUCCESS (0.024s)
[329.995955] [040/137] (744s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[330.709996] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[330.728190] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[331.057405] [041/137] (743s left) api_intel_bb (reset-bb)
[331.252570] Starting subtest: reset-bb
[331.256395] Subtest reset-bb: SUCCESS (0.007s)
[331.357717] [042/137] (743s left) i915_query (query-regions-garbage-items)
[331.497707] Starting subtest: query-regions-garbage-items
[331.502364] Subtest query-regions-garbage-items: SUCCESS (0.001s)
[331.585054] [043/137] (742s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[331.736406] Starting subtest: single-wait-for-submit-available-signaled
[331.740067] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[331.807299] [044/137] (742s left) gem_media_vme
[332.011112] [045/137] (742s left) syncobj_timeline (invalid-signal-illegal-handle)
[332.161310] Starting subtest: invalid-signal-illegal-handle
[332.164979] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[332.241854] [046/137] (742s left) gem_tiled_partial_pwrite_pread (writes)
[332.400791] Starting subtest: writes
[334.200770] Subtest writes: SUCCESS (1.789s)
[334.291159] [047/137] (740s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[334.564118] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[336.617655] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.059s)
[336.823481] [048/137] (737s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[337.152247] Starting subtest: addfb25-yf-tiled-legacy
[337.155664] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[337.323480] [049/137] (737s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[337.596231] Starting subtest: addfb25-framebuffer-vs-set-tiling
[337.599781] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[337.872902] [050/137] (736s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[338.510798] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[338.517906] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[338.878181] [051/137] (736s left) api_intel_allocator (gem-pool)
[339.037447] Starting subtest: gem-pool
[339.044639] Subtest gem-pool: SUCCESS (0.010s)
[339.144352] [052/137] (735s left) gem_exec_schedule (u-fairslice-all)
[339.322826] Starting subtest: u-fairslice-all
[341.438863] Subtest u-fairslice-all: SUCCESS (2.120s)
[341.761240] [053/137] (733s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[342.043182] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[342.060645] Starting dynamic subtest: pipe-A-HDMI-A-1
[343.223877] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.190s)
[343.253964] Starting dynamic subtest: pipe-B-HDMI-A-1
[344.507618] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.271s)
[344.536940] Starting dynamic subtest: pipe-C-HDMI-A-1
[344.935518] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.409s)
[344.939991] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (2.889s)
[345.341481] [054/137] (729s left) gem_userptr_blits (sd-probe)
[345.549132] Starting subtest: sd-probe
[345.552604] Subtest sd-probe: SUCCESS (0.001s)
[345.676228] [055/137] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[345.938145] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[347.937635] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.008s)
[348.075202] [056/137] (726s left) gem_exec_create (legacy)
[348.253221] Starting subtest: legacy
[348.256950] Starting dynamic subtest: smem
[350.307160] Dynamic subtest smem: SUCCESS (2.042s)
[350.310884] Subtest legacy: SUCCESS (2.043s)
[350.491200] [057/137] (724s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[351.233971] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[351.245879] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[351.515640] [058/137] (723s left) gem_close_race (multigpu-basic-threads)
[351.709986] Starting subtest: multigpu-basic-threads
[351.717148] Subtest multigpu-basic-threads: SKIP (0.000s)
[351.916251] [059/137] (723s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_ccs)
[352.695386] Subtest pipe-D-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[352.941659] [060/137] (722s left) gem_ppgtt (blt-vs-render-ctx0)
[353.122310] Starting subtest: blt-vs-render-ctx0
[385.828881] Subtest blt-vs-render-ctx0: SUCCESS (32.706s)
[385.939310] [061/137] (689s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[386.804950] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[386.827063] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[387.089707] [062/137] (688s left) gem_exec_reloc (basic-write-gtt-active)
[387.256777] Starting subtest: basic-write-gtt-active
[387.382859] Subtest basic-write-gtt-active: SUCCESS (0.128s)
[387.556125] [063/137] (687s left) gem_exec_reloc (basic-gtt-read)
[387.700776] Starting subtest: basic-gtt-read
[387.722722] Subtest basic-gtt-read: SUCCESS (0.018s)
[387.899251] [064/137] (687s left) kms_psr (psr2_suspend)
[388.088870] Subtest psr2_suspend: SKIP (0.000s)
[388.122477] [065/137] (687s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[388.885354] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[389.087634] [066/137] (686s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[389.334867] Starting subtest: bo-too-small-due-to-tiling
[389.338596] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[389.598865] [067/137] (685s left) kms_invalid_mode (bad-hsync-start)
[389.848925] Starting subtest: bad-hsync-start
[389.853985] Starting dynamic subtest: HDMI-A-1-pipe-A
[390.254863] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.421s)
[390.287160] Starting dynamic subtest: HDMI-A-2-pipe-A
[390.291086] Dynamic subtest HDMI-A-2-pipe-A: SUCCESS (0.003s)
[390.323388] Starting dynamic subtest: HDMI-A-1-pipe-B
[390.327124] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.002s)
[390.371005] Starting dynamic subtest: HDMI-A-2-pipe-B
[390.386609] Dynamic subtest HDMI-A-2-pipe-B: SUCCESS (0.006s)
[390.408778] Starting dynamic subtest: HDMI-A-1-pipe-C
[390.413829] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.003s)
[390.450377] Starting dynamic subtest: HDMI-A-2-pipe-C
[390.465855] Dynamic subtest HDMI-A-2-pipe-C: SUCCESS (0.002s)
[390.469697] Subtest bad-hsync-start: SUCCESS (0.464s)
[390.532432] [068/137] (685s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[390.777293] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[390.784573] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[390.864413] [069/137] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[391.119273] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[393.577031] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.467s)
[393.764060] [070/137] (681s left) kms_content_protection (lic)
[394.019662] Starting subtest: LIC
[395.794869] Subtest LIC: SKIP (1.758s)
[396.233914] [071/137] (679s left) v3d/v3d_mmap (mmap-bad-handle)
[396.463572] Subtest mmap-bad-handle: SKIP (0.000s)
[396.531227] [072/137] (679s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[397.185930] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[397.363531] [073/137] (678s left) i915_pm_rc6_residency (rc6-fence)
[397.505983] Starting subtest: rc6-fence
[412.742859] Subtest rc6-fence: SUCCESS (15.226s)
[413.010055] [074/137] (662s left) kms_flip (2x-plain-flip-ts-check)
[413.265336] Starting subtest: 2x-plain-flip-ts-check
[413.268938] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[424.496267] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.251s)
[424.523929] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[435.496313] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.004s)
[435.525918] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[446.491238] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.983s)
[446.494926] Subtest 2x-plain-flip-ts-check: SUCCESS (33.251s)
[446.983221] [075/137] (628s left) gem_ctx_param (invalid-get-engines)
[447.152388] Starting subtest: invalid-get-engines
[447.156114] Subtest invalid-get-engines: SUCCESS (0.001s)
[447.226837] [076/137] (628s left) gem_exec_fence (basic-busy-all)
[447.420388] Starting subtest: basic-busy-all
[447.435905] Subtest basic-busy-all: SUCCESS (0.020s)
[448.126435] [077/137] (627s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[448.269542] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[448.371174] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[448.470362] [078/137] (627s left) drm_fdinfo (busy-idle-check-all)
[448.615555] Starting subtest: busy-idle-check-all
[448.620225] Starting dynamic subtest: rcs0
[449.230832] Dynamic subtest rcs0: SUCCESS (0.621s)
[449.251657] Starting dynamic subtest: bcs0
[449.855316] Dynamic subtest bcs0: SUCCESS (0.619s)
[449.873808] Starting dynamic subtest: vcs0
[450.474890] Dynamic subtest vcs0: SUCCESS (0.621s)
[450.494068] Starting dynamic subtest: vecs0
[451.097581] Dynamic subtest vecs0: SUCCESS (0.619s)
[451.101230] Subtest busy-idle-check-all: SUCCESS (2.485s)
[451.194745] [079/137] (624s left) perf_pmu (faulting-read)
[451.337247] Starting subtest: faulting-read
[451.341218] Starting dynamic subtest: gtt
[451.347162] Dynamic subtest gtt: SUCCESS (0.003s)
[451.366166] Starting dynamic subtest: wb
[451.370391] Dynamic subtest wb: SUCCESS (0.002s)
[451.390609] Starting dynamic subtest: wc
[451.394580] Dynamic subtest wc: SUCCESS (0.001s)
[451.413457] Starting dynamic subtest: uc
[451.417956] Dynamic subtest uc: SUCCESS (0.001s)
[451.422336] Subtest faulting-read: SUCCESS (0.011s)
[451.471310] [080/137] (624s left) gem_render_copy (yf-tiled-to-vebox-linear)
[451.634173] Starting subtest: yf-tiled-to-vebox-linear
[451.642612] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[451.830352] [081/137] (624s left) prime_mmap (test_map_unmap)
[451.994550] Starting subtest: test_map_unmap
[451.998186] Starting dynamic subtest: test_map_unmap-smem
[452.001920] Dynamic subtest test_map_unmap-smem: SUCCESS (0.008s)
[452.005523] Subtest test_map_unmap: SUCCESS (0.008s)
[452.079994] [082/137] (624s left) perf_pmu (invalid-init)
[452.258321] Starting subtest: invalid-init
[452.262542] Subtest invalid-init: SUCCESS (0.001s)
[452.341342] [083/137] (623s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[453.070338] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[453.286006] [084/137] (622s left) syncobj_timeline (multi-wait-submitted-signaled)
[453.431051] Starting subtest: multi-wait-submitted-signaled
[453.449392] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[453.521161] [085/137] (622s left) gen7_exec_parse (basic-rejected)
[453.684373] Subtest basic-rejected: SKIP (0.000s)
[453.740639] [086/137] (622s left) gem_lmem_swapping (heavy-multi)
[453.906999] Subtest heavy-multi: SKIP (0.000s)
[453.958041] [087/137] (622s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[454.106577] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[454.113903] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[454.303242] [088/137] (622s left) gem_exec_schedule (preempt-engines)
[454.526307] Starting subtest: preempt-engines
[454.530019] Starting dynamic subtest: rcs0
[454.705934] Dynamic subtest rcs0: SUCCESS (0.214s)
[454.737365] Starting dynamic subtest: bcs0
[454.945746] Dynamic subtest bcs0: SUCCESS (0.245s)
[454.964540] Starting dynamic subtest: vcs0
[455.138875] Dynamic subtest vcs0: SUCCESS (0.190s)
[455.161955] Starting dynamic subtest: vecs0
[455.327196] Dynamic subtest vecs0: SUCCESS (0.188s)
[455.330881] Subtest preempt-engines: SUCCESS (0.842s)
[455.670075] [089/137] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[455.925743] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[455.932805] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[456.015824] [090/137] (620s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[456.264528] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[469.577176] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (12.054s)
[469.651234] [091/137] (606s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[469.926010] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[469.934140] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[469.984793] [092/137] (606s left) gem_exec_reloc (basic-wc-noreloc)
[470.135782] Starting subtest: basic-wc-noreloc
[470.154535] Subtest basic-wc-noreloc: SUCCESS (0.010s)
[470.318008] [093/137] (606s left) kms_properties (plane-properties-atomic)
[470.569883] Starting subtest: plane-properties-atomic
[471.710030] Subtest plane-properties-atomic: SUCCESS (1.151s)
[471.984263] [094/137] (604s left) fbdev (write)
[472.144322] Starting subtest: write
[472.912578] Subtest write: SUCCESS (0.768s)
[472.985988] [095/137] (603s left) kms_cursor_crc (cursor-sliding-512x512)
[473.249265] Starting subtest: cursor-sliding-512x512
[473.272414] Subtest cursor-sliding-512x512: SKIP (0.003s)
[473.352937] [096/137] (603s left) kms_content_protection (dp-mst-type-0)
[473.603614] Starting subtest: dp-mst-type-0
[473.617775] Subtest dp-mst-type-0: SKIP (0.001s)
[473.715735] [097/137] (603s left) kms_panel_fitting (atomic-fastset)
[473.952771] Starting subtest: atomic-fastset
[473.960568] Subtest atomic-fastset: SKIP (0.001s)
[474.036010] [098/137] (602s left) v3d/v3d_submit_csd (multiple-job-submission)
[474.255300] Subtest multiple-job-submission: SKIP (0.000s)
[474.302332] [099/137] (602s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[474.557598] Starting subtest: 4-tiled-64bpp-rotate-270
[474.564335] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[474.636620] [100/137] (602s left) gem_pxp (regular-baseline-src-copy-readible)
[477.315463] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[477.380339] [101/137] (599s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[477.544112] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[477.619464] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[477.717035] [102/137] (599s left) v3d/v3d_get_bo_offset (create-get-offsets)
[477.905648] Subtest create-get-offsets: SKIP (0.000s)
[477.981298] [103/137] (599s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[478.225914] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[479.176486] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.952s)
[479.419543] [104/137] (597s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[479.691484] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[479.705926] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[479.762118] [105/137] (597s left) perf (gen12-group-concurrent-oa-buffer-read)
[480.034260] Subtest gen12-group-concurrent-oa-buffer-read: SKIP (0.000s)
[480.069404] [106/137] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[480.338423] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[480.346044] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[480.430143] [107/137] (596s left) v3d/v3d_submit_cl (multi-and-single-sync)
[480.615655] Subtest multi-and-single-sync: SKIP (0.000s)
[480.694451] [108/137] (596s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[480.838497] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[480.888291] [109/137] (596s left) prime_vgem (basic-blt)
[481.055722] Starting subtest: basic-blt
[481.101328] Subtest basic-blt: SUCCESS (0.046s)
[481.199110] [110/137] (596s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[481.439563] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[481.682089] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.231s)
[481.865998] [111/137] (595s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[482.135826] Starting subtest: plane-all-modeset-transition-internal-panels
[482.143256] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[482.230807] [112/137] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[482.493112] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[482.506339] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[482.576010] [113/137] (594s left) kms_vblank (pipe-c-wait-busy)
[482.829701] Starting subtest: pipe-C-wait-busy
[488.986278] Subtest pipe-C-wait-busy: SUCCESS (6.175s)
[489.227596] [114/137] (588s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[489.460363] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[493.573953] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (4.120s)
[494.015781] [115/137] (583s left) kms_chamelium_frames (dp-crc-fast)
[494.634476] Subtest dp-crc-fast: SKIP (0.000s)
[494.851153] [116/137] (582s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs)
[495.612783] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs
[495.620032] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.001s)
[495.908731] [117/137] (581s left) gem_userptr_blits (unsync-overlap)
[496.065278] Subtest unsync-overlap: SKIP (0.000s)
[496.191121] [118/137] (581s left) gem_ctx_persistence (legacy-engines-mixed)
[496.341410] Starting subtest: legacy-engines-mixed
[496.344977] Starting dynamic subtest: render
[496.376308] Dynamic subtest render: SUCCESS (0.038s)
[496.410339] Starting dynamic subtest: bsd
[496.430189] Dynamic subtest bsd: SUCCESS (0.050s)
[496.463940] Starting dynamic subtest: blt
[496.488277] Dynamic subtest blt: SUCCESS (0.050s)
[496.517116] Starting dynamic subtest: vebox
[496.529438] Dynamic subtest vebox: SUCCESS (0.045s)
[496.535100] Subtest legacy-engines-mixed: SUCCESS (0.191s)
[496.635208] [119/137] (581s left) kms_flip (wf_vblank-ts-check-interruptible)
[496.912087] Starting subtest: wf_vblank-ts-check-interruptible
[496.915752] Starting dynamic subtest: A-HDMI-A1
[502.870214] Dynamic subtest A-HDMI-A1: SUCCESS (5.968s)
[502.889275] Starting dynamic subtest: B-HDMI-A1
[508.514148] Dynamic subtest B-HDMI-A1: SUCCESS (5.645s)
[508.545026] Starting dynamic subtest: C-HDMI-A1
[514.177186] Dynamic subtest C-HDMI-A1: SUCCESS (5.648s)
[514.205167] Starting dynamic subtest: A-HDMI-A2
[519.793083] Dynamic subtest A-HDMI-A2: SUCCESS (5.636s)
[519.816105] Starting dynamic subtest: B-HDMI-A2
[525.463786] Dynamic subtest B-HDMI-A2: SUCCESS (5.670s)
[525.485951] Starting dynamic subtest: C-HDMI-A2
[531.134301] Dynamic subtest C-HDMI-A2: SUCCESS (5.655s)
[531.137621] Subtest wf_vblank-ts-check-interruptible: SUCCESS (34.245s)
[531.532415] [120/137] (546s left) kms_vblank (pipe-c-wait-idle-hang)
[531.772991] Starting subtest: pipe-C-wait-idle-hang
[546.524241] Subtest pipe-C-wait-idle-hang: SUCCESS (14.761s)
[546.817067] [121/137] (531s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-0-25)
[547.059232] Starting subtest: planes-downscale-factor-0-25-upscale-0-25
[547.062810] Starting dynamic subtest: pipe-A-HDMI-A-1
[547.214992] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.144s)
[547.234410] Starting dynamic subtest: pipe-B-HDMI-A-1
[547.305338] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.090s)
[547.334069] Starting dynamic subtest: pipe-C-HDMI-A-1
[547.450391] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.140s)
[547.457715] Subtest planes-downscale-factor-0-25-upscale-0-25: SKIP (0.386s)
[547.535631] [122/137] (530s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[547.809367] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[550.224254] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.436s)
[550.381859] [123/137] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[550.653327] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[553.249149] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SUCCESS (2.601s)
[553.415437] [124/137] (524s left) gem_exec_flush (basic-wb-pro-default)
[553.600017] Starting subtest: basic-wb-pro-default
[559.015731] Subtest basic-wb-pro-default: SUCCESS (5.415s)
[559.235346] [125/137] (518s left) kms_lease (invalid-create-leases)
[559.479641] Starting subtest: invalid-create-leases
[559.492398] Subtest invalid-create-leases: SUCCESS (0.012s)
[559.592135] [126/137] (518s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[559.874191] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[561.827415] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (1.974s)
[562.034037] [127/137] (516s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[562.195004] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[562.261040] [128/137] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[562.519454] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[562.526517] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[562.615644] [129/137] (515s left) syncobj_wait (invalid-wait-zero-handles)
[562.774513] Starting subtest: invalid-wait-zero-handles
[562.777830] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[562.873689] [130/137] (515s left) sw_sync (alloc_fence_invalid_timeline)
[563.007319] Starting subtest: alloc_fence_invalid_timeline
[563.011910] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[563.093267] [131/137] (515s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[563.255490] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[563.259183] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[563.335339] [132/137] (515s left) kms_addfb_basic (bad-pitch-63)
[563.484912] Starting subtest: bad-pitch-63
[563.488449] Subtest bad-pitch-63: SUCCESS (0.000s)
[563.831935] [133/137] (514s left) i915_hangman (detector)
[563.995840] Starting subtest: detector
[563.999430] Starting dynamic subtest: rcs0
[573.818661] Dynamic subtest rcs0: SUCCESS (9.823s)
[573.850331] Starting dynamic subtest: bcs0
[583.797319] Dynamic subtest bcs0: SUCCESS (9.976s)
[583.840028] Starting dynamic subtest: vcs0
[593.687572] Dynamic subtest vcs0: SUCCESS (9.889s)
[593.711537] Starting dynamic subtest: vecs0
[603.689475] Dynamic subtest vecs0: SUCCESS (9.990s)
[603.693299] Subtest detector: SUCCESS (39.684s)
[603.784755] [134/137] (474s left) gem_exec_basic (basic)
[603.937485] Starting subtest: basic
[603.941063] Starting dynamic subtest: rcs0-smem
[603.945222] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[603.963866] Starting dynamic subtest: bcs0-smem
[603.967436] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[604.000585] Starting dynamic subtest: vcs0-smem
[604.005609] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[604.024894] Starting dynamic subtest: vecs0-smem
[604.029210] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[604.033131] Subtest basic: SUCCESS (0.009s)
[604.163363] [135/137] (474s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[604.382528] Starting subtest: disable-crc-after-crtc
[604.386623] Starting dynamic subtest: pipe-A-HDMI-A-1
[605.483163] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.090s)
[605.512922] Starting dynamic subtest: pipe-B-HDMI-A-2
[606.553061] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.070s)
[606.584467] Starting dynamic subtest: pipe-C-HDMI-A-1
[607.861500] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.289s)
[607.866926] Subtest disable-crc-after-crtc: SUCCESS (3.463s)
[608.100184] [136/137] (470s left) gem_exec_store (dword)
[608.283665] Starting subtest: dword
[608.287798] Starting dynamic subtest: rcs0
[608.310974] Dynamic subtest rcs0: SUCCESS (0.019s)
[608.356197] Starting dynamic subtest: bcs0
[608.359918] Dynamic subtest bcs0: SUCCESS (0.017s)
[608.379370] Starting dynamic subtest: vcs0
[608.382996] Dynamic subtest vcs0: SUCCESS (0.023s)
[608.400933] Starting dynamic subtest: vecs0
[608.404582] Dynamic subtest vecs0: SUCCESS (0.013s)
[608.408507] Subtest dword: SUCCESS (0.076s)
[608.551243] [137/137] (470s left) syncobj_wait (wait-all-snapshot)
[608.696227] Starting subtest: wait-all-snapshot
[608.770468] Subtest wait-all-snapshot: SUCCESS (0.083s)
[608.857651] Closing watchdogs
Done.