[56.436939] Initializing watchdogs
[56.437552]   /dev/watchdog0
[56.469153] [001/142] (960s left) i915_pm_dc (dc5-psr)
[58.026559] Starting subtest: dc5-psr
[61.507095] Subtest dc5-psr: SUCCESS (3.478s)
[62.825700] [002/142] (954s left) kms_cursor_crc (cursor-onscreen-128x42)
[63.727822] Starting subtest: cursor-onscreen-128x42
[63.756288] Starting dynamic subtest: pipe-A-eDP-1
[68.005814] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.248s)
[68.196712] Starting dynamic subtest: pipe-D-eDP-1
[73.386567] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.220s)
[73.388587] Subtest cursor-onscreen-128x42: SUCCESS (9.658s)
[74.395931] [003/142] (942s left) vc4/vc4_tiling (get-bad-handle)
[74.838104] Subtest get-bad-handle: SKIP (0.000s)
[74.941711] [004/142] (942s left) kms_addfb_basic (basic)
[75.259213] Starting subtest: basic
[75.261672] Subtest basic: SUCCESS (0.000s)
[75.448126] [005/142] (941s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[76.528315] Starting subtest: cursor-rapid-movement-512x512
[76.534318] Subtest cursor-rapid-movement-512x512: SKIP (0.006s)
[76.926824] [006/142] (940s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[77.334221] Subtest tiled-to-untiled: SKIP (0.000s)
[77.431344] [007/142] (939s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[77.897040] Starting subtest: FB-8BPC-Vs-Panel-8BPC
[77.899221] Starting dynamic subtest: pipe-A-eDP-1
[79.717275] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[79.719689] Subtest FB-8BPC-Vs-Panel-8BPC: SUCCESS (1.820s)
[80.652670] [008/142] (936s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[81.025950] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[81.031140] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.003s)
[81.155582] [009/142] (936s left) syncobj_wait (wait-all-complex)
[81.531997] Starting subtest: wait-all-complex
[81.751978] Subtest wait-all-complex: SUCCESS (0.217s)
[81.875975] [010/142] (935s left) gem_exec_suspend (basic-s3-devices)
[82.297646] Starting subtest: basic-S3-devices
[82.300440] Starting dynamic subtest: smem
[99.515866] Dynamic subtest smem: SUCCESS (17.216s)
[99.518589] Subtest basic-S3-devices: SUCCESS (17.217s)
[99.793898] [011/142] (917s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[100.381168] Starting subtest: cursor-vs-flip-legacy
[140.280095] Subtest cursor-vs-flip-legacy: SUCCESS (39.898s)
[141.228493] [012/142] (876s left) gem_flink_basic (bad-flink)
[141.617823] Starting subtest: bad-flink
[141.620759] Subtest bad-flink: SUCCESS (0.000s)
[141.749233] [013/142] (876s left) gem_basic (multigpu-create-close)
[142.109709] Starting subtest: multigpu-create-close
[142.114659] Subtest multigpu-create-close: SKIP (0.000s)
[142.243875] [014/142] (875s left) gem_exec_capture (pi)
[142.634641] Starting subtest: pi
[142.637123] Starting dynamic subtest: rcs0
[162.350423] Dynamic subtest rcs0: SUCCESS (19.716s)
[162.399790] Starting dynamic subtest: bcs0
[174.244205] Dynamic subtest bcs0: SUCCESS (11.892s)
[174.285624] Starting dynamic subtest: vcs0
[177.526786] Dynamic subtest vcs0: FAIL (3.251s)
[177.551690] Starting dynamic subtest: vcs1
[205.595682] Dynamic subtest vcs1: SUCCESS (28.094s)
[205.650897] Starting dynamic subtest: vecs0
[218.128117] Dynamic subtest vecs0: SUCCESS (12.529s)
[218.172907] Starting dynamic subtest: ccs0
[230.626483] Dynamic subtest ccs0: SUCCESS (12.498s)
[230.628867] Subtest pi: FAIL (87.996s)
[230.921324] [015/142] (787s left) api_intel_bb (object-reloc-purge-cache)
[231.552441] Starting subtest: object-reloc-purge-cache
[231.564416] Subtest object-reloc-purge-cache: SKIP (0.009s)
[231.748753] [016/142] (786s left) gem_exec_schedule (pi-distinct-iova)
[232.373538] Starting subtest: pi-distinct-iova
[232.376198] Starting dynamic subtest: rcs0
[232.825764] Dynamic subtest rcs0: SUCCESS (0.451s)
[232.870564] Starting dynamic subtest: bcs0
[233.150679] Dynamic subtest bcs0: SUCCESS (0.323s)
[233.192694] Starting dynamic subtest: vcs0
[233.393968] Dynamic subtest vcs0: SUCCESS (0.240s)
[233.439299] Starting dynamic subtest: vcs1
[233.612736] Dynamic subtest vcs1: SUCCESS (0.217s)
[233.665864] Starting dynamic subtest: vecs0
[233.826447] Dynamic subtest vecs0: SUCCESS (0.212s)
[233.872295] Starting dynamic subtest: ccs0
[234.164663] Dynamic subtest ccs0: SUCCESS (0.336s)
[234.167133] Subtest pi-distinct-iova: SUCCESS (1.793s)
[235.774616] [017/142] (782s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[238.159777] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[238.176446] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.016s)
[238.745314] [018/142] (779s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[239.308062] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[239.312776] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.001s)
[239.474469] [019/142] (778s left) kms_rotation_crc (primary-rotation-90)
[239.946207] Starting subtest: primary-rotation-90
[239.953221] Subtest primary-rotation-90: SKIP (0.007s)
[240.094260] [020/142] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[240.603575] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[258.258802] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (17.656s)
[258.509192] [021/142] (759s left) gem_mmap_gtt (basic-small-bo)
[258.881567] Subtest basic-small-bo: SKIP (0.000s)
[259.000247] [022/142] (759s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[259.532127] Starting subtest: x-tiled-8bpp-rotate-180
[263.903505] Subtest x-tiled-8bpp-rotate-180: SUCCESS (4.370s)
[264.212892] [023/142] (754s left) gem_render_copy (yf-tiled-ccs-to-linear)
[264.616921] Starting subtest: yf-tiled-ccs-to-linear
[264.620077] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[264.888950] [024/142] (753s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[265.370645] Starting subtest: plane-downscale-with-rotation-factor-0-5
[265.379191] Starting dynamic subtest: pipe-A-eDP-1
[265.509389] Dynamic subtest pipe-A-eDP-1: SKIP (0.128s)
[265.555536] Starting dynamic subtest: pipe-B-eDP-1
[265.727178] Dynamic subtest pipe-B-eDP-1: SKIP (0.207s)
[265.778244] Starting dynamic subtest: pipe-C-eDP-1
[265.951058] Dynamic subtest pipe-C-eDP-1: SKIP (0.212s)
[265.993626] Starting dynamic subtest: pipe-D-eDP-1
[266.172891] Dynamic subtest pipe-D-eDP-1: SKIP (0.215s)
[266.176588] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (0.805s)
[266.363817] [025/142] (752s left) kms_selftest (drm_plane)
[266.725129] Starting subtest: drm_plane
[266.733956] Subtest drm_plane: SKIP (0.007s)
[266.865185] [026/142] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[267.354681] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[267.358195] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[267.524886] [027/142] (751s left) gem_exec_flush (basic-batch-kernel-default-uc)
[267.946252] Starting subtest: basic-batch-kernel-default-uc
[276.907223] Subtest basic-batch-kernel-default-uc: SUCCESS (8.960s)
[277.219310] [028/142] (741s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[278.793129] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs
[278.797568] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.003s)
[279.479341] [029/142] (739s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[281.009660] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs
[282.249329] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.239s)
[283.575093] [030/142] (735s left) gem_exec_params (invalid-batch-start-offset)
[283.981089] Starting subtest: invalid-batch-start-offset
[283.992865] Subtest invalid-batch-start-offset: SUCCESS (0.016s)
[284.166963] [031/142] (735s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs)
[285.596188] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs
[285.600858] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.002s)
[286.556279] [032/142] (732s left) kms_flip (flip-vs-panning)
[286.949266] Starting subtest: flip-vs-panning
[286.978088] Starting dynamic subtest: A-eDP1
[296.419591] Dynamic subtest A-eDP1: SUCCESS (9.442s)
[296.467977] Starting dynamic subtest: B-eDP1
[305.769660] Dynamic subtest B-eDP1: SUCCESS (9.345s)
[305.828830] Starting dynamic subtest: C-eDP1
[315.087861] Dynamic subtest C-eDP1: SUCCESS (9.311s)
[315.128726] Starting dynamic subtest: D-eDP1
[324.209647] Dynamic subtest D-eDP1: SUCCESS (9.119s)
[324.237387] Subtest flip-vs-panning: SUCCESS (37.290s)
[325.823707] [033/142] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[326.307095] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[326.311243] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[326.471275] [034/142] (693s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[327.462182] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[327.466776] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[328.741361] [035/142] (690s left) vc4/vc4_create_bo (create-bo-zeroed)
[329.239387] Subtest create-bo-zeroed: SKIP (0.000s)
[329.377306] [036/142] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[329.877772] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[340.090145] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (10.211s)
[340.361844] [037/142] (679s left) kms_plane_scaling (2x-scaler-multi-pipe)
[340.849719] Starting subtest: 2x-scaler-multi-pipe
[340.865624] Subtest 2x-scaler-multi-pipe: SKIP (0.016s)
[341.009468] [038/142] (678s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[341.388163] Starting subtest: invalid-single-wait-unsubmitted
[341.390557] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s)
[341.527409] [039/142] (678s left) gem_exec_fence (submit67)
[342.121576] Starting subtest: submit67
[342.126106] Subtest submit67: SKIP (0.000s)
[344.141723] [040/142] (675s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[344.625430] Starting subtest: primary-x-tiled-reflect-x-0
[359.625232] Subtest primary-x-tiled-reflect-x-0: SUCCESS (15.000s)
[361.148583] [041/142] (658s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[362.285118] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[363.428239] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.143s)
[364.722447] [042/142] (655s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[365.646577] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[374.500739] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SUCCESS (8.854s)
[376.294824] [043/142] (643s left) gem_mmap_gtt (ptrace)
[376.665815] Subtest ptrace: SKIP (0.000s)
[376.792657] [044/142] (643s left) gem_eio (hibernate)
[378.832679] Starting subtest: hibernate
[404.472209] Subtest hibernate: SUCCESS (25.638s)
[406.710526] [045/142] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[407.215740] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[407.220116] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[407.340417] [046/142] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[407.780287] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[407.784320] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[407.956525] [047/142] (612s left) i915_pm_rpm (gem-mmap-type)
[414.027913] Starting subtest: gem-mmap-type
[414.030803] Starting dynamic subtest: gtt-smem0
[414.810391] Dynamic subtest gtt-smem0: SKIP (0.778s)
[414.846577] Starting dynamic subtest: wb-smem0
[421.707773] Dynamic subtest wb-smem0: SUCCESS (6.896s)
[421.748876] Starting dynamic subtest: wc-smem0
[428.433175] Dynamic subtest wc-smem0: SUCCESS (6.723s)
[428.485574] Starting dynamic subtest: uc-smem0
[438.812050] Dynamic subtest uc-smem0: SUCCESS (10.372s)
[438.814092] Subtest gem-mmap-type: SUCCESS (24.784s)
[439.020872] [048/142] (581s left) debugfs_test (read_all_entries_display_on)
[439.530158] Starting subtest: read_all_entries_display_on
[442.450841] Subtest read_all_entries_display_on: SUCCESS (2.922s)
[442.647532] [049/142] (578s left) gen9_exec_parse (shadow-peek)
[443.033090] Subtest shadow-peek: SKIP (0.000s)
[443.154966] [050/142] (577s left) perf (oa-formats)
[444.081564] Starting subtest: oa-formats
[444.084183] Starting dynamic subtest: 0-rcs0
[444.129445] Dynamic subtest 0-rcs0: SUCCESS (0.045s)
[444.197416] Starting dynamic subtest: 1-vcs0
[444.205229] Dynamic subtest 1-vcs0: SUCCESS (0.067s)
[444.207420] Subtest oa-formats: SUCCESS (0.121s)
[444.319067] [051/142] (576s left) gem_mmap_gtt (cpuset-big-copy-xy)
[444.696637] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[444.811510] [052/142] (576s left) kms_atomic_interruptible (atomic-setmode)
[445.304550] Starting subtest: atomic-setmode
[445.315171] Starting dynamic subtest: eDP-1-pipe-A
[452.795606] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.480s)
[452.797989] Subtest atomic-setmode: SUCCESS (7.493s)
[453.755412] [053/142] (567s left) gem_ctx_isolation (preservation)
[454.182969] Starting subtest: preservation
[454.185441] Starting dynamic subtest: rcs0
[454.724334] Dynamic subtest rcs0: SUCCESS (0.537s)
[454.771378] Starting dynamic subtest: bcs0
[455.338819] Dynamic subtest bcs0: SUCCESS (0.610s)
[455.387981] Starting dynamic subtest: vcs0
[455.915130] Dynamic subtest vcs0: SUCCESS (0.570s)
[455.978408] Starting dynamic subtest: vcs1
[457.048061] Dynamic subtest vcs1: SUCCESS (1.129s)
[457.098363] Starting dynamic subtest: vecs0
[459.028204] Dynamic subtest vecs0: SUCCESS (1.975s)
[459.091855] Starting dynamic subtest: ccs0
[461.086224] Dynamic subtest ccs0: SUCCESS (2.054s)
[461.088836] Subtest preservation: SUCCESS (6.903s)
[461.451403] [054/142] (559s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[461.832576] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[461.834967] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.001s)
[462.019906] [055/142] (559s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[462.570164] Starting subtest: yf-tiled-16bpp-rotate-180
[462.574598] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[462.743276] [056/142] (558s left) gem_eio (in-flight-external)
[464.482989] Starting subtest: in-flight-external
[467.281968] Subtest in-flight-external: SUCCESS (2.799s)
[468.682597] [057/142] (552s left) gem_exec_params (no-vebox)
[469.076548] Starting subtest: no-vebox
[469.082951] Subtest no-vebox: SUCCESS (0.005s)
[470.703917] [058/142] (550s left) gem_exec_schedule (thriceslice)
[471.141362] Starting subtest: thriceslice
[471.143126] Starting dynamic subtest: rcs0
[471.192322] Dynamic subtest rcs0: SUCCESS (0.047s)
[471.246154] Starting dynamic subtest: bcs0
[471.248594] Dynamic subtest bcs0: SUCCESS (0.044s)
[471.294662] Starting dynamic subtest: vcs0
[471.297283] Dynamic subtest vcs0: SUCCESS (0.041s)
[471.348296] Starting dynamic subtest: vcs1
[471.350795] Dynamic subtest vcs1: SUCCESS (0.045s)
[471.399423] Starting dynamic subtest: vecs0
[471.402744] Dynamic subtest vecs0: SUCCESS (0.064s)
[471.458623] Starting dynamic subtest: ccs0
[471.470912] Dynamic subtest ccs0: SUCCESS (0.063s)
[471.474213] Subtest thriceslice: SUCCESS (0.331s)
[472.686485] [059/142] (549s left) kms_mmap_write_crc (main)
[473.210174] Starting subtest: main
[473.218185] Starting dynamic subtest: pipe-A-eDP-1
[482.971784] Dynamic subtest pipe-A-eDP-1: SUCCESS (9.749s)
[482.974161] Subtest main: SUCCESS (9.758s)
[483.944418] [060/142] (537s left) kms_busy (extended-modeset-hang-newfb)
[484.461117] Starting subtest: extended-modeset-hang-newfb
[484.470357] Starting dynamic subtest: pipe-A
[508.532105] Dynamic subtest pipe-A: SUCCESS (24.062s)
[508.599617] Starting dynamic subtest: pipe-D
[532.678111] Dynamic subtest pipe-D: SUCCESS (24.125s)
[532.680288] Subtest extended-modeset-hang-newfb: SUCCESS (48.222s)
[533.634996] [061/142] (488s left) template (b)
[534.012148] Starting subtest: B
[534.014577] Subtest B: SUCCESS (0.000s)
[534.158839] [062/142] (487s left) gem_ctx_persistence (heartbeat-close)
[534.548315] Starting subtest: heartbeat-close
[534.554614] Subtest heartbeat-close: SKIP (0.001s)
[534.703540] [063/142] (487s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[535.177941] Starting subtest: primary-y-tiled-reflect-x-270
[535.184386] Subtest primary-y-tiled-reflect-x-270: SKIP (0.007s)
[535.334855] [064/142] (486s left) i915_suspend (basic-s3-without-i915)
[535.708169] Starting subtest: basic-s3-without-i915
[539.567150] Subtest basic-s3-without-i915: SKIP (3.857s)
[543.487046] [065/142] (478s left) kms_rotation_crc (sprite-rotation-180)
[543.799605] Starting subtest: sprite-rotation-180
[555.473611] Subtest sprite-rotation-180: SUCCESS (11.675s)
[557.337553] [066/142] (465s left) kms_flip (2x-flip-vs-modeset)
[557.733383] Starting subtest: 2x-flip-vs-modeset
[557.900546] Subtest 2x-flip-vs-modeset: SKIP (0.163s)
[558.093992] [067/142] (464s left) gem_spin_batch (resubmit-all)
[558.526898] Starting subtest: resubmit-all
[558.530245] Starting dynamic subtest: rcs0
[558.564597] Dynamic subtest rcs0: SUCCESS (0.035s)
[558.614934] Starting dynamic subtest: bcs0
[558.617348] Dynamic subtest bcs0: SUCCESS (0.011s)
[558.659805] Starting dynamic subtest: vcs0
[558.662347] Dynamic subtest vcs0: SUCCESS (0.011s)
[558.701752] Starting dynamic subtest: vcs1
[558.704146] Dynamic subtest vcs1: SUCCESS (0.008s)
[558.743762] Starting dynamic subtest: vecs0
[558.746356] Dynamic subtest vecs0: SUCCESS (0.008s)
[558.798115] Starting dynamic subtest: ccs0
[558.800442] Dynamic subtest ccs0: SUCCESS (0.008s)
[558.802643] Subtest resubmit-all: SUCCESS (0.107s)
[560.650817] [068/142] (461s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[563.566092] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[563.734518] [069/142] (458s left) gem_ccs (block-copy-compressed)
[564.130731] Starting subtest: block-copy-compressed
[564.135727] Subtest block-copy-compressed: SKIP (0.000s)
[564.330613] [070/142] (458s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs)
[565.790517] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs
[565.797077] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[566.717595] [071/142] (456s left) gem_mmap_wc (read-write)
[567.086689] Subtest read-write: SKIP (0.000s)
[567.205338] [072/142] (455s left) kms_plane_multiple (tiling-yf)
[567.671767] Starting subtest: tiling-yf
[567.676352] Subtest tiling-yf: SKIP (0.000s)
[567.822096] [073/142] (455s left) v3d/v3d_submit_csd (single-in-sync)
[568.287361] Subtest single-in-sync: SKIP (0.000s)
[568.414596] [074/142] (454s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[569.718049] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[569.733351] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.013s)
[570.791612] [075/142] (452s left) kms_atomic (crtc-invalid-params)
[571.577374] Starting subtest: crtc-invalid-params
[571.710675] Subtest crtc-invalid-params: SUCCESS (0.134s)
[573.051431] [076/142] (450s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[573.568726] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[573.573141] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[573.739242] [077/142] (449s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[574.239690] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[574.244177] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[574.405269] [078/142] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[574.900659] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[574.905143] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[575.068407] [079/142] (448s left) gem_exec_whisper (basic-contexts-all)
[575.488039] Starting subtest: basic-contexts-all
[597.845804] Subtest basic-contexts-all: SUCCESS (22.352s)
[598.125317] [080/142] (425s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[599.210194] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[599.225161] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.013s)
[600.558454] [081/142] (423s left) drm_mm (drm_mm_test)
[600.922203] Starting subtest: drm_mm_test
[600.932604] Subtest drm_mm_test: SKIP (0.008s)
[601.068646] [082/142] (422s left) vgem_basic (bad-fence)
[601.445576] Starting subtest: bad-fence
[601.447991] Subtest bad-fence: SUCCESS (0.000s)
[601.577955] [083/142] (422s left) kms_invalid_mode (bad-hsync-start)
[602.063237] Starting subtest: bad-hsync-start
[602.069983] Starting dynamic subtest: eDP-1-pipe-A
[602.490587] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.420s)
[602.543061] Starting dynamic subtest: eDP-1-pipe-B
[602.545614] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.039s)
[602.593095] Starting dynamic subtest: eDP-1-pipe-C
[602.595812] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.039s)
[602.642316] Starting dynamic subtest: eDP-1-pipe-D
[602.644797] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.039s)
[602.647155] Subtest bad-hsync-start: SUCCESS (0.574s)
[603.419252] [084/142] (420s left) gem_lmem_swapping (heavy-verify-multi)
[603.813860] Subtest heavy-verify-multi: SKIP (0.000s)
[603.943117] [085/142] (419s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[604.457433] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[604.462126] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[604.620733] [086/142] (419s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[606.192173] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[606.207032] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.013s)
[607.041649] [087/142] (417s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[607.519067] Starting subtest: pipe-C-ts-continuation-modeset-rpm
[612.033566] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (4.516s)
[612.984578] [088/142] (411s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[613.885865] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[614.759490] [089/142] (409s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[615.297615] Starting subtest: y-tiled-8bpp-rotate-90
[615.302670] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[615.474571] [090/142] (408s left) kms_chamelium_audio (dp-audio-edid)
[616.361826] Subtest dp-audio-edid: SKIP (0.000s)
[617.236858] [091/142] (407s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[618.623330] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[618.632130] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.007s)
[619.692373] [092/142] (404s left) v3d/v3d_get_bo_offset (get-bad-handle)
[620.169654] Subtest get-bad-handle: SKIP (0.000s)
[620.308562] [093/142] (404s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[620.692620] Starting subtest: single-wait-for-submit-unsubmitted
[620.802285] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[620.951361] [094/142] (403s left) i915_pm_dc (dc9-dpms)
[622.443556] Starting subtest: dc9-dpms
[622.450165] Subtest dc9-dpms: SKIP (0.001s)
[622.596176] [095/142] (402s left) kms_content_protection (dp-mst-type-0)
[623.300459] Starting subtest: dp-mst-type-0
[623.305383] Subtest dp-mst-type-0: SKIP (0.002s)
[623.512583] [096/142] (401s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[624.025241] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[642.039735] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (18.010s)
[642.305958] [097/142] (382s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[642.822617] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[642.827355] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[642.998925] [098/142] (382s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[643.482247] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[643.491567] Starting dynamic subtest: pipe-A-eDP-1
[643.610810] Dynamic subtest pipe-A-eDP-1: SKIP (0.116s)
[643.664961] Starting dynamic subtest: pipe-B-eDP-1
[643.844372] Dynamic subtest pipe-B-eDP-1: SKIP (0.223s)
[643.892600] Starting dynamic subtest: pipe-C-eDP-1
[644.076117] Dynamic subtest pipe-C-eDP-1: SKIP (0.222s)
[644.128440] Starting dynamic subtest: pipe-D-eDP-1
[644.305748] Dynamic subtest pipe-D-eDP-1: SKIP (0.220s)
[644.310448] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.825s)
[644.487608] [099/142] (380s left) gem_userptr_blits (process-exit)
[644.942566] Starting subtest: process-exit
[645.014346] Subtest process-exit: SUCCESS (0.070s)
[645.249851] [100/142] (379s left) v3d/v3d_mmap (mmap-bad-handle)
[645.716067] Subtest mmap-bad-handle: SKIP (0.000s)
[645.853883] [101/142] (379s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[646.358551] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[659.392753] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (13.033s)
[659.700551] [102/142] (365s left) perf_pmu (render-node-busy)
[660.151080] Starting subtest: render-node-busy
[660.153542] Starting dynamic subtest: rcs0
[660.755528] Dynamic subtest rcs0: SUCCESS (0.603s)
[660.806734] Starting dynamic subtest: bcs0
[661.331558] Dynamic subtest bcs0: SUCCESS (0.572s)
[661.384372] Starting dynamic subtest: vcs0
[662.523237] Dynamic subtest vcs0: SUCCESS (1.185s)
[662.571068] Starting dynamic subtest: vcs1
[664.507296] Dynamic subtest vcs1: SUCCESS (1.980s)
[664.552716] Starting dynamic subtest: vecs0
[666.556299] Dynamic subtest vecs0: SUCCESS (2.044s)
[666.602153] Starting dynamic subtest: ccs0
[667.129139] Dynamic subtest ccs0: SUCCESS (0.572s)
[667.131624] Subtest render-node-busy: SUCCESS (6.981s)
[667.311787] [103/142] (358s left) gen7_exec_parse (basic-allocation)
[667.715734] Subtest basic-allocation: SKIP (0.000s)
[667.856348] [104/142] (357s left) gem_userptr_blits (readonly-unsync)
[668.248612] Subtest readonly-unsync: SKIP (0.000s)
[668.558954] [105/142] (357s left) gem_mmap_wc (write)
[668.926814] Subtest write: SKIP (0.000s)
[669.059449] [106/142] (356s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[670.177579] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[670.182268] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[671.457370] [107/142] (354s left) gem_exec_params (rel-constants-invalid)
[671.845114] Starting subtest: rel-constants-invalid
[671.847619] Subtest rel-constants-invalid: SUCCESS (0.001s)
[672.018107] [108/142] (353s left) gem_userptr_blits (usage-restrictions)
[672.412373] Starting subtest: usage-restrictions
[672.415099] Subtest usage-restrictions: SUCCESS (0.000s)
[672.704946] [109/142] (353s left) gem_exec_balancer (semaphore)
[673.120709] Starting subtest: semaphore
[681.554217] Subtest semaphore: SUCCESS (8.431s)
[682.569609] [110/142] (343s left) i915_query (query-regions-garbage-items)
[682.936226] Starting subtest: query-regions-garbage-items
[682.938667] Subtest query-regions-garbage-items: SUCCESS (0.002s)
[683.123279] [111/142] (343s left) kms_addfb_basic (tile-pitch-mismatch)
[683.507211] Starting subtest: tile-pitch-mismatch
[683.512358] Subtest tile-pitch-mismatch: SKIP (0.000s)
[683.824371] [112/142] (342s left) kms_hdr (static-toggle)
[684.306553] Starting subtest: static-toggle
[684.313148] Subtest static-toggle: SKIP (0.001s)
[684.463295] [113/142] (341s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[685.040253] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[685.049456] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.008s)
[685.404527] [114/142] (341s left) perf_pmu (invalid-init)
[685.785496] Starting subtest: invalid-init
[685.788199] Subtest invalid-init: SUCCESS (0.002s)
[685.965211] [115/142] (340s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[686.468726] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[700.828636] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (14.361s)
[701.093294] [116/142] (325s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[701.583976] Starting subtest: plane-primary-toggle-with-vblank-wait
[701.593163] Starting dynamic subtest: pipe-A-eDP-1
[701.853209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.263s)
[702.244663] Starting dynamic subtest: pipe-B-eDP-1
[703.238747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.018s)
[703.639394] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (2.057s)
[704.591716] [117/142] (322s left) gem_eio (unwedge-stress)
[706.182405] Starting subtest: unwedge-stress
[780.564561] Subtest unwedge-stress: SUCCESS (74.385s)
[782.685818] [118/142] (244s left) gem_ctx_shared (q-out-order)
[783.124461] Starting subtest: Q-out-order
[783.126632] Starting dynamic subtest: rcs0
[783.469644] Dynamic subtest rcs0: SUCCESS (0.341s)
[783.536217] Starting dynamic subtest: bcs0
[783.727962] Dynamic subtest bcs0: SUCCESS (0.255s)
[783.799671] Starting dynamic subtest: vcs0
[783.982294] Dynamic subtest vcs0: SUCCESS (0.251s)
[784.053496] Starting dynamic subtest: vcs1
[784.232491] Dynamic subtest vcs1: SUCCESS (0.246s)
[784.300777] Starting dynamic subtest: vecs0
[784.510976] Dynamic subtest vecs0: SUCCESS (0.273s)
[784.583865] Starting dynamic subtest: ccs0
[784.919528] Dynamic subtest ccs0: SUCCESS (0.406s)
[784.921518] Subtest Q-out-order: SUCCESS (1.794s)
[785.299410] [119/142] (241s left) kms_vblank (pipe-a-wait-forked-busy)
[785.817581] Starting subtest: pipe-A-wait-forked-busy
[788.381347] Subtest pipe-A-wait-forked-busy: SUCCESS (2.566s)
[789.344362] [120/142] (237s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[789.728976] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[789.731594] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[789.879378] [121/142] (237s left) kms_prop_blob (blob-multiple)
[790.258183] Starting subtest: blob-multiple
[790.265636] Subtest blob-multiple: SUCCESS (0.008s)
[790.417491] [122/142] (236s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[790.812770] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[790.948488] [123/142] (236s left) perf (non-sampling-read-error)
[791.827208] Starting subtest: non-sampling-read-error
[791.868149] Subtest non-sampling-read-error: SUCCESS (0.041s)
[791.993448] [124/142] (235s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[792.576383] Starting subtest: flip-vs-cursor-atomic-transitions
[797.966633] Subtest flip-vs-cursor-atomic-transitions: FAIL (4.960s)
[798.049887] [125/142] (229s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[798.452189] Subtest writes-after-reads-uncached: SKIP (0.000s)
[798.593945] [126/142] (228s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[799.093412] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[799.097595] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[799.274746] [127/142] (228s left) prime_vgem (busy)
[799.691089] Starting subtest: busy
[799.693787] Starting dynamic subtest: rcs0
[799.760121] Dynamic subtest rcs0: SUCCESS (0.072s)
[799.831646] Starting dynamic subtest: bcs0
[799.834633] Dynamic subtest bcs0: SUCCESS (0.069s)
[799.903275] Starting dynamic subtest: vcs0
[799.905672] Dynamic subtest vcs0: SUCCESS (0.061s)
[799.982244] Starting dynamic subtest: vcs1
[799.984908] Dynamic subtest vcs1: SUCCESS (0.039s)
[800.047181] Starting dynamic subtest: vecs0
[800.049924] Dynamic subtest vecs0: SUCCESS (0.039s)
[800.104379] Starting dynamic subtest: ccs0
[800.107056] Dynamic subtest ccs0: SUCCESS (0.045s)
[800.109619] Subtest busy: SUCCESS (0.342s)
[800.191142] [128/142] (227s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[800.712442] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[800.717195] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[800.889870] [129/142] (226s left) kms_cursor_edge_walk (128x128-left-edge)
[801.380159] Starting subtest: 128x128-left-edge
[801.386323] Starting dynamic subtest: pipe-A-eDP-1
[805.293639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.904s)
[805.352448] Starting dynamic subtest: pipe-D-eDP-1
[808.735352] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.431s)
[808.737749] Subtest 128x128-left-edge: SUCCESS (7.358s)
[809.686969] [130/142] (218s left) kms_psr (psr2_sprite_plane_onoff)
[810.179597] Starting subtest: psr2_sprite_plane_onoff
[813.514567] Subtest psr2_sprite_plane_onoff: SUCCESS (3.333s)
[814.467291] [131/142] (213s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[815.021618] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[819.873130] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: FAIL (4.318s)
[819.954429] [132/142] (208s left) perf (gen12-mi-rpc)
[820.597415] Starting subtest: gen12-mi-rpc
[820.600101] Starting dynamic subtest: rcs0
[820.669619] Dynamic subtest rcs0: SUCCESS (0.071s)
[820.672730] Subtest gen12-mi-rpc: SUCCESS (0.077s)
[820.790785] [133/142] (207s left) perf_pmu (faulting-read)
[821.187798] Starting subtest: faulting-read
[821.190583] Starting dynamic subtest: gtt
[821.195120] Dynamic subtest gtt: SKIP (0.001s)
[821.255598] Starting dynamic subtest: wb
[821.258073] Dynamic subtest wb: SUCCESS (0.005s)
[821.316716] Starting dynamic subtest: wc
[821.319764] Dynamic subtest wc: SUCCESS (0.004s)
[821.373142] Starting dynamic subtest: uc
[821.375664] Dynamic subtest uc: SUCCESS (0.003s)
[821.378049] Subtest faulting-read: SUCCESS (0.031s)
[821.448455] [134/142] (206s left) gem_softpin (allocator-evict)
[821.843125] Starting subtest: allocator-evict
[821.845438] Starting dynamic subtest: rcs0
[857.710801] Dynamic subtest rcs0: SUCCESS (35.869s)
[857.762476] Starting dynamic subtest: bcs0
[891.289316] Dynamic subtest bcs0: SUCCESS (33.573s)
[891.346634] Starting dynamic subtest: vcs0
[920.790347] Dynamic subtest vcs0: SUCCESS (29.494s)
[920.837244] Starting dynamic subtest: vcs1
[953.715000] Dynamic subtest vcs1: SUCCESS (32.922s)
[953.763946] Starting dynamic subtest: vecs0
[986.989777] Dynamic subtest vecs0: SUCCESS (33.272s)
[987.043794] Starting dynamic subtest: ccs0
[1020.373959] Dynamic subtest ccs0: SUCCESS (33.374s)
[1020.376285] Subtest allocator-evict: SUCCESS (198.534s)
[1020.567385] [135/142] (  7s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[1021.113534] Starting subtest: pipe-D-ts-continuation-idle-hang
[1036.723091] Subtest pipe-D-ts-continuation-idle-hang: SUCCESS (15.603s)
[1037.693701] Overall timeout time exceeded, stopping.
[1037.694962] Closing watchdogs
Done.