[52.827931] Initializing watchdogs
[52.828490]   /dev/watchdog0
[52.860206] [001/141] (960s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[53.385180] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[53.391533] Starting dynamic subtest: pipe-A-default-mode
[53.816497] Dynamic subtest pipe-A-default-mode: SKIP (0.420s)
[53.823125] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.429s)
[54.764361] [002/141] (958s left) gem_userptr_blits (readonly-pwrite-unsync)
[55.204741] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[55.461549] [003/141] (958s left) perf (polling-parameterized)
[56.390870] Starting subtest: polling-parameterized
[76.491959] Subtest polling-parameterized: SUCCESS (20.099s)
[76.580748] [004/141] (937s left) gem_sync (basic-store-each)
[77.018271] Starting subtest: basic-store-each
[79.427495] Subtest basic-store-each: SUCCESS (2.406s)
[79.720734] [005/141] (933s left) gem_exec_reloc (basic-wc-noreloc)
[80.130425] Subtest basic-wc-noreloc: SKIP (0.000s)
[80.269139] [006/141] (933s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[80.810845] Starting subtest: yf-tiled-8bpp-rotate-270
[80.817442] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[80.973881] [007/141] (932s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[81.483909] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[81.490628] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[81.638473] [008/141] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[82.138139] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[82.144977] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[82.282659] [009/141] (931s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[83.191729] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[92.050539] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SUCCESS (8.858s)
[93.986246] [010/141] (920s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs)
[95.751894] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs
[95.761498] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[96.431089] [011/141] (917s left) v3d/v3d_submit_cl (bad-pad)
[96.884946] Subtest bad-pad: SKIP (0.000s)
[96.996436] [012/141] (917s left) sysfs_timeslice_duration (idempotent)
[97.383937] Starting subtest: idempotent
[97.387562] Starting dynamic subtest: vecs0
[97.391127] Dynamic subtest vecs0: SUCCESS (0.002s)
[97.424379] Starting dynamic subtest: ccs0
[97.427422] Dynamic subtest ccs0: SUCCESS (0.002s)
[97.461878] Starting dynamic subtest: vcs0
[97.465421] Dynamic subtest vcs0: SUCCESS (0.002s)
[97.496086] Starting dynamic subtest: bcs0
[97.499606] Dynamic subtest bcs0: SUCCESS (0.002s)
[97.530857] Starting dynamic subtest: rcs0
[97.535160] Dynamic subtest rcs0: SUCCESS (0.003s)
[97.565874] Starting dynamic subtest: vcs1
[97.569308] Dynamic subtest vcs1: SUCCESS (0.002s)
[97.572603] Subtest idempotent: SUCCESS (0.022s)
[97.618498] [013/141] (916s left) gem_sync (basic-each)
[98.033318] Starting subtest: basic-each
[100.941171] Subtest basic-each: SUCCESS (2.907s)
[101.230541] [014/141] (913s left) gem_lmem_swapping (heavy-verify-random)
[101.621721] Subtest heavy-verify-random: SKIP (0.000s)
[101.738084] [015/141] (912s left) gem_ctx_param (invalid-ctx-get)
[102.105784] Starting subtest: invalid-ctx-get
[102.109443] Subtest invalid-ctx-get: SUCCESS (0.000s)
[102.254938] [016/141] (912s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[102.769580] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[118.360992] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (15.594s)
[118.666746] [017/141] (895s left) kms_invalid_mode (bad-hsync-end)
[119.143523] Starting subtest: bad-hsync-end
[119.147084] Starting dynamic subtest: eDP-1-pipe-A
[119.540967] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.397s)
[119.571483] Starting dynamic subtest: eDP-1-pipe-B
[119.581459] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.034s)
[119.607237] Starting dynamic subtest: eDP-1-pipe-C
[119.617549] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.032s)
[119.647328] Starting dynamic subtest: eDP-1-pipe-D
[119.657370] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.033s)
[119.660855] Subtest bad-hsync-end: SUCCESS (0.518s)
[120.436489] [018/141] (894s left) gem_exec_reloc (basic-cpu-wc-active)
[120.827069] Subtest basic-cpu-wc-active: SKIP (0.000s)
[120.948552] [019/141] (893s left) kms_prop_blob (blob-prop-core)
[121.306630] Starting subtest: blob-prop-core
[121.311164] Subtest blob-prop-core: SUCCESS (0.000s)
[121.426775] [020/141] (893s left) kms_pipe_crc_basic (hang-read-crc)
[121.776544] Starting subtest: hang-read-crc
[121.779658] Starting dynamic subtest: pipe-A-eDP-1
[126.052971] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.272s)
[126.090982] Starting dynamic subtest: pipe-B-eDP-1
[131.684565] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.623s)
[131.722073] Starting dynamic subtest: pipe-C-eDP-1
[137.385441] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.699s)
[137.425397] Starting dynamic subtest: pipe-D-eDP-1
[144.138120] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.739s)
[144.141857] Subtest hang-read-crc: SUCCESS (22.358s)
[145.072781] [021/141] (869s left) kms_vrr (negative-basic)
[145.566084] Starting subtest: negative-basic
[145.574753] Starting dynamic subtest: pipe-A-eDP-1
[151.757383] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.184s)
[151.761167] Subtest negative-basic: SUCCESS (6.191s)
[152.699533] [022/141] (862s left) i915_pm_freq_api (freq-reset-multiple)
[153.116610] Starting subtest: freq-reset-multiple
[153.120420] Starting dynamic subtest: gt0
[183.969668] Dynamic subtest gt0: SUCCESS (30.848s)
[184.003686] Starting dynamic subtest: gt1
[234.678181] Dynamic subtest gt1: SUCCESS (50.704s)
[234.681224] Subtest freq-reset-multiple: SUCCESS (81.558s)
[234.853121] [023/141] (780s left) gem_exec_schedule (u-semaphore-noskip)
[235.293413] Starting subtest: u-semaphore-noskip
[236.184397] Subtest u-semaphore-noskip: SUCCESS (0.890s)
[236.673197] [024/141] (778s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[237.649390] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[237.652269] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[239.017490] [025/141] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[239.529531] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[239.536202] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.690762] [026/141] (775s left) gem_ctx_param (set-priority-range)
[240.071491] Starting subtest: set-priority-range
[240.192931] Subtest set-priority-range: SUCCESS (0.126s)
[240.338395] [027/141] (774s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_ccs)
[242.096295] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_ccs
[242.102796] Subtest pipe-D-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[242.726763] [028/141] (772s left) kms_cursor_crc (cursor-onscreen-256x85)
[243.844300] Starting subtest: cursor-onscreen-256x85
[243.878708] Starting dynamic subtest: pipe-A-eDP-1
[247.876884] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.995s)
[248.066081] Starting dynamic subtest: pipe-D-eDP-1
[253.278971] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.245s)
[253.282460] Subtest cursor-onscreen-256x85: SUCCESS (9.432s)
[254.227811] [029/141] (761s left) kms_plane_alpha_blend (constant-alpha-min)
[254.648450] Starting subtest: constant-alpha-min
[256.056828] Starting dynamic subtest: pipe-A-eDP-1
[257.101111] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.036s)
[257.139356] Starting dynamic subtest: pipe-D-eDP-1
[258.928222] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.823s)
[258.932587] Subtest constant-alpha-min: SUCCESS (4.274s)
[259.828252] [030/141] (755s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[261.259787] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[261.266563] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[262.255254] [031/141] (753s left) syncobj_timeline (wait-any-complex)
[262.651794] Starting subtest: wait-any-complex
[262.719654] Subtest wait-any-complex: SUCCESS (0.068s)
[262.857670] [032/141] (752s left) vc4/vc4_perfmon (create-single-perfmon)
[263.325410] Subtest create-single-perfmon: SKIP (0.000s)
[263.446088] [033/141] (752s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs)
[264.555185] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs
[264.558824] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[265.814678] [034/141] (750s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[266.724453] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[267.578928] [035/141] (748s left) gem_pxp (reject-modify-context-protection-off-3)
[270.474838] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[270.611093] [036/141] (745s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[272.792505] Starting subtest: syncobj-stationary-timeline-chain-engines
[273.128069] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.335s)
[273.744896] [037/141] (742s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[274.332256] Starting subtest: basic-busy-flip-before-cursor-legacy
[274.339290] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[274.625511] [038/141] (741s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[275.029897] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[275.151680] [039/141] (741s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[275.663240] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[275.670084] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[275.830709] [040/141] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[276.343756] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[276.350628] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[276.510543] [041/141] (739s left) kms_rotation_crc (primary-rotation-180)
[276.989834] Starting subtest: primary-rotation-180
[291.865053] Subtest primary-rotation-180: SUCCESS (14.876s)
[293.466594] [042/141] (723s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[294.005762] Starting subtest: x-tiled-64bpp-rotate-180
[299.942073] Subtest x-tiled-64bpp-rotate-180: SUCCESS (5.931s)
[300.842767] [043/141] (715s left) kms_addfb_basic (legacy-format)
[301.079782] Starting subtest: legacy-format
[301.307303] Subtest legacy-format: SUCCESS (0.224s)
[301.868462] [044/141] (714s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs)
[303.226106] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs
[303.232758] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[304.277374] [045/141] (712s left) perf (gen12-invalid-class-instance)
[304.921952] Starting subtest: gen12-invalid-class-instance
[304.953771] Subtest gen12-invalid-class-instance: SUCCESS (0.031s)
[305.064184] [046/141] (711s left) i915_pm_rps (thresholds-idle-park)
[305.462354] Starting subtest: thresholds-idle-park
[305.466517] Starting dynamic subtest: gt0
[305.483991] Dynamic subtest gt0: SKIP (0.015s)
[305.503190] Starting dynamic subtest: gt1
[305.508994] Dynamic subtest gt1: SKIP (0.003s)
[305.514948] Subtest thresholds-idle-park: SKIP (0.028s)
[305.654114] [047/141] (711s left) gem_exec_reloc (basic-gtt-wc)
[306.082568] Subtest basic-gtt-wc: SKIP (0.000s)
[306.218502] [048/141] (710s left) gem_ppgtt (shrink-vs-evict-any)
[306.616308] Starting subtest: shrink-vs-evict-any
[314.585538] Subtest shrink-vs-evict-any: SUCCESS (7.975s)
[314.769172] [049/141] (702s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[315.339122] Starting subtest: 2x-cursor-vs-flip-atomic
[315.355405] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.015s)
[315.683805] [050/141] (701s left) kms_vblank (pipe-d-query-forked-busy-hang)
[316.155587] Starting subtest: pipe-D-query-forked-busy-hang
[332.819534] Subtest pipe-D-query-forked-busy-hang: SUCCESS (16.662s)
[333.765111] [051/141] (683s left) i915_pm_rpm (gem-evict-pwrite)
[339.859262] Starting subtest: gem-evict-pwrite
[339.866376] Subtest gem-evict-pwrite: SKIP (0.000s)
[340.793425] [052/141] (676s left) gem_exec_reloc (basic-write-cpu-noreloc)
[341.200438] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[341.327699] [053/141] (676s left) gem_exec_whisper (basic-fds-priority)
[341.753240] Starting subtest: basic-fds-priority
[369.162740] Subtest basic-fds-priority: SUCCESS (27.407s)
[369.459532] [054/141] (648s left) kms_ccs (pipe-b-random-ccs-data-yf_tiled_ccs)
[370.709332] Starting subtest: pipe-B-random-ccs-data-yf_tiled_ccs
[370.718591] Subtest pipe-B-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[371.893202] [055/141] (645s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[372.433892] Starting subtest: y-tiled-32bpp-rotate-270
[372.442279] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[372.604140] [056/141] (645s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[373.127058] Starting subtest: y-tiled-16bpp-rotate-180
[373.134475] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[373.306835] [057/141] (644s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[374.439587] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[375.738553] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.299s)
[377.345661] [058/141] (640s left) kms_psr (psr2_cursor_mmap_cpu)
[377.836349] Starting subtest: psr2_cursor_mmap_cpu
[380.921314] Subtest psr2_cursor_mmap_cpu: SUCCESS (3.082s)
[381.860962] [059/141] (636s left) kms_hdmi_inject (inject-4k)
[382.650394] Starting subtest: inject-4k
[383.171202] Subtest inject-4k: SUCCESS (0.521s)
[383.814189] [060/141] (634s left) gem_ctx_shared (exec-single-timeline)
[384.254940] Starting subtest: exec-single-timeline
[384.258736] Starting dynamic subtest: rcs0
[385.368457] Dynamic subtest rcs0: SUCCESS (1.111s)
[385.408466] Starting dynamic subtest: bcs0
[386.456907] Dynamic subtest bcs0: SUCCESS (1.084s)
[386.503171] Starting dynamic subtest: vcs0
[387.544638] Dynamic subtest vcs0: SUCCESS (1.084s)
[387.586664] Starting dynamic subtest: vcs1
[388.633283] Dynamic subtest vcs1: SUCCESS (1.084s)
[388.673721] Starting dynamic subtest: vecs0
[389.721948] Dynamic subtest vecs0: SUCCESS (1.084s)
[389.761653] Starting dynamic subtest: ccs0
[390.809151] Dynamic subtest ccs0: SUCCESS (1.084s)
[390.812757] Subtest exec-single-timeline: SUCCESS (6.556s)
[391.699764] [061/141] (626s left) gem_exec_schedule (preempt-other-chain)
[392.165802] Starting subtest: preempt-other-chain
[392.169387] Starting dynamic subtest: rcs0
[392.761321] Dynamic subtest rcs0: SUCCESS (0.597s)
[392.801184] Starting dynamic subtest: bcs0
[393.339144] Dynamic subtest bcs0: SUCCESS (0.574s)
[393.381162] Starting dynamic subtest: vcs0
[393.920726] Dynamic subtest vcs0: SUCCESS (0.577s)
[393.966289] Starting dynamic subtest: vcs1
[394.520573] Dynamic subtest vcs1: SUCCESS (0.596s)
[394.565575] Starting dynamic subtest: vecs0
[395.107658] Dynamic subtest vecs0: SUCCESS (0.582s)
[395.150203] Starting dynamic subtest: ccs0
[395.760952] Dynamic subtest ccs0: SUCCESS (0.649s)
[395.764890] Subtest preempt-other-chain: SUCCESS (3.600s)
[397.647661] [062/141] (620s left) kms_cdclk (mode-transition)
[398.141694] Starting subtest: mode-transition
[398.145336] Starting dynamic subtest: pipe-A-eDP-1
[398.566828] Dynamic subtest pipe-A-eDP-1: SKIP (0.418s)
[398.613069] Starting dynamic subtest: pipe-B-eDP-1
[398.620126] Dynamic subtest pipe-B-eDP-1: SKIP (0.028s)
[398.666149] Starting dynamic subtest: pipe-C-eDP-1
[398.673102] Dynamic subtest pipe-C-eDP-1: SKIP (0.029s)
[398.719580] Starting dynamic subtest: pipe-D-eDP-1
[398.726698] Dynamic subtest pipe-D-eDP-1: SKIP (0.029s)
[398.733665] Subtest mode-transition: SKIP (0.529s)
[399.502331] [063/141] (618s left) gen9_exec_parse (bb-secure)
[399.902861] Subtest bb-secure: SKIP (0.000s)
[400.018755] [064/141] (618s left) kms_addfb_basic (invalid-get-prop-any)
[400.402808] Starting subtest: invalid-get-prop-any
[400.405890] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[400.683228] [065/141] (617s left) api_intel_allocator (reserve-simple)
[401.061865] Starting subtest: reserve-simple
[401.070363] Subtest reserve-simple: SUCCESS (0.008s)
[401.248415] [066/141] (617s left) kms_psr (primary_render)
[401.686236] Starting subtest: primary_render
[403.694483] Subtest primary_render: SUCCESS (2.008s)
[404.600270] [067/141] (613s left) gem_ctx_engines (none)
[404.799855] Starting subtest: none
[404.807302] Subtest none: SUCCESS (0.004s)
[405.078046] [068/141] (613s left) gem_exec_fair (basic-pace-share)
[405.480605] Subtest basic-pace-share: SKIP (0.000s)
[405.641197] [069/141] (613s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[407.057149] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[408.056634] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.998s)
[409.433774] [070/141] (609s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[409.818916] Starting subtest: multi-wait-all-for-submit-available-submitted
[409.822978] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.003s)
[409.974464] [071/141] (608s left) gem_exec_parallel (userptr)
[410.392484] Starting subtest: userptr
[410.396163] Starting dynamic subtest: rcs0
[414.561286] Dynamic subtest rcs0: SUCCESS (4.167s)
[414.613147] Starting dynamic subtest: bcs0
[418.911742] Dynamic subtest bcs0: SUCCESS (4.344s)
[418.965967] Starting dynamic subtest: vcs0
[423.459153] Dynamic subtest vcs0: SUCCESS (4.541s)
[423.502343] Starting dynamic subtest: vcs1
[426.520830] Dynamic subtest vcs1: SUCCESS (3.058s)
[426.577165] Starting dynamic subtest: vecs0
[429.490173] Dynamic subtest vecs0: SUCCESS (2.964s)
[429.548520] Starting dynamic subtest: ccs0
[433.900159] Dynamic subtest ccs0: SUCCESS (4.404s)
[433.904220] Subtest userptr: SUCCESS (23.510s)
[434.239102] [072/141] (584s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[434.676657] Starting subtest: basic-batch-kernel-default-cmd
[434.682867] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[434.980296] [073/141] (584s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[435.425917] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[435.458406] Starting dynamic subtest: A-eDP1
[444.947174] Dynamic subtest A-eDP1: SUCCESS (9.488s)
[444.993136] Starting dynamic subtest: B-eDP1
[454.252403] Dynamic subtest B-eDP1: SUCCESS (9.298s)
[454.296194] Starting dynamic subtest: C-eDP1
[463.560157] Dynamic subtest C-eDP1: SUCCESS (9.303s)
[463.604874] Starting dynamic subtest: D-eDP1
[472.859707] Dynamic subtest D-eDP1: SUCCESS (9.291s)
[472.884850] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (37.459s)
[474.399906] [074/141] (544s left) kms_vblank (pipe-b-query-forked-busy)
[474.880878] Starting subtest: pipe-B-query-forked-busy
[478.450527] Subtest pipe-B-query-forked-busy: SUCCESS (3.574s)
[479.439752] [075/141] (539s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[479.943262] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[479.948933] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[480.087187] [076/141] (539s left) kms_force_connector_basic (prune-stale-modes)
[480.475942] Starting subtest: prune-stale-modes
[480.742525] Subtest prune-stale-modes: SKIP (0.257s)
[481.004932] [077/141] (538s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[482.813886] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[482.824680] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.013s)
[483.426453] [078/141] (536s left) kms_vblank (pipe-a-query-forked-busy-hang)
[483.916852] Starting subtest: pipe-A-query-forked-busy-hang
[498.813802] Subtest pipe-A-query-forked-busy-hang: SUCCESS (14.896s)
[499.762423] [079/141] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[500.280923] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[500.287999] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[500.448065] [080/141] (519s left) gem_exec_balancer (bonded-dual)
[500.889278] Starting subtest: bonded-dual
[500.896127] Subtest bonded-dual: SKIP (0.001s)
[501.879458] [081/141] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[502.398552] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[502.405597] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[502.563589] [082/141] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[503.089260] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[503.096193] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[503.254999] [083/141] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[503.773911] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[503.780885] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[503.945498] [084/141] (516s left) sw_sync (sync_busy_fork_unixsocket)
[504.320311] Starting subtest: sync_busy_fork_unixsocket
[504.385653] Subtest sync_busy_fork_unixsocket: SUCCESS (0.066s)
[504.528161] [085/141] (515s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[504.908621] Starting subtest: invalid-signal-one-illegal-handle
[504.912393] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.002s)
[505.063537] [086/141] (515s left) gem_mmap (big-bo)
[505.452848] Subtest big-bo: SKIP (0.000s)
[505.571796] [087/141] (514s left) vgem_basic (debugfs)
[505.968748] Starting subtest: debugfs
[505.972459] Subtest debugfs: SUCCESS (0.003s)
[506.098966] [088/141] (514s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[506.625383] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[523.094641] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (16.479s)
[523.400738] [089/141] (497s left) kms_flip (flip-vs-expired-vblank)
[523.796371] Starting subtest: flip-vs-expired-vblank
[523.824288] Starting dynamic subtest: A-eDP1
[533.087911] Dynamic subtest A-eDP1: SUCCESS (9.264s)
[533.136969] Starting dynamic subtest: B-eDP1
[542.183124] Dynamic subtest B-eDP1: SUCCESS (9.090s)
[542.233093] Starting dynamic subtest: C-eDP1
[551.272180] Dynamic subtest C-eDP1: SUCCESS (9.083s)
[551.319236] Starting dynamic subtest: D-eDP1
[560.354975] Dynamic subtest D-eDP1: SUCCESS (9.074s)
[560.377695] Subtest flip-vs-expired-vblank: SUCCESS (36.585s)
[561.955810] [090/141] (458s left) dmabuf (all-tests)
[562.339835] Starting subtest: all-tests
[562.343380] Starting dynamic subtest: sanitycheck
[562.422429] Dynamic subtest sanitycheck: SUCCESS (0.088s)
[562.464271] Starting dynamic subtest: dma_fence
[562.646973] Dynamic subtest dma_fence: SUCCESS (0.222s)
[562.701442] Starting dynamic subtest: dma_fence_chain
[574.870561] Dynamic subtest dma_fence_chain: SUCCESS (12.217s)
[574.938140] Starting dynamic subtest: dma_fence_unwrap
[574.970989] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[575.020854] Starting dynamic subtest: dma_resv
[575.058776] Dynamic subtest dma_resv: SUCCESS (0.083s)
[575.062393] Subtest all-tests: SUCCESS (12.727s)
[575.209514] [091/141] (445s left) v3d/v3d_submit_csd (single-in-sync)
[575.713805] Subtest single-in-sync: SKIP (0.000s)
[575.861326] [092/141] (444s left) gem_close_race (basic-process)
[576.312613] Starting subtest: basic-process
[576.412090] Subtest basic-process: SUCCESS (0.099s)
[576.723646] [093/141] (444s left) kms_getfb (getfb2-handle-protection)
[577.115561] Starting subtest: getfb2-handle-protection
[577.177786] Subtest getfb2-handle-protection: SUCCESS (0.063s)
[577.388457] [094/141] (443s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[578.389261] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[578.396530] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[579.240110] [095/141] (441s left) i915_module_load (reload)
[579.611873] Starting subtest: reload
[585.820800] Subtest reload: SUCCESS (6.212s)
[585.898262] [096/141] (435s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[587.601480] Starting subtest: 4-tiled-16bpp-rotate-0
[592.240104] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (4.634s)
[592.687424] [097/141] (428s left) gem_mmap_wc (close)
[593.074689] Subtest close: SKIP (0.000s)
[593.184945] [098/141] (428s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[593.570667] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[593.684848] [099/141] (427s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted)
[594.073150] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted
[594.076968] Subtest invalid-multi-wait-available-unsubmitted-submitted: SUCCESS (0.003s)
[594.222744] [100/141] (427s left) gem_mmap_gtt (basic-write-gtt)
[594.606440] Subtest basic-write-gtt: SKIP (0.000s)
[594.714893] [101/141] (426s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[595.091964] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[595.205678] [102/141] (426s left) gem_spin_batch (user-each)
[595.656131] Starting subtest: user-each
[599.116678] Subtest user-each: SUCCESS (3.459s)
[599.620749] [103/141] (422s left) gem_blits (basic)
[600.028946] Starting subtest: basic
[612.022277] Subtest basic: SUCCESS (11.990s)
[612.234817] [104/141] (409s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[613.838184] Starting subtest: pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[613.841370] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.001s)
[614.643659] [105/141] (407s left) gem_exec_balancer (parallel)
[615.920790] Starting subtest: parallel
[623.228674] Subtest parallel: SUCCESS (7.306s)
[623.437750] [106/141] (398s left) kms_frontbuffer_tracking (fbc-1p-rte)
[623.952584] Starting subtest: fbc-1p-rte
[632.112931] Subtest fbc-1p-rte: SUCCESS (8.168s)
[632.403958] [107/141] (389s left) gem_exec_reloc (basic-cpu-read-noreloc)
[632.809947] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[632.938320] [108/141] (389s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[633.420311] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[633.547272] [109/141] (388s left) kms_flip (plain-flip-interruptible)
[633.971170] Starting subtest: plain-flip-interruptible
[634.003339] Starting dynamic subtest: A-eDP1
[636.257749] Dynamic subtest A-eDP1: SUCCESS (2.254s)
[636.299499] Starting dynamic subtest: B-eDP1
[638.344087] Dynamic subtest B-eDP1: SUCCESS (2.081s)
[638.385869] Starting dynamic subtest: C-eDP1
[640.417885] Dynamic subtest C-eDP1: SUCCESS (2.069s)
[640.449440] Starting dynamic subtest: D-eDP1
[642.458200] Dynamic subtest D-eDP1: SUCCESS (2.034s)
[642.483911] Subtest plain-flip-interruptible: SUCCESS (8.512s)
[644.004697] [110/141] (378s left) kms_plane (plane-panning-bottom-right)
[644.474393] Starting subtest: plane-panning-bottom-right
[644.482770] Starting dynamic subtest: pipe-A-planes
[646.777251] Dynamic subtest pipe-A-planes: SUCCESS (2.294s)
[646.812427] Starting dynamic subtest: pipe-B-planes
[649.776247] Dynamic subtest pipe-B-planes: SUCCESS (2.983s)
[649.780201] Subtest plane-panning-bottom-right: SUCCESS (5.300s)
[650.721382] [111/141] (371s left) gem_tiled_fence_blits (basic)
[651.116637] Subtest basic: SKIP (0.000s)
[651.229579] [112/141] (371s left) kms_selftest (drm_format)
[651.608898] Starting subtest: drm_format
[651.615864] Subtest drm_format: SKIP (0.008s)
[651.733273] [113/141] (370s left) kms_concurrent (pipe-c)
[652.212096] Starting subtest: pipe-C
[652.217455] Starting dynamic subtest: eDP-1
[654.406197] Dynamic subtest eDP-1: SUCCESS (2.185s)
[654.409817] Subtest pipe-C: SUCCESS (2.197s)
[655.360515] [114/141] (367s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[655.737959] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[655.847970] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[655.994765] [115/141] (366s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[656.476377] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[656.482681] Starting dynamic subtest: pipe-A-default-mode
[656.888206] Dynamic subtest pipe-A-default-mode: SKIP (0.400s)
[656.895060] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.414s)
[657.834536] [116/141] (364s left) kms_color (ctm-signed)
[658.309058] Starting subtest: ctm-signed
[658.312097] Starting dynamic subtest: pipe-A
[661.340806] Dynamic subtest pipe-A: SUCCESS (3.031s)
[661.377531] Starting dynamic subtest: pipe-B
[665.167389] Dynamic subtest pipe-B: SUCCESS (3.819s)
[665.206308] Starting dynamic subtest: pipe-C
[669.222350] Dynamic subtest pipe-C: SUCCESS (4.050s)
[669.258070] Starting dynamic subtest: pipe-D
[672.289069] Dynamic subtest pipe-D: SUCCESS (3.061s)
[672.292910] Subtest ctm-signed: SUCCESS (13.977s)
[673.231941] [117/141] (349s left) kms_color (ctm-0-75)
[673.712430] Starting subtest: ctm-0-75
[673.715435] Starting dynamic subtest: pipe-A
[680.683455] Dynamic subtest pipe-A: SUCCESS (6.966s)
[680.725382] Starting dynamic subtest: pipe-B
[687.711832] Dynamic subtest pipe-B: SUCCESS (7.022s)
[687.755230] Starting dynamic subtest: pipe-C
[693.668071] Dynamic subtest pipe-C: SUCCESS (5.951s)
[693.711443] Starting dynamic subtest: pipe-D
[699.733910] Dynamic subtest pipe-D: SUCCESS (6.064s)
[699.737832] Subtest ctm-0-75: SUCCESS (26.017s)
[700.633232] [118/141] (322s left) prime_vgem (fence-write-hang)
[701.052362] Subtest fence-write-hang: SKIP (0.000s)
[701.220432] [119/141] (321s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[701.608331] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[701.720154] [120/141] (321s left) fbdev (unaligned-write)
[702.095593] Starting subtest: unaligned-write
[703.035225] Subtest unaligned-write: SUCCESS (0.939s)
[703.197395] [121/141] (319s left) gem_userptr_blits (readonly-unsync)
[703.605567] Subtest readonly-unsync: SKIP (0.000s)
[703.909203] [122/141] (319s left) gem_vm_create (execbuf)
[704.303343] Starting subtest: execbuf
[704.325932] Subtest execbuf: SUCCESS (0.023s)
[704.518969] [123/141] (318s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[705.075885] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[707.988365] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (2.125s)
[708.058412] [124/141] (315s left) gem_exec_params (rsvd2-dirt)
[708.451213] Starting subtest: rsvd2-dirt
[708.458074] Subtest rsvd2-dirt: SKIP (0.000s)
[708.611784] [125/141] (314s left) kms_properties (invalid-properties-atomic)
[709.093492] Starting subtest: invalid-properties-atomic
[711.815766] Subtest invalid-properties-atomic: SUCCESS (2.724s)
[711.970996] [126/141] (311s left) syncobj_wait (multi-wait-signaled)
[712.345318] Starting subtest: multi-wait-signaled
[712.348568] Subtest multi-wait-signaled: SUCCESS (0.002s)
[712.514220] [127/141] (311s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[712.929633] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[713.095708] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.162s)
[713.262797] [128/141] (310s left) drm_fdinfo (most-busy-idle-check-all)
[713.661297] Starting subtest: most-busy-idle-check-all
[713.664128] Starting dynamic subtest: rcs0
[713.675934] Dynamic subtest rcs0: SKIP (0.015s)
[713.716251] Starting dynamic subtest: bcs0
[713.721693] Dynamic subtest bcs0: SKIP (0.003s)
[713.762600] Starting dynamic subtest: vcs0
[713.768929] Dynamic subtest vcs0: SKIP (0.003s)
[713.806776] Starting dynamic subtest: vcs1
[713.813351] Dynamic subtest vcs1: SKIP (0.003s)
[713.851632] Starting dynamic subtest: vecs0
[713.858376] Dynamic subtest vecs0: SKIP (0.003s)
[713.895983] Starting dynamic subtest: ccs0
[713.902552] Dynamic subtest ccs0: SKIP (0.003s)
[713.909059] Subtest most-busy-idle-check-all: SKIP (0.056s)
[713.966957] [129/141] (309s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[714.860314] Starting subtest: cursor-rapid-movement-128x128
[714.891356] Starting dynamic subtest: pipe-A-eDP-1
[716.168290] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.279s)
[716.384714] Starting dynamic subtest: pipe-D-eDP-1
[718.991269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.638s)
[718.994433] Subtest cursor-rapid-movement-128x128: SUCCESS (4.132s)
[720.092665] [130/141] (303s left) kms_draw_crc (draw-method-pwrite)
[720.573854] Starting subtest: draw-method-pwrite
[720.577494] Starting dynamic subtest: xrgb8888-untiled
[724.858158] Dynamic subtest xrgb8888-untiled: SUCCESS (4.282s)
[724.905136] Starting dynamic subtest: rgb565-untiled
[728.235894] Dynamic subtest rgb565-untiled: SUCCESS (3.371s)
[728.281225] Starting dynamic subtest: xrgb2101010-untiled
[732.402558] Dynamic subtest xrgb2101010-untiled: SUCCESS (4.162s)
[732.447923] Starting dynamic subtest: xrgb8888-xtiled
[736.235945] Dynamic subtest xrgb8888-xtiled: SUCCESS (3.829s)
[736.284067] Starting dynamic subtest: rgb565-xtiled
[740.307471] Dynamic subtest rgb565-xtiled: SUCCESS (4.058s)
[740.349431] Starting dynamic subtest: xrgb2101010-xtiled
[751.705080] Dynamic subtest xrgb2101010-xtiled: SUCCESS (11.395s)
[751.729466] Starting dynamic subtest: xrgb8888-4tiled
[760.692278] Dynamic subtest xrgb8888-4tiled: SUCCESS (8.987s)
[760.739201] Starting dynamic subtest: rgb565-4tiled
[764.214238] Dynamic subtest rgb565-4tiled: SUCCESS (3.518s)
[764.261387] Starting dynamic subtest: xrgb2101010-4tiled
[772.250853] Dynamic subtest xrgb2101010-4tiled: SUCCESS (8.029s)
[772.255090] Subtest draw-method-pwrite: SUCCESS (51.676s)
[772.410895] [131/141] (251s left) gem_ctx_param (vm)
[772.790268] Starting subtest: vm
[772.931496] Subtest vm: SUCCESS (0.140s)
[773.139550] [132/141] (250s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[773.693431] Starting subtest: 4-tiled-8bpp-rotate-180
[777.848311] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (4.160s)
[778.185269] [133/141] (245s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[778.752758] Starting subtest: basic-busy-flip-before-cursor-varying-size
[778.758800] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[779.070819] [134/141] (245s left) gem_softpin (allocator-basic-reserve)
[779.475496] Starting subtest: allocator-basic-reserve
[780.038857] Subtest allocator-basic-reserve: SUCCESS (0.563s)
[780.271118] [135/141] (244s left) kms_getfb (getfb-handle-not-fb)
[780.646804] Starting subtest: getfb-handle-not-fb
[780.754592] Subtest getfb-handle-not-fb: SUCCESS (0.107s)
[780.925753] [136/141] (243s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[782.235399] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[785.319377] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (3.084s)
[786.586169] [137/141] (237s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[787.002424] Starting subtest: fbcpsr-rgb565-draw-render
[797.869960] Subtest fbcpsr-rgb565-draw-render: SUCCESS (10.864s)
[798.133754] [138/141] (226s left) gem_render_copy (yf-tiled)
[798.536240] Starting subtest: yf-tiled
[798.542684] Subtest yf-tiled: SKIP (0.000s)
[798.808656] [139/141] (225s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[799.291386] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[799.300355] Starting dynamic subtest: pipe-A-eDP-1
[799.337286] Dynamic subtest pipe-A-eDP-1: SKIP (0.033s)
[799.387195] Starting dynamic subtest: pipe-B-eDP-1
[799.490204] Dynamic subtest pipe-B-eDP-1: SKIP (0.144s)
[799.538883] Starting dynamic subtest: pipe-C-eDP-1
[799.653189] Dynamic subtest pipe-C-eDP-1: SKIP (0.148s)
[799.694996] Starting dynamic subtest: pipe-D-eDP-1
[799.811199] Dynamic subtest pipe-D-eDP-1: SKIP (0.147s)
[799.817947] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.515s)
[799.984224] [140/141] (224s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[800.469528] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[800.473337] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s)
[802.409421] [141/141] (222s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[802.935402] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[802.942878] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[803.093691] Closing watchdogs
Done.