[57.547101] Initializing watchdogs
[57.547166]   /dev/watchdog0
[57.561141] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.565645] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.568033] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.571541] [001/131] (960s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[57.714052] Starting subtest: cursor-vs-flip-atomic-transitions
[87.760263] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.075s)
[88.626281] [002/131] (929s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[88.703927] Starting subtest: single-wait-for-submit-available-signaled
[88.706306] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[88.834931] [003/131] (929s left) i915_drm_fdinfo (memory-info-shared)
[88.876229] Starting subtest: memory-info-shared
[88.879054] Starting dynamic subtest: smem0
[88.951528] Dynamic subtest smem0: SUCCESS (0.075s)
[88.954329] Subtest memory-info-shared: SUCCESS (0.075s)
[89.046797] [004/131] (929s left) kms_atomic_interruptible (legacy-dpms)
[89.152733] Starting subtest: legacy-dpms
[89.155089] Starting dynamic subtest: pipe-A-eDP-1
[96.528843] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.374s)
[96.530833] Subtest legacy-dpms: SUCCESS (7.375s)
[97.391823] [005/131] (920s left) kms_getfb (getfb-handle-closed)
[97.491226] Starting subtest: getfb-handle-closed
[97.493544] Subtest getfb-handle-closed: SUCCESS (0.000s)
[97.624854] [006/131] (920s left) gem_ccs (suspend-resume)
[97.691873] Starting subtest: suspend-resume
[97.696180] Subtest suspend-resume: SKIP (0.000s)
[97.814688] [007/131] (920s left) gem_exec_fence (syncobj-signal)
[98.244695] Starting subtest: syncobj-signal
[98.250553] Subtest syncobj-signal: SUCCESS (0.006s)
[99.995117] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[99.998218] [008/131] (918s left) kms_flip (basic-plain-flip)
[100.101162] Starting subtest: basic-plain-flip
[100.103433] Starting dynamic subtest: A-eDP1
[101.768061] Dynamic subtest A-eDP1: SUCCESS (1.668s)
[101.775221] Starting dynamic subtest: B-eDP1
[103.397803] Dynamic subtest B-eDP1: SUCCESS (1.629s)
[103.407845] Starting dynamic subtest: C-eDP1
[105.025342] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[105.034958] Starting dynamic subtest: D-eDP1
[106.650550] Dynamic subtest D-eDP1: SUCCESS (1.625s)
[106.652953] Subtest basic-plain-flip: SUCCESS (6.555s)
[107.847863] [009/131] (910s left) kms_rotation_crc (sprite-rotation-270)
[107.958200] Starting subtest: sprite-rotation-270
[107.962494] Subtest sprite-rotation-270: SKIP (0.001s)
[108.061203] [010/131] (910s left) kms_psr (psr2-sprite-render)
[108.162316] Starting subtest: psr2-sprite-render
[108.164645] Starting dynamic subtest: eDP-1
[109.921487] Dynamic subtest eDP-1: SUCCESS (1.760s)
[109.923872] Subtest psr2-sprite-render: SUCCESS (1.761s)
[110.812537] [011/131] (907s left) gen9_exec_parse (batch-without-end)
[110.889158] Subtest batch-without-end: SKIP (0.000s)
[110.959226] [012/131] (907s left) i915_pm_rc6_residency (rc6-idle)
[111.008946] Starting subtest: rc6-idle
[111.043387] Starting dynamic subtest: gt0-rcs0
[135.254443] Dynamic subtest gt0-rcs0: SUCCESS (24.211s)
[135.263953] Starting dynamic subtest: gt0-bcs0
[159.657744] Dynamic subtest gt0-bcs0: SUCCESS (24.403s)
[159.667638] Starting dynamic subtest: gt0-ccs0
[183.868093] Dynamic subtest gt0-ccs0: SUCCESS (24.212s)
[183.875876] Starting dynamic subtest: gt1-vcs0
[190.044762] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[190.054967] Starting dynamic subtest: gt1-vecs0
[196.215818] Dynamic subtest gt1-vecs0: SUCCESS (6.171s)
[196.219428] Subtest rc6-idle: SUCCESS (85.210s)
[196.322179] [013/131] (822s left) kms_pm_dc (dc5-psr)
[197.432046] Starting subtest: dc5-psr
[200.307399] Subtest dc5-psr: SUCCESS (2.875s)
[201.132296] [014/131] (817s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[206.170352] Starting subtest: psr2-cursor-plane-move-continuous-sf
[206.172336] Starting dynamic subtest: pipe-A-eDP-1
[217.264112] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.093s)
[217.272624] Starting dynamic subtest: pipe-B-eDP-1
[228.301645] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.036s)
[228.304089] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.133s)
[229.116643] [015/131] (789s left) gem_tiled_pread_basic
[229.237620] [016/131] (789s left) kms_atomic (test-only)
[229.329099] Starting subtest: test-only
[229.373182] Starting dynamic subtest: pipe-A-eDP-1
[231.909711] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.534s)
[231.911647] Subtest test-only: SUCCESS (2.581s)
[232.790817] [017/131] (785s left) gem_eio (in-flight-internal-10ms)
[233.034878] Starting subtest: in-flight-internal-10ms
[234.969693] Subtest in-flight-internal-10ms: SUCCESS (1.934s)
[235.154273] [018/131] (783s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[235.250478] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[235.252786] Starting dynamic subtest: pipe-A-eDP-1
[235.276048] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.286439] Starting dynamic subtest: pipe-B-eDP-1
[235.308403] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.315798] Starting dynamic subtest: pipe-C-eDP-1
[235.337239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.344924] Starting dynamic subtest: pipe-D-eDP-1
[235.367112] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.371261] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[237.465522] [019/131] (781s left) gem_exec_params (sol-reset-invalid)
[237.528595] Starting subtest: sol-reset-invalid
[237.531037] Subtest sol-reset-invalid: SUCCESS (0.002s)
[239.026905] [020/131] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[239.135585] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[239.139833] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[239.269448] [021/131] (779s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[239.337403] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[239.408267] [022/131] (779s left) prime_mmap_kms (buffer-sharing)
[239.514833] Starting subtest: buffer-sharing
[239.963399] Subtest buffer-sharing: SUCCESS (0.450s)
[240.803241] [023/131] (778s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[240.871740] Starting subtest: multi-wait-available-submitted-signaled
[240.873824] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[240.992962] [024/131] (777s left) kms_plane (plane-panning-bottom-right-suspend)
[241.084856] Starting subtest: plane-panning-bottom-right-suspend
[241.086735] Starting dynamic subtest: pipe-A
[258.544780] Dynamic subtest pipe-A: SUCCESS (6.580s)
[258.554287] Starting dynamic subtest: pipe-B
[276.509896] Dynamic subtest pipe-B: SUCCESS (3.455s)
[276.512240] Subtest plane-panning-bottom-right-suspend: SUCCESS (10.037s)
[277.331552] [025/131] (741s left) kms_big_fb (x-tiled-addfb-size-overflow)
[277.453835] Starting subtest: x-tiled-addfb-size-overflow
[277.456042] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[277.576619] [026/131] (741s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[277.683292] Starting subtest: yf-tiled-64bpp-rotate-0
[277.687254] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[277.791358] [027/131] (741s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[277.943097] Starting subtest: cursor-rapid-movement-32x32
[277.988968] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[278.296802] [028/131] (740s left) prime_vgem (fence-read-hang)
[278.380250] Subtest fence-read-hang: SKIP (0.000s)
[278.530452] [029/131] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[278.638107] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[285.927361] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.351s)
[286.099970] [030/131] (733s left) perf_pmu (idle-no-semaphores)
[286.139601] Starting subtest: idle-no-semaphores
[286.141863] Starting dynamic subtest: rcs0
[286.709695] Dynamic subtest rcs0: SUCCESS (0.570s)
[286.720621] Starting dynamic subtest: bcs0
[287.241158] Dynamic subtest bcs0: SUCCESS (0.532s)
[287.252827] Starting dynamic subtest: vcs0
[287.758379] Dynamic subtest vcs0: SUCCESS (0.517s)
[287.768314] Starting dynamic subtest: vcs1
[288.277848] Dynamic subtest vcs1: SUCCESS (0.520s)
[288.287828] Starting dynamic subtest: vecs0
[288.803693] Dynamic subtest vecs0: SUCCESS (0.527s)
[288.815000] Starting dynamic subtest: ccs0
[289.331756] Dynamic subtest ccs0: SUCCESS (0.526s)
[289.334457] Subtest idle-no-semaphores: SUCCESS (3.205s)
[289.484662] [031/131] (729s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[289.883401] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[290.738845] [032/131] (728s left) kms_chamelium_edid (dp-edid-read)
[291.138463] Subtest dp-edid-read: SKIP (0.000s)
[291.958949] [033/131] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[292.054299] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[292.058606] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[292.191422] [034/131] (727s left) prime_vgem (fence-wait)
[292.271940] Starting subtest: fence-wait
[292.274127] Starting dynamic subtest: rcs0
[293.322242] Dynamic subtest rcs0: SUCCESS (1.051s)
[293.334061] Starting dynamic subtest: bcs0
[294.404434] Dynamic subtest bcs0: SUCCESS (1.084s)
[294.415581] Starting dynamic subtest: vcs0
[295.448896] Dynamic subtest vcs0: SUCCESS (1.046s)
[295.460564] Starting dynamic subtest: vcs1
[296.486844] Dynamic subtest vcs1: SUCCESS (1.038s)
[296.498106] Starting dynamic subtest: vecs0
[297.527989] Dynamic subtest vecs0: SUCCESS (1.042s)
[297.539260] Starting dynamic subtest: ccs0
[298.571634] Dynamic subtest ccs0: SUCCESS (1.043s)
[298.574309] Subtest fence-wait: SUCCESS (6.312s)
[298.739010] [035/131] (720s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[298.843548] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[298.947818] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[299.050796] [036/131] (720s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[299.108690] Starting subtest: yf-tiled-to-vebox-yf-tiled
[299.113098] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[299.319332] [037/131] (720s left) kms_addfb_basic (too-wide)
[299.423080] Starting subtest: too-wide
[299.425237] Subtest too-wide: SUCCESS (0.000s)
[299.563663] [038/131] (720s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[299.659575] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[300.316352] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[300.490100] [039/131] (719s left) kms_joiner (invalid-modeset-ultra-joiner)
[300.593222] Starting subtest: invalid-modeset-ultra-joiner
[300.597646] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[300.682479] [040/131] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[300.803017] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[300.807200] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[300.936575] [041/131] (718s left) gem_exec_reloc (basic-write-wc-active)
[300.998751] Subtest basic-write-wc-active: SKIP (0.000s)
[301.077925] [042/131] (718s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[301.174482] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[301.176637] Starting dynamic subtest: pipe-A-eDP-1
[301.988303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[301.997518] Starting dynamic subtest: pipe-B-eDP-1
[303.521771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.532s)
[303.531736] Starting dynamic subtest: pipe-C-eDP-1
[304.988590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.468s)
[304.998832] Starting dynamic subtest: pipe-D-eDP-1
[306.517580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[306.519442] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.340s)
[307.731380] [043/131] (712s left) kms_frontbuffer_tracking (psr-1p-rte)
[307.844568] Starting subtest: psr-1p-rte
[313.212686] Subtest psr-1p-rte: SUCCESS (5.370s)
[313.372060] [044/131] (706s left) gem_ccs (block-copy-uncompressed)
[313.432513] Starting subtest: block-copy-uncompressed
[313.434782] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[313.455119] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[313.466212] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[313.476633] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[313.486320] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[313.494050] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[313.502572] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[313.511134] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[313.513453] Subtest block-copy-uncompressed: SUCCESS (0.079s)
[313.681564] [045/131] (706s left) kms_psr (psr-sprite-plane-onoff)
[313.783696] Starting subtest: psr-sprite-plane-onoff
[313.786053] Starting dynamic subtest: eDP-1
[315.539531] Dynamic subtest eDP-1: SUCCESS (1.757s)
[315.541686] Subtest psr-sprite-plane-onoff: SUCCESS (1.758s)
[316.386783] [046/131] (703s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[316.449763] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[316.558991] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[316.656424] [047/131] (703s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[316.780763] Starting subtest: cursorB-vs-flipB-varying-size
[316.785152] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[316.953607] [048/131] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[317.055927] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[317.060045] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[317.200049] [049/131] (702s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[317.286450] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[317.288770] Starting dynamic subtest: pipe-A-default-mode
[317.581602] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[317.585835] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.294s)
[318.402071] [050/131] (701s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[318.496406] Starting subtest: psr-rgb101010-draw-mmap-wc
[325.574545] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.082s)
[325.734261] [051/131] (694s left) gem_mmap_wc (bad-size)
[325.801342] Subtest bad-size: SKIP (0.000s)
[325.878162] [052/131] (694s left) gem_ctx_persistence (legacy-engines-cleanup)
[325.946679] Starting subtest: legacy-engines-cleanup
[325.949040] Starting dynamic subtest: render
[326.079668] Dynamic subtest render: SUCCESS (0.132s)
[326.092631] Starting dynamic subtest: bsd1
[326.154447] Dynamic subtest bsd1: SUCCESS (0.072s)
[326.169421] Starting dynamic subtest: bsd2
[326.220178] Dynamic subtest bsd2: SUCCESS (0.063s)
[326.231671] Starting dynamic subtest: blt
[326.250124] Dynamic subtest blt: SUCCESS (0.028s)
[326.259162] Starting dynamic subtest: vebox
[326.357955] Dynamic subtest vebox: SUCCESS (0.106s)
[326.360351] Subtest legacy-engines-cleanup: SUCCESS (0.413s)
[326.457354] [053/131] (693s left) perf_pmu (busy-no-semaphores)
[326.500612] Starting subtest: busy-no-semaphores
[326.502777] Starting dynamic subtest: rcs0
[327.096143] Dynamic subtest rcs0: SUCCESS (0.596s)
[327.109178] Starting dynamic subtest: bcs0
[327.646769] Dynamic subtest bcs0: SUCCESS (0.548s)
[327.659342] Starting dynamic subtest: vcs0
[328.196830] Dynamic subtest vcs0: SUCCESS (0.548s)
[328.208721] Starting dynamic subtest: vcs1
[329.846012] Dynamic subtest vcs1: SUCCESS (1.647s)
[329.858211] Starting dynamic subtest: vecs0
[331.829616] Dynamic subtest vecs0: SUCCESS (1.981s)
[331.841744] Starting dynamic subtest: ccs0
[333.881041] Dynamic subtest ccs0: SUCCESS (2.048s)
[333.884085] Subtest busy-no-semaphores: SUCCESS (7.384s)
[334.021169] [054/131] (686s left) kms_force_connector_basic (prune-stale-modes)
[334.107770] Starting subtest: prune-stale-modes
[334.427004] Subtest prune-stale-modes: SUCCESS (0.319s)
[334.589867] [055/131] (685s left) gem_set_tiling_vs_gtt
[334.725350] [056/131] (685s left) gem_ctx_exec (basic-invalid-context)
[334.785534] Starting subtest: basic-invalid-context
[334.790177] Subtest basic-invalid-context: SUCCESS (0.005s)
[334.959701] [057/131] (685s left) gem_ctx_param (invalid-size-get)
[335.015795] Starting subtest: invalid-size-get
[335.017734] Subtest invalid-size-get: SUCCESS (0.001s)
[335.159656] [058/131] (685s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[335.256859] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[335.258780] Starting dynamic subtest: pipe-A-eDP-1
[335.277666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[335.286895] Starting dynamic subtest: pipe-B-eDP-1
[335.304866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.313064] Starting dynamic subtest: pipe-C-eDP-1
[335.330635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[335.338664] Starting dynamic subtest: pipe-D-eDP-1
[335.356550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[335.359928] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[337.544624] [059/131] (682s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[337.608338] Starting subtest: invalid-multi-wait-all-unsubmitted
[337.610528] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[337.744559] [060/131] (682s left) gem_sync (basic-all)
[337.822667] Starting subtest: basic-all
[341.258413] Subtest basic-all: SUCCESS (3.447s)
[341.471641] [061/131] (679s left) kms_cursor_crc (cursor-sliding-256x256)
[341.717778] Starting subtest: cursor-sliding-256x256
[341.720181] Starting dynamic subtest: pipe-A-eDP-1
[344.954999] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.236s)
[344.994786] Starting dynamic subtest: pipe-D-eDP-1
[348.869751] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.895s)
[348.872133] Subtest cursor-sliding-256x256: SUCCESS (7.157s)
[349.739802] [062/131] (670s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[349.871452] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[349.875952] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[350.036989] [063/131] (670s left) gem_render_copy_redux (normal)
[350.099105] Starting subtest: normal
[350.360068] Subtest normal: SUCCESS (0.260s)
[350.526479] [064/131] (670s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[350.642790] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[350.646977] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[350.761623] [065/131] (669s left) kms_busy (extended-pageflip-hang-oldfb)
[350.880305] Starting subtest: extended-pageflip-hang-oldfb
[350.882354] Starting dynamic subtest: pipe-A
[351.282142] Dynamic subtest pipe-A: SUCCESS (0.401s)
[351.294779] Starting dynamic subtest: pipe-D
[352.386127] Dynamic subtest pipe-D: SUCCESS (1.103s)
[352.388463] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.509s)
[353.233077] [066/131] (667s left) kms_pm_rpm (system-suspend-idle)
[355.459991] Starting subtest: system-suspend-idle
[375.632114] Subtest system-suspend-idle: SUCCESS (4.574s)
[376.043191] [067/131] (644s left) gem_huc_copy (huc-copy)
[376.105945] Starting subtest: huc-copy
[376.111136] Subtest huc-copy: SUCCESS (0.003s)
[376.266158] [068/131] (644s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[381.180930] Starting subtest: psr2-plane-move-sf-dmg-area
[381.183304] Starting dynamic subtest: pipe-A-eDP-1
[386.323604] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.177s)
[386.333277] Starting dynamic subtest: pipe-B-eDP-1
[391.507110] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.200s)
[391.509273] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.382s)
[392.365296] [069/131] (628s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[392.479311] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[392.490826] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[392.617884] [070/131] (628s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[392.721469] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[392.846124] [071/131] (628s left) gem_eio (reset-stress)
[393.086186] Starting subtest: reset-stress
[393.088440] Starting dynamic subtest: render
[398.520963] Dynamic subtest render: SUCCESS (5.443s)
[398.537487] Starting dynamic subtest: bsd1
[416.532303] Dynamic subtest bsd1: SUCCESS (18.018s)
[416.549849] Starting dynamic subtest: bsd2
[434.460415] Dynamic subtest bsd2: SUCCESS (17.926s)
[434.477734] Starting dynamic subtest: blt
[434.482491] Dynamic subtest blt: SKIP (0.000s)
[434.490684] Starting dynamic subtest: vebox
[452.528707] Dynamic subtest vebox: SUCCESS (18.070s)
[452.530649] Subtest reset-stress: SUCCESS (59.462s)
[453.986834] [072/131] (566s left) vgem_basic (dmabuf-fence-before)
[454.036934] Starting subtest: dmabuf-fence-before
[454.038949] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[454.118914] [073/131] (566s left) gem_softpin (reverse)
[454.170593] Starting subtest: reverse
[454.175594] Subtest reverse: SUCCESS (0.005s)
[454.334467] [074/131] (566s left) kms_plane_multiple (2x-tiling-4)
[454.451216] Starting subtest: 2x-tiling-4
[454.455296] Subtest 2x-tiling-4: SKIP (0.000s)
[454.549874] [075/131] (566s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[454.619184] Subtest writes-after-reads-uncached: SKIP (0.000s)
[454.704814] [076/131] (566s left) api_intel_bb (object-noreloc-keep-cache-simple)
[454.762415] Starting subtest: object-noreloc-keep-cache-simple
[454.765440] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[454.931535] [077/131] (566s left) kms_selftest (drm_format_helper)
[454.974893] Starting subtest: drm_format_helper
[454.982210] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[455.081318] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.099s)
[455.091254] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[455.218280] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.134s)
[455.229310] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[455.342945] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.125s)
[455.352109] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[455.469097] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.124s)
[455.478692] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[455.609210] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.140s)
[455.618176] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[455.777704] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.167s)
[455.786918] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[455.905369] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.126s)
[455.914480] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[456.050309] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.145s)
[456.059977] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[456.185374] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.135s)
[456.194347] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[456.304998] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.119s)
[456.314273] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[456.450249] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.144s)
[456.461240] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[456.564515] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.115s)
[456.573467] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[456.704222] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.137s)
[456.714730] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[456.854634] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.151s)
[456.863296] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[457.012294] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.157s)
[457.023009] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[457.152429] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.140s)
[457.161536] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[457.300380] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.147s)
[457.302722] Subtest drm_format_helper: SUCCESS (2.328s)
[457.556635] [078/131] (563s left) kms_vblank (wait-idle)
[457.663243] Starting subtest: wait-idle
[457.665115] Starting dynamic subtest: pipe-A-eDP-1
[459.428867] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.766s)
[459.443681] Starting dynamic subtest: pipe-D-eDP-1
[461.919436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.490s)
[461.921821] Subtest wait-idle: SUCCESS (4.260s)
[462.831160] [079/131] (558s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[462.927255] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[462.929525] Starting dynamic subtest: pipe-A-eDP-1
[462.950356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[462.962188] Starting dynamic subtest: pipe-B-eDP-1
[462.982232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[462.993156] Starting dynamic subtest: pipe-C-eDP-1
[463.012955] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[463.021529] Starting dynamic subtest: pipe-D-eDP-1
[463.041066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[463.042979] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[465.224593] [080/131] (556s left) gem_exec_whisper (basic-normal)
[465.291173] Starting subtest: basic-normal
[470.287687] Subtest basic-normal: SUCCESS (4.997s)
[470.501456] [081/131] (550s left) gem_spin_batch (user-each)
[470.575009] Starting subtest: user-each
[473.939859] Subtest user-each: SUCCESS (3.365s)
[476.018717] [082/131] (545s left) gem_ctx_shared (exec-shared-gtt)
[476.083592] Starting subtest: exec-shared-gtt
[476.085990] Starting dynamic subtest: rcs0
[476.092287] Dynamic subtest rcs0: SUCCESS (0.011s)
[476.104195] Starting dynamic subtest: bcs0
[476.106198] Dynamic subtest bcs0: SUCCESS (0.010s)
[476.115810] Starting dynamic subtest: vcs0
[476.118024] Dynamic subtest vcs0: SUCCESS (0.009s)
[476.127411] Starting dynamic subtest: vcs1
[476.129316] Dynamic subtest vcs1: SUCCESS (0.009s)
[476.138431] Starting dynamic subtest: vecs0
[476.140661] Dynamic subtest vecs0: SUCCESS (0.008s)
[476.149895] Starting dynamic subtest: ccs0
[476.151826] Dynamic subtest ccs0: SUCCESS (0.011s)
[476.153720] Subtest exec-shared-gtt: SUCCESS (0.062s)
[476.363584] [083/131] (545s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[476.483620] Starting subtest: basic-flip-after-cursor-legacy
[477.404089] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.920s)
[478.232384] [084/131] (543s left) i915_hangman (detector)
[478.304202] Starting subtest: detector
[478.306049] Starting dynamic subtest: rcs0
[489.923764] Dynamic subtest rcs0: SUCCESS (11.615s)
[489.935806] Starting dynamic subtest: bcs0
[501.891942] Dynamic subtest bcs0: SUCCESS (11.963s)
[501.904220] Starting dynamic subtest: vcs0
[513.858537] Dynamic subtest vcs0: SUCCESS (11.964s)
[513.870757] Starting dynamic subtest: vcs1
[524.867631] Dynamic subtest vcs1: SUCCESS (11.006s)
[524.879937] Starting dynamic subtest: vecs0
[536.835077] Dynamic subtest vecs0: SUCCESS (11.966s)
[536.847292] Starting dynamic subtest: ccs0
[547.907397] Dynamic subtest ccs0: SUCCESS (11.071s)
[547.910419] Subtest detector: SUCCESS (69.602s)
[548.013164] [085/131] (473s left) kms_atomic_transition (plane-all-transition-nonblocking)
[548.119155] Starting subtest: plane-all-transition-nonblocking
[548.121496] Starting dynamic subtest: pipe-A-eDP-1
[550.612141] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[550.929519] Starting dynamic subtest: pipe-B-eDP-1
[554.196917] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.277s)
[554.501306] Subtest plane-all-transition-nonblocking: SUCCESS (6.384s)
[555.331227] [086/131] (466s left) gem_exec_schedule (semaphore-codependency)
[555.420714] Starting subtest: semaphore-codependency
[555.444184] Subtest semaphore-codependency: SUCCESS (0.026s)
[555.840746] [087/131] (465s left) gem_exec_params (sol-reset-not-gen7)
[555.897950] Starting subtest: sol-reset-not-gen7
[555.900725] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[556.057506] [088/131] (465s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[556.138100] Starting subtest: bo-too-small-due-to-tiling
[556.142349] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[556.286218] [089/131] (465s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[556.343788] Starting subtest: multi-wait-all-for-submit-signaled
[556.346213] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[556.466049] [090/131] (465s left) kms_color (invalid-gamma-lut-sizes)
[556.554176] Starting subtest: invalid-gamma-lut-sizes
[556.556454] Starting dynamic subtest: pipe-A
[556.839087] Dynamic subtest pipe-A: SUCCESS (0.286s)
[556.849024] Starting dynamic subtest: pipe-B
[556.851328] Dynamic subtest pipe-B: SUCCESS (0.001s)
[556.860706] Starting dynamic subtest: pipe-C
[556.863107] Dynamic subtest pipe-C: SUCCESS (0.001s)
[556.872302] Starting dynamic subtest: pipe-D
[556.874597] Dynamic subtest pipe-D: SUCCESS (0.001s)
[556.876850] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[557.705018] [091/131] (464s left) kms_plane_alpha_blend (alpha-opaque-fb)
[557.807347] Starting subtest: alpha-opaque-fb
[558.099799] Starting dynamic subtest: pipe-A-eDP-1
[558.788290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[558.798341] Starting dynamic subtest: pipe-D-eDP-1
[560.090118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[560.092401] Subtest alpha-opaque-fb: SUCCESS (2.284s)
[560.909228] [092/131] (460s left) kms_psr (pr-sprite-blt)
[561.010208] Starting subtest: pr-sprite-blt
[561.014592] Subtest pr-sprite-blt: SKIP (0.000s)
[561.106648] [093/131] (460s left) kms_chamelium_color (ctm-red-to-blue)
[561.209116] Subtest ctm-red-to-blue: SKIP (0.000s)
[561.254527] [094/131] (460s left) gem_mmap_gtt (big-copy)
[561.307848] Subtest big-copy: SKIP (0.000s)
[561.368016] [095/131] (460s left) gem_mmap_gtt (hang-busy)
[561.427887] Subtest hang-busy: SKIP (0.000s)
[561.498175] [096/131] (460s left) i915_suspend (basic-s3-without-i915)
[561.536237] Starting subtest: basic-s3-without-i915
[564.971770] Subtest basic-s3-without-i915: SKIP (3.435s)
[566.609311] [097/131] (455s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[566.731095] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[566.855623] [098/131] (455s left) syncobj_wait (invalid-signal-illegal-handle)
[566.926913] Starting subtest: invalid-signal-illegal-handle
[566.929248] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[567.043276] [099/131] (455s left) kms_psr (fbc-psr2-cursor-blt)
[567.136815] Starting subtest: fbc-psr2-cursor-blt
[567.139080] Starting dynamic subtest: eDP-1
[567.143201] Dynamic subtest eDP-1: SKIP (0.000s)
[567.147146] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[567.237710] [100/131] (454s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[567.341214] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[568.563825] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.222s)
[568.726599] [101/131] (453s left) gem_exec_schedule (pi-ringfull)
[568.915807] Starting subtest: pi-ringfull
[568.917890] Starting dynamic subtest: rcs0
[568.940943] Dynamic subtest rcs0: SUCCESS (0.028s)
[568.954829] Starting dynamic subtest: bcs0
[568.969161] Dynamic subtest bcs0: SUCCESS (0.027s)
[568.983274] Starting dynamic subtest: vcs0
[568.996310] Dynamic subtest vcs0: SUCCESS (0.026s)
[569.009367] Starting dynamic subtest: vcs1
[569.023341] Dynamic subtest vcs1: SUCCESS (0.026s)
[569.036862] Starting dynamic subtest: vecs0
[569.050120] Dynamic subtest vecs0: SUCCESS (0.026s)
[569.064101] Starting dynamic subtest: ccs0
[569.077102] Dynamic subtest ccs0: SUCCESS (0.026s)
[569.079466] Subtest pi-ringfull: SUCCESS (0.165s)
[569.314883] [102/131] (452s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[569.415771] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[576.276567] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.865s)
[576.405149] [103/131] (445s left) kms_addfb_basic (clobberred-modifier)
[576.473997] Starting subtest: clobberred-modifier
[576.478531] Subtest clobberred-modifier: SKIP (0.000s)
[576.632949] [104/131] (445s left) gem_exec_params (batch-first)
[576.686221] Starting subtest: batch-first
[576.692268] Subtest batch-first: SUCCESS (0.006s)
[576.874625] [105/131] (445s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[576.935898] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[577.009377] [106/131] (445s left) drm_read (empty-nonblock)
[577.159089] Starting subtest: empty-nonblock
[577.161455] Subtest empty-nonblock: SUCCESS (0.000s)
[577.334960] [107/131] (445s left) kms_content_protection (uevent)
[577.477590] Starting subtest: uevent
[577.481661] Subtest uevent: SKIP (0.000s)
[577.630685] [108/131] (444s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[577.713268] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[577.715148] Starting dynamic subtest: pipe-A
[578.761347] Dynamic subtest pipe-A: SUCCESS (1.050s)
[578.769914] Starting dynamic subtest: pipe-B
[580.892862] Dynamic subtest pipe-B: SUCCESS (2.130s)
[580.903860] Starting dynamic subtest: pipe-C
[582.078526] Dynamic subtest pipe-C: SUCCESS (1.182s)
[582.087923] Starting dynamic subtest: pipe-D
[583.301786] Dynamic subtest pipe-D: SUCCESS (1.223s)
[583.304130] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.592s)
[584.528829] [109/131] (438s left) gem_mmap_gtt (basic-write-gtt)
[584.595158] Subtest basic-write-gtt: SKIP (0.000s)
[584.660236] [110/131] (437s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[584.766529] Starting subtest: psr-farfromfence-mmap-gtt
[584.770644] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[584.892782] [111/131] (437s left) kms_dp_link_training (non-uhbr-mst)
[584.986498] Starting subtest: non-uhbr-mst
[584.995742] Subtest non-uhbr-mst: SKIP (0.000s)
[585.089948] [112/131] (437s left) gem_basic (bad-close)
[585.151917] Starting subtest: bad-close
[585.156410] Subtest bad-close: SUCCESS (0.000s)
[585.285308] [113/131] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[585.395365] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[585.399466] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[585.507161] [114/131] (437s left) kms_psr (fbc-psr-primary-blt)
[585.597772] Starting subtest: fbc-psr-primary-blt
[585.599764] Starting dynamic subtest: eDP-1
[585.603419] Dynamic subtest eDP-1: SKIP (0.000s)
[585.607047] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[585.699572] [115/131] (437s left) sysfs_timeslice_duration (duration)
[585.769579] Starting subtest: duration
[585.771593] Starting dynamic subtest: vecs0
[600.835900] Dynamic subtest vecs0: SUCCESS (15.069s)
[600.847806] Starting dynamic subtest: ccs0
[614.019416] Dynamic subtest ccs0: SUCCESS (13.178s)
[614.031308] Starting dynamic subtest: vcs0
[628.867620] Dynamic subtest vcs0: SUCCESS (14.841s)
[628.880556] Starting dynamic subtest: bcs0
[642.015273] Dynamic subtest bcs0: SUCCESS (13.144s)
[642.027831] Starting dynamic subtest: rcs0
[655.174362] Dynamic subtest rcs0: SUCCESS (13.155s)
[655.186078] Starting dynamic subtest: vcs1
[668.867467] Dynamic subtest vcs1: SUCCESS (13.689s)
[668.870323] Subtest duration: SUCCESS (83.092s)
[668.969630] [116/131] (353s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[669.077654] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[669.082127] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[669.214221] [117/131] (353s left) kms_draw_crc (fill-fb)
[669.320495] Starting subtest: fill-fb
[669.817114] Subtest fill-fb: SUCCESS (0.498s)
[669.959350] [118/131] (352s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[670.067443] Starting subtest: y-tiled-16bpp-rotate-90
[670.071243] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[670.218486] [119/131] (352s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[670.326199] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[670.329838] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[670.458453] [120/131] (352s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[670.571371] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[677.305795] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.736s)
[677.455709] [121/131] (345s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[677.552788] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[677.554999] Starting dynamic subtest: pipe-A-default-mode
[680.260652] Dynamic subtest pipe-A-default-mode: SUCCESS (2.708s)
[680.262922] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.710s)
[681.122636] [122/131] (341s left) gem_pxp (reject-modify-context-protection-on)
[681.257617] Starting subtest: reject-modify-context-protection-on
[681.260066] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[681.396696] [123/131] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[681.497804] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[681.501959] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[681.607452] [124/131] (341s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[681.708910] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[681.713375] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[681.842982] [125/131] (341s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[686.879499] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[686.884097] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.003s)
[687.754401] [126/131] (335s left) kms_hdr (static-toggle-suspend)
[687.855067] Starting subtest: static-toggle-suspend
[687.861308] Subtest static-toggle-suspend: SKIP (0.000s)
[687.953390] [127/131] (335s left) dmabuf_sync_file (export-wait-after-attach)
[688.002341] Starting subtest: export-wait-after-attach
[688.004260] Subtest export-wait-after-attach: SUCCESS (0.001s)
[688.084937] [128/131] (335s left) kms_cursor_legacy (single-move)
[688.219651] Starting subtest: single-move
[688.221894] Starting dynamic subtest: pipe-A
[693.601923] Dynamic subtest pipe-A: SUCCESS (5.379s)
[693.613894] Starting dynamic subtest: pipe-B
[698.983715] Dynamic subtest pipe-B: SUCCESS (5.380s)
[698.994422] Starting dynamic subtest: pipe-C
[704.366062] Dynamic subtest pipe-C: SUCCESS (5.380s)
[704.376606] Starting dynamic subtest: pipe-D
[709.754006] Dynamic subtest pipe-D: SUCCESS (5.379s)
[709.766913] Starting dynamic subtest: all-pipes
[715.139556] Dynamic subtest all-pipes: SUCCESS (5.388s)
[715.141839] Subtest single-move: SUCCESS (26.919s)
[715.308487] [129/131] (308s left) gem_exec_fence (basic-wait)
[715.502952] Starting subtest: basic-wait
[715.505384] Starting dynamic subtest: rcs0
[715.612871] Dynamic subtest rcs0: SUCCESS (0.110s)
[715.624913] Starting dynamic subtest: bcs0
[715.680609] Dynamic subtest bcs0: SUCCESS (0.066s)
[715.692264] Starting dynamic subtest: vcs0
[715.744377] Dynamic subtest vcs0: SUCCESS (0.061s)
[715.756529] Starting dynamic subtest: vcs1
[715.804414] Dynamic subtest vcs1: SUCCESS (0.058s)
[715.815737] Starting dynamic subtest: vecs0
[715.858951] Dynamic subtest vecs0: SUCCESS (0.052s)
[715.869899] Starting dynamic subtest: ccs0
[715.923311] Dynamic subtest ccs0: SUCCESS (0.062s)
[715.925793] Subtest basic-wait: SUCCESS (0.422s)
[718.026416] [130/131] (305s left) gem_exec_balancer (full-late)
[718.086745] Starting subtest: full-late
[722.766975] Subtest full-late: SUCCESS (4.680s)
[723.122978] [131/131] (300s left) gem_exec_params (readonly)
[723.203822] Starting subtest: readonly
[723.209210] Subtest readonly: SUCCESS (0.005s)
[723.365374] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_atomic_interruptible
results: parsing output: 4/ for test: kms_getfb
results: parsing output: 5/ for test: gem_ccs
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: i915_pm_rc6_residency
results: parsing output: 12/ for test: kms_pm_dc
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_tiled_pread_basic
results: parsing output: 15/ for test: kms_atomic
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_pipe_b_c_ivb
results: parsing output: 21/ for test: prime_mmap_kms
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_joiner
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ccs
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_force_connector_basic
results: parsing output: 54/ for test: gem_set_tiling_vs_gtt
results: parsing output: 55/ for test: gem_ctx_exec
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: gem_sync
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_render_copy_redux
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_busy
results: parsing output: 65/ for test: kms_pm_rpm
results: parsing output: 66/ for test: gem_huc_copy
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: gem_partial_pwrite_pread
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_selftest
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_spin_batch
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: i915_hangman
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_plane_alpha_blend
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_chamelium_color
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: i915_suspend
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: drm_read
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_dp_link_training
results: parsing output: 111/ for test: gem_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_draw_crc
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_hdr
results: parsing output: 126/ for test: dmabuf_sync_file
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_exec_fence
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: gem_exec_params
Done.