[56.694751] Initializing watchdogs
[56.694895]   /dev/watchdog0
[56.709301] [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]
[56.713784] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.716173] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.719561] [001/131] (960s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[56.873107] Starting subtest: cursor-vs-flip-atomic-transitions
[86.799956] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.927s)
[87.650324] [002/131] (929s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[87.719898] Starting subtest: single-wait-for-submit-available-signaled
[87.722173] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[87.853942] [003/131] (929s left) i915_drm_fdinfo (memory-info-shared)
[87.894261] Starting subtest: memory-info-shared
[87.896519] Starting dynamic subtest: smem0
[87.943881] Dynamic subtest smem0: SUCCESS (0.049s)
[87.946517] Subtest memory-info-shared: SUCCESS (0.050s)
[88.039859] [004/131] (929s left) kms_atomic_interruptible (legacy-dpms)
[88.160196] Starting subtest: legacy-dpms
[88.162548] Starting dynamic subtest: pipe-A-eDP-1
[95.581624] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s)
[95.583805] Subtest legacy-dpms: SUCCESS (7.421s)
[96.418990] [005/131] (920s left) kms_getfb (getfb-handle-closed)
[96.528928] Starting subtest: getfb-handle-closed
[96.531282] Subtest getfb-handle-closed: SUCCESS (0.000s)
[96.668498] [006/131] (920s left) gem_ccs (suspend-resume)
[96.744265] Starting subtest: suspend-resume
[96.748716] Subtest suspend-resume: SKIP (0.000s)
[96.895280] [007/131] (920s left) gem_exec_fence (syncobj-signal)
[97.347824] Starting subtest: syncobj-signal
[97.352764] Subtest syncobj-signal: SUCCESS (0.005s)
[99.033657] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[99.036717] [008/131] (918s left) kms_flip (basic-plain-flip)
[99.134709] Starting subtest: basic-plain-flip
[99.137063] Starting dynamic subtest: A-eDP1
[100.805901] Dynamic subtest A-eDP1: SUCCESS (1.672s)
[100.818073] Starting dynamic subtest: B-eDP1
[102.436161] Dynamic subtest B-eDP1: SUCCESS (1.629s)
[102.445552] Starting dynamic subtest: C-eDP1
[104.062172] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[104.069060] Starting dynamic subtest: D-eDP1
[105.706118] Dynamic subtest D-eDP1: SUCCESS (1.643s)
[105.710759] Subtest basic-plain-flip: SUCCESS (6.578s)
[106.906698] [009/131] (910s left) kms_rotation_crc (sprite-rotation-270)
[107.015446] Starting subtest: sprite-rotation-270
[107.020129] Subtest sprite-rotation-270: SKIP (0.001s)
[107.116227] [010/131] (910s left) kms_psr (psr2-sprite-render)
[107.221845] Starting subtest: psr2-sprite-render
[107.224228] Starting dynamic subtest: eDP-1
[108.992745] Dynamic subtest eDP-1: SUCCESS (1.770s)
[108.995327] Subtest psr2-sprite-render: SUCCESS (1.770s)
[109.883925] [011/131] (907s left) gen9_exec_parse (batch-without-end)
[109.950917] Subtest batch-without-end: SKIP (0.000s)
[110.031848] [012/131] (907s left) i915_pm_rc6_residency (rc6-idle)
[110.089664] Starting subtest: rc6-idle
[110.112281] Starting dynamic subtest: gt0-rcs0
[134.511842] Dynamic subtest gt0-rcs0: SUCCESS (24.399s)
[134.521662] Starting dynamic subtest: gt0-bcs0
[158.725058] Dynamic subtest gt0-bcs0: SUCCESS (24.211s)
[158.735214] Starting dynamic subtest: gt0-ccs0
[183.085748] Dynamic subtest gt0-ccs0: SUCCESS (24.359s)
[183.095842] Starting dynamic subtest: gt1-vcs0
[189.258632] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[189.269359] Starting dynamic subtest: gt1-vecs0
[195.428992] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[195.431845] Subtest rc6-idle: SUCCESS (85.337s)
[195.533200] [013/131] (822s left) kms_pm_dc (dc5-psr)
[196.643983] Starting subtest: dc5-psr
[199.629783] Subtest dc5-psr: SUCCESS (2.985s)
[200.495503] [014/131] (817s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[205.528747] Starting subtest: psr2-cursor-plane-move-continuous-sf
[205.531211] Starting dynamic subtest: pipe-A-eDP-1
[216.624474] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.094s)
[216.632268] Starting dynamic subtest: pipe-B-eDP-1
[227.655942] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.026s)
[227.658144] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.125s)
[228.469056] [015/131] (789s left) gem_tiled_pread_basic
[228.593138] [016/131] (789s left) kms_atomic (test-only)
[228.705666] Starting subtest: test-only
[228.760058] Starting dynamic subtest: pipe-A-eDP-1
[231.236496] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.476s)
[231.238713] Subtest test-only: SUCCESS (2.531s)
[232.067014] [017/131] (785s left) gem_eio (in-flight-internal-10ms)
[232.312323] Starting subtest: in-flight-internal-10ms
[234.025874] Subtest in-flight-internal-10ms: SUCCESS (1.714s)
[234.187758] [018/131] (783s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[234.287963] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[234.290317] Starting dynamic subtest: pipe-A-eDP-1
[234.312953] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[234.321717] Starting dynamic subtest: pipe-B-eDP-1
[234.343092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[234.350591] Starting dynamic subtest: pipe-C-eDP-1
[234.372643] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[234.379962] Starting dynamic subtest: pipe-D-eDP-1
[234.401873] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[234.406127] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[236.548240] [019/131] (781s left) gem_exec_params (sol-reset-invalid)
[236.628071] Starting subtest: sol-reset-invalid
[236.630544] Subtest sol-reset-invalid: SUCCESS (0.002s)
[237.986147] [020/131] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[238.090100] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[238.094457] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[238.232665] [021/131] (779s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[238.302317] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[238.375680] [022/131] (779s left) prime_mmap_kms (buffer-sharing)
[238.468127] Starting subtest: buffer-sharing
[238.911791] Subtest buffer-sharing: SUCCESS (0.445s)
[239.768674] [023/131] (778s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[239.842307] Starting subtest: multi-wait-available-submitted-signaled
[239.844620] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[239.985186] [024/131] (778s left) kms_plane (plane-panning-bottom-right-suspend)
[240.083810] Starting subtest: plane-panning-bottom-right-suspend
[240.086056] Starting dynamic subtest: pipe-A
[258.066552] Dynamic subtest pipe-A: SUCCESS (7.360s)
[258.076117] Starting dynamic subtest: pipe-B
[277.042362] Dynamic subtest pipe-B: SUCCESS (3.498s)
[277.044644] Subtest plane-panning-bottom-right-suspend: SUCCESS (10.860s)
[277.873877] [025/131] (740s left) kms_big_fb (x-tiled-addfb-size-overflow)
[278.019293] Starting subtest: x-tiled-addfb-size-overflow
[278.021772] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[278.157352] [026/131] (740s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[278.258583] Starting subtest: yf-tiled-64bpp-rotate-0
[278.262814] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[278.371466] [027/131] (739s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[278.514397] Starting subtest: cursor-rapid-movement-32x32
[278.607442] Subtest cursor-rapid-movement-32x32: SKIP (0.088s)
[278.917350] [028/131] (739s left) prime_vgem (fence-read-hang)
[279.003283] Subtest fence-read-hang: SKIP (0.000s)
[279.146498] [029/131] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[279.243994] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[286.618970] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.373s)
[286.811186] [030/131] (731s left) perf_pmu (idle-no-semaphores)
[286.856429] Starting subtest: idle-no-semaphores
[286.858768] Starting dynamic subtest: rcs0
[287.426415] Dynamic subtest rcs0: SUCCESS (0.568s)
[287.438432] Starting dynamic subtest: bcs0
[287.954998] Dynamic subtest bcs0: SUCCESS (0.526s)
[287.965210] Starting dynamic subtest: vcs0
[288.485970] Dynamic subtest vcs0: SUCCESS (0.528s)
[288.497950] Starting dynamic subtest: vcs1
[289.013813] Dynamic subtest vcs1: SUCCESS (0.525s)
[289.024746] Starting dynamic subtest: vecs0
[289.542818] Dynamic subtest vecs0: SUCCESS (0.527s)
[289.554839] Starting dynamic subtest: ccs0
[290.069956] Dynamic subtest ccs0: SUCCESS (0.525s)
[290.072859] Subtest idle-no-semaphores: SUCCESS (3.212s)
[290.191153] [031/131] (728s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[290.575530] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[291.400219] [032/131] (727s left) kms_chamelium_edid (dp-edid-read)
[291.783341] Subtest dp-edid-read: SKIP (0.000s)
[292.637224] [033/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[292.736981] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[292.741271] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[292.856638] [034/131] (725s left) prime_vgem (fence-wait)
[292.918316] Starting subtest: fence-wait
[292.920599] Starting dynamic subtest: rcs0
[293.986063] Dynamic subtest rcs0: SUCCESS (1.066s)
[293.996134] Starting dynamic subtest: bcs0
[295.038283] Dynamic subtest bcs0: SUCCESS (1.051s)
[295.049116] Starting dynamic subtest: vcs0
[296.082442] Dynamic subtest vcs0: SUCCESS (1.043s)
[296.092908] Starting dynamic subtest: vcs1
[297.122318] Dynamic subtest vcs1: SUCCESS (1.038s)
[297.133722] Starting dynamic subtest: vecs0
[298.165584] Dynamic subtest vecs0: SUCCESS (1.041s)
[298.177840] Starting dynamic subtest: ccs0
[299.208019] Dynamic subtest ccs0: SUCCESS (1.041s)
[299.211134] Subtest fence-wait: SUCCESS (6.288s)
[299.361918] [035/131] (719s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[299.416977] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[299.521625] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[299.626455] [036/131] (719s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[299.694165] Starting subtest: yf-tiled-to-vebox-yf-tiled
[299.698850] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[299.906345] [037/131] (718s left) kms_addfb_basic (too-wide)
[300.011688] Starting subtest: too-wide
[300.013554] Subtest too-wide: SUCCESS (0.000s)
[300.149015] [038/131] (718s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[300.257941] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[300.881986] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[301.093724] [039/131] (717s left) kms_joiner (invalid-modeset-ultra-joiner)
[301.199126] Starting subtest: invalid-modeset-ultra-joiner
[301.203254] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[301.288762] [040/131] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[301.388071] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[301.392152] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[301.514617] [041/131] (717s left) gem_exec_reloc (basic-write-wc-active)
[301.575444] Subtest basic-write-wc-active: SKIP (0.000s)
[301.644364] [042/131] (717s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[301.732273] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[301.734569] Starting dynamic subtest: pipe-A-eDP-1
[302.591640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[302.600306] Starting dynamic subtest: pipe-B-eDP-1
[304.155424] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.558s)
[304.165823] Starting dynamic subtest: pipe-C-eDP-1
[305.699253] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[305.710628] Starting dynamic subtest: pipe-D-eDP-1
[307.235390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[307.237715] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.495s)
[308.414054] [043/131] (710s left) kms_frontbuffer_tracking (psr-1p-rte)
[308.524893] Starting subtest: psr-1p-rte
[313.890987] Subtest psr-1p-rte: SUCCESS (5.370s)
[314.061308] [044/131] (704s left) gem_ccs (block-copy-uncompressed)
[314.136926] Starting subtest: block-copy-uncompressed
[314.139243] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[314.156183] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[314.167137] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[314.174241] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[314.182952] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[314.190872] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[314.199685] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[314.208259] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[314.210602] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[314.376070] [045/131] (704s left) kms_psr (psr-sprite-plane-onoff)
[314.476918] Starting subtest: psr-sprite-plane-onoff
[314.479306] Starting dynamic subtest: eDP-1
[316.238343] Dynamic subtest eDP-1: SUCCESS (1.762s)
[316.240765] Subtest psr-sprite-plane-onoff: SUCCESS (1.762s)
[317.075639] [046/131] (701s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[317.136971] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[317.241812] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[317.342117] [047/131] (701s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[317.470357] Starting subtest: cursorB-vs-flipB-varying-size
[317.475069] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[317.638494] [048/131] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[317.746161] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[317.750341] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[317.866109] [049/131] (701s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[317.961178] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[317.963379] Starting dynamic subtest: pipe-A-default-mode
[318.254841] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[318.259508] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.292s)
[319.102807] [050/131] (700s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[319.214353] Starting subtest: psr-rgb101010-draw-mmap-wc
[326.256924] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.045s)
[326.384505] [051/131] (692s left) gem_mmap_wc (bad-size)
[326.447271] Subtest bad-size: SKIP (0.000s)
[326.502709] [052/131] (692s left) gem_ctx_persistence (legacy-engines-cleanup)
[326.573402] Starting subtest: legacy-engines-cleanup
[326.576025] Starting dynamic subtest: render
[326.650840] Dynamic subtest render: SUCCESS (0.076s)
[326.662380] Starting dynamic subtest: bsd1
[326.708614] Dynamic subtest bsd1: SUCCESS (0.055s)
[326.720149] Starting dynamic subtest: bsd2
[326.758270] Dynamic subtest bsd2: SUCCESS (0.047s)
[326.768744] Starting dynamic subtest: blt
[326.832810] Dynamic subtest blt: SUCCESS (0.071s)
[326.844181] Starting dynamic subtest: vebox
[326.903773] Dynamic subtest vebox: SUCCESS (0.068s)
[326.906600] Subtest legacy-engines-cleanup: SUCCESS (0.331s)
[327.006486] [053/131] (692s left) perf_pmu (busy-no-semaphores)
[327.047508] Starting subtest: busy-no-semaphores
[327.049720] Starting dynamic subtest: rcs0
[327.619033] Dynamic subtest rcs0: SUCCESS (0.570s)
[327.630626] Starting dynamic subtest: bcs0
[328.170025] Dynamic subtest bcs0: SUCCESS (0.548s)
[328.182431] Starting dynamic subtest: vcs0
[328.719997] Dynamic subtest vcs0: SUCCESS (0.547s)
[328.732517] Starting dynamic subtest: vcs1
[330.504936] Dynamic subtest vcs1: SUCCESS (1.780s)
[330.517087] Starting dynamic subtest: vecs0
[332.550449] Dynamic subtest vecs0: SUCCESS (2.045s)
[332.562530] Starting dynamic subtest: ccs0
[334.536582] Dynamic subtest ccs0: SUCCESS (1.982s)
[334.539560] Subtest busy-no-semaphores: SUCCESS (7.489s)
[334.695625] [054/131] (684s left) kms_force_connector_basic (prune-stale-modes)
[334.780113] Starting subtest: prune-stale-modes
[335.233912] Subtest prune-stale-modes: SUCCESS (0.455s)
[335.395872] [055/131] (684s left) gem_set_tiling_vs_gtt
[335.539531] [056/131] (683s left) gem_ctx_exec (basic-invalid-context)
[335.591513] Starting subtest: basic-invalid-context
[335.595992] Subtest basic-invalid-context: SUCCESS (0.005s)
[335.748302] [057/131] (683s left) gem_ctx_param (invalid-size-get)
[335.805427] Starting subtest: invalid-size-get
[335.807589] Subtest invalid-size-get: SUCCESS (0.001s)
[335.938169] [058/131] (683s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[336.037903] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[336.039871] Starting dynamic subtest: pipe-A-eDP-1
[336.058080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.072319] Starting dynamic subtest: pipe-B-eDP-1
[336.090064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.099772] Starting dynamic subtest: pipe-C-eDP-1
[336.116754] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.125208] Starting dynamic subtest: pipe-D-eDP-1
[336.143479] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.147063] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[338.351447] [059/131] (681s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[338.407401] Starting subtest: invalid-multi-wait-all-unsubmitted
[338.409803] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[338.545264] [060/131] (681s left) gem_sync (basic-all)
[338.616135] Starting subtest: basic-all
[342.020965] Subtest basic-all: SUCCESS (3.413s)
[342.233940] [061/131] (677s left) kms_cursor_crc (cursor-sliding-256x256)
[342.493649] Starting subtest: cursor-sliding-256x256
[342.498475] Starting dynamic subtest: pipe-A-eDP-1
[345.744651] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.246s)
[345.772924] Starting dynamic subtest: pipe-D-eDP-1
[349.591075] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.825s)
[349.593320] Subtest cursor-sliding-256x256: SUCCESS (7.096s)
[350.463924] [062/131] (669s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[350.590358] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[350.594760] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[350.757379] [063/131] (669s left) gem_render_copy_redux (normal)
[350.819053] Starting subtest: normal
[351.130129] Subtest normal: SUCCESS (0.309s)
[351.280489] [064/131] (668s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[351.416182] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[351.419959] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[351.533160] [065/131] (668s left) kms_busy (extended-pageflip-hang-oldfb)
[351.636505] Starting subtest: extended-pageflip-hang-oldfb
[351.640499] Starting dynamic subtest: pipe-A
[352.050757] Dynamic subtest pipe-A: SUCCESS (0.410s)
[352.060748] Starting dynamic subtest: pipe-D
[353.129338] Dynamic subtest pipe-D: SUCCESS (1.075s)
[353.131623] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.491s)
[353.961144] [066/131] (665s left) kms_pm_rpm (system-suspend-idle)
[356.102390] Starting subtest: system-suspend-idle
[375.870226] Subtest system-suspend-idle: SUCCESS (4.297s)
[376.263646] [067/131] (643s left) gem_huc_copy (huc-copy)
[376.328650] Starting subtest: huc-copy
[376.333435] Subtest huc-copy: SUCCESS (0.004s)
[376.488104] [068/131] (643s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[381.490945] Starting subtest: psr2-plane-move-sf-dmg-area
[381.493526] Starting dynamic subtest: pipe-A-eDP-1
[386.686862] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.194s)
[386.696046] Starting dynamic subtest: pipe-B-eDP-1
[391.884540] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.196s)
[391.886965] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.394s)
[392.759449] [069/131] (627s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[392.869421] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[392.881733] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[393.011987] [070/131] (627s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[393.105362] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[393.230742] [071/131] (626s left) gem_eio (reset-stress)
[393.480283] Starting subtest: reset-stress
[393.482658] Starting dynamic subtest: render
[398.879483] Dynamic subtest render: SUCCESS (5.396s)
[398.897030] Starting dynamic subtest: bsd1
[417.280194] Dynamic subtest bsd1: SUCCESS (18.398s)
[417.290834] Starting dynamic subtest: bsd2
[435.003897] Dynamic subtest bsd2: SUCCESS (17.722s)
[435.019524] Starting dynamic subtest: blt
[435.023729] Dynamic subtest blt: SKIP (0.000s)
[435.032480] Starting dynamic subtest: vebox
[453.072307] Dynamic subtest vebox: SUCCESS (18.064s)
[453.074538] Subtest reset-stress: SUCCESS (59.585s)
[454.518345] [072/131] (565s left) vgem_basic (dmabuf-fence-before)
[454.564955] Starting subtest: dmabuf-fence-before
[454.567175] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[454.648783] [073/131] (565s left) gem_softpin (reverse)
[454.704117] Starting subtest: reverse
[454.709352] Subtest reverse: SUCCESS (0.005s)
[454.870557] [074/131] (565s left) kms_plane_multiple (2x-tiling-4)
[454.967535] Starting subtest: 2x-tiling-4
[454.971599] Subtest 2x-tiling-4: SKIP (0.000s)
[455.067718] [075/131] (565s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[455.127600] Subtest writes-after-reads-uncached: SKIP (0.000s)
[455.207648] [076/131] (565s left) api_intel_bb (object-noreloc-keep-cache-simple)
[455.261029] Starting subtest: object-noreloc-keep-cache-simple
[455.263486] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[455.428300] [077/131] (564s left) kms_selftest (drm_format_helper)
[455.466543] Starting subtest: drm_format_helper
[455.473309] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[455.615099] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.140s)
[455.623912] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[455.774556] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.158s)
[455.784691] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[455.919917] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.145s)
[455.930175] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[456.065326] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.145s)
[456.074728] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[456.209485] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.143s)
[456.220284] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[456.341403] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.131s)
[456.351259] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[456.467542] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.125s)
[456.477840] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[456.601356] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.133s)
[456.610208] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[456.751530] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.150s)
[456.760508] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[456.914315] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.162s)
[456.922706] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[457.011301] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.097s)
[457.020849] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[457.142260] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.129s)
[457.150888] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[457.239537] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.098s)
[457.248703] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[457.397662] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.156s)
[457.407486] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[457.547298] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.150s)
[457.557750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[457.679449] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.130s)
[457.688900] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[457.825109] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.146s)
[457.827512] Subtest drm_format_helper: SUCCESS (2.359s)
[458.047013] [078/131] (562s left) kms_vblank (wait-idle)
[458.145380] Starting subtest: wait-idle
[458.147678] Starting dynamic subtest: pipe-A-eDP-1
[459.910006] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.763s)
[459.924177] Starting dynamic subtest: pipe-D-eDP-1
[462.323350] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.410s)
[462.325289] Subtest wait-idle: SUCCESS (4.177s)
[463.153193] [079/131] (557s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[463.252206] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[463.254438] Starting dynamic subtest: pipe-A-eDP-1
[463.274845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[463.286007] Starting dynamic subtest: pipe-B-eDP-1
[463.304975] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[463.313722] Starting dynamic subtest: pipe-C-eDP-1
[463.332089] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[463.340333] Starting dynamic subtest: pipe-D-eDP-1
[463.359830] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[463.361741] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[465.549006] [080/131] (554s left) gem_exec_whisper (basic-normal)
[465.618661] Starting subtest: basic-normal
[470.602035] Subtest basic-normal: SUCCESS (4.982s)
[470.810173] [081/131] (549s left) gem_spin_batch (user-each)
[470.869525] Starting subtest: user-each
[474.236293] Subtest user-each: SUCCESS (3.367s)
[474.553215] [082/131] (545s left) gem_ctx_shared (exec-shared-gtt)
[474.614537] Starting subtest: exec-shared-gtt
[474.616764] Starting dynamic subtest: rcs0
[474.629208] Dynamic subtest rcs0: SUCCESS (0.014s)
[474.644646] Starting dynamic subtest: bcs0
[474.647100] Dynamic subtest bcs0: SUCCESS (0.014s)
[474.662159] Starting dynamic subtest: vcs0
[474.664355] Dynamic subtest vcs0: SUCCESS (0.012s)
[474.673535] Starting dynamic subtest: vcs1
[474.675437] Dynamic subtest vcs1: SUCCESS (0.008s)
[474.684869] Starting dynamic subtest: vecs0
[474.687028] Dynamic subtest vecs0: SUCCESS (0.012s)
[474.696507] Starting dynamic subtest: ccs0
[474.698308] Dynamic subtest ccs0: SUCCESS (0.012s)
[474.700127] Subtest exec-shared-gtt: SUCCESS (0.079s)
[474.906395] [083/131] (545s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[475.039663] Starting subtest: basic-flip-after-cursor-legacy
[475.955408] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.913s)
[476.840578] [084/131] (543s left) i915_hangman (detector)
[476.912132] Starting subtest: detector
[476.914065] Starting dynamic subtest: rcs0
[488.467294] Dynamic subtest rcs0: SUCCESS (11.555s)
[488.478565] Starting dynamic subtest: bcs0
[500.435912] Dynamic subtest bcs0: SUCCESS (11.966s)
[500.452432] Starting dynamic subtest: vcs0
[512.402892] Dynamic subtest vcs0: SUCCESS (11.963s)
[512.414357] Starting dynamic subtest: vcs1
[524.371921] Dynamic subtest vcs1: SUCCESS (11.965s)
[524.384455] Starting dynamic subtest: vecs0
[534.420713] Dynamic subtest vecs0: SUCCESS (10.045s)
[534.432504] Starting dynamic subtest: ccs0
[546.450499] Dynamic subtest ccs0: SUCCESS (12.026s)
[546.453089] Subtest detector: SUCCESS (69.536s)
[546.565953] [085/131] (474s left) kms_atomic_transition (plane-all-transition-nonblocking)
[546.693527] Starting subtest: plane-all-transition-nonblocking
[546.695799] Starting dynamic subtest: pipe-A-eDP-1
[549.186814] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[549.491960] Starting dynamic subtest: pipe-B-eDP-1
[552.714796] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.232s)
[553.018567] Subtest plane-all-transition-nonblocking: SUCCESS (6.325s)
[553.848994] [086/131] (466s left) gem_exec_schedule (semaphore-codependency)
[553.942204] Starting subtest: semaphore-codependency
[553.947701] Subtest semaphore-codependency: SUCCESS (0.013s)
[554.327198] [087/131] (466s left) gem_exec_params (sol-reset-not-gen7)
[554.391965] Starting subtest: sol-reset-not-gen7
[554.394239] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[554.533173] [088/131] (466s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[554.633729] Starting subtest: bo-too-small-due-to-tiling
[554.637728] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[554.770460] [089/131] (466s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[554.824593] Starting subtest: multi-wait-all-for-submit-signaled
[554.826707] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[554.960010] [090/131] (465s left) kms_color (invalid-gamma-lut-sizes)
[555.057297] Starting subtest: invalid-gamma-lut-sizes
[555.059412] Starting dynamic subtest: pipe-A
[555.349500] Dynamic subtest pipe-A: SUCCESS (0.290s)
[555.359316] Starting dynamic subtest: pipe-B
[555.361621] Dynamic subtest pipe-B: SUCCESS (0.001s)
[555.371117] Starting dynamic subtest: pipe-C
[555.373399] Dynamic subtest pipe-C: SUCCESS (0.001s)
[555.382639] Starting dynamic subtest: pipe-D
[555.384784] Dynamic subtest pipe-D: SUCCESS (0.001s)
[555.386990] Subtest invalid-gamma-lut-sizes: SUCCESS (0.295s)
[556.246601] [091/131] (464s left) kms_plane_alpha_blend (alpha-opaque-fb)
[556.342395] Starting subtest: alpha-opaque-fb
[556.639265] Starting dynamic subtest: pipe-A-eDP-1
[557.349354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[557.358766] Starting dynamic subtest: pipe-D-eDP-1
[558.706065] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s)
[558.708530] Subtest alpha-opaque-fb: SUCCESS (2.365s)
[559.547251] [092/131] (461s left) kms_psr (pr-sprite-blt)
[559.655275] Starting subtest: pr-sprite-blt
[559.659542] Subtest pr-sprite-blt: SKIP (0.000s)
[559.752242] [093/131] (461s left) kms_chamelium_color (ctm-red-to-blue)
[559.855377] Subtest ctm-red-to-blue: SKIP (0.000s)
[559.901622] [094/131] (461s left) gem_mmap_gtt (big-copy)
[559.964763] Subtest big-copy: SKIP (0.000s)
[560.039589] [095/131] (461s left) gem_mmap_gtt (hang-busy)
[560.101033] Subtest hang-busy: SKIP (0.000s)
[560.157966] [096/131] (460s left) i915_suspend (basic-s3-without-i915)
[560.193942] Starting subtest: basic-s3-without-i915
[563.696765] Subtest basic-s3-without-i915: SKIP (3.497s)
[565.394132] [097/131] (455s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[565.508854] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[565.624141] [098/131] (455s left) syncobj_wait (invalid-signal-illegal-handle)
[565.690269] Starting subtest: invalid-signal-illegal-handle
[565.692623] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[565.821656] [099/131] (455s left) kms_psr (fbc-psr2-cursor-blt)
[565.919545] Starting subtest: fbc-psr2-cursor-blt
[565.921801] Starting dynamic subtest: eDP-1
[565.926526] Dynamic subtest eDP-1: SKIP (0.000s)
[565.930602] Subtest fbc-psr2-cursor-blt: SKIP (0.002s)
[566.021435] [100/131] (455s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[566.118281] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[567.098554] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.981s)
[567.258274] [101/131] (454s left) gem_exec_schedule (pi-ringfull)
[567.455515] Starting subtest: pi-ringfull
[567.457939] Starting dynamic subtest: rcs0
[567.479139] Dynamic subtest rcs0: SUCCESS (0.027s)
[567.491137] Starting dynamic subtest: bcs0
[567.507223] Dynamic subtest bcs0: SUCCESS (0.027s)
[567.519539] Starting dynamic subtest: vcs0
[567.536623] Dynamic subtest vcs0: SUCCESS (0.029s)
[567.549356] Starting dynamic subtest: vcs1
[567.562761] Dynamic subtest vcs1: SUCCESS (0.025s)
[567.576091] Starting dynamic subtest: vecs0
[567.589337] Dynamic subtest vecs0: SUCCESS (0.026s)
[567.602488] Starting dynamic subtest: ccs0
[567.617008] Dynamic subtest ccs0: SUCCESS (0.027s)
[567.619199] Subtest pi-ringfull: SUCCESS (0.166s)
[567.875968] [102/131] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[567.990935] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[574.880677] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.891s)
[575.031330] [103/131] (446s left) kms_addfb_basic (clobberred-modifier)
[575.107851] Starting subtest: clobberred-modifier
[575.112379] Subtest clobberred-modifier: SKIP (0.000s)
[575.266109] [104/131] (446s left) gem_exec_params (batch-first)
[575.343642] Starting subtest: batch-first
[575.349750] Subtest batch-first: SUCCESS (0.006s)
[575.517817] [105/131] (445s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[575.576153] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[575.639234] [106/131] (445s left) drm_read (empty-nonblock)
[575.797430] Starting subtest: empty-nonblock
[575.799331] Subtest empty-nonblock: SUCCESS (0.000s)
[575.938415] [107/131] (445s left) kms_content_protection (uevent)
[576.082121] Starting subtest: uevent
[576.086026] Subtest uevent: SKIP (0.000s)
[576.243351] [108/131] (445s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[576.348808] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[576.350796] Starting dynamic subtest: pipe-A
[577.406384] Dynamic subtest pipe-A: SUCCESS (1.060s)
[577.414865] Starting dynamic subtest: pipe-B
[579.550406] Dynamic subtest pipe-B: SUCCESS (2.143s)
[579.561032] Starting dynamic subtest: pipe-C
[580.751051] Dynamic subtest pipe-C: SUCCESS (1.199s)
[580.760162] Starting dynamic subtest: pipe-D
[581.978442] Dynamic subtest pipe-D: SUCCESS (1.226s)
[581.980898] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.632s)
[583.202909] [109/131] (438s left) gem_mmap_gtt (basic-write-gtt)
[583.271574] Subtest basic-write-gtt: SKIP (0.000s)
[583.331535] [110/131] (438s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[583.424762] Starting subtest: psr-farfromfence-mmap-gtt
[583.429021] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[583.554812] [111/131] (438s left) kms_dp_link_training (non-uhbr-mst)
[583.660518] Starting subtest: non-uhbr-mst
[583.668817] Subtest non-uhbr-mst: SKIP (0.000s)
[583.755333] [112/131] (438s left) gem_basic (bad-close)
[583.817718] Starting subtest: bad-close
[583.822062] Subtest bad-close: SUCCESS (0.000s)
[583.944181] [113/131] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[584.036547] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[584.040715] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[584.153649] [114/131] (437s left) kms_psr (fbc-psr-primary-blt)
[584.259746] Starting subtest: fbc-psr-primary-blt
[584.261670] Starting dynamic subtest: eDP-1
[584.265260] Dynamic subtest eDP-1: SKIP (0.000s)
[584.268907] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[584.362362] [115/131] (437s left) sysfs_timeslice_duration (duration)
[584.420048] Starting subtest: duration
[584.421951] Starting dynamic subtest: vecs0
[599.381243] Dynamic subtest vecs0: SUCCESS (14.956s)
[599.392531] Starting dynamic subtest: ccs0
[612.547785] Dynamic subtest ccs0: SUCCESS (13.165s)
[612.561738] Starting dynamic subtest: vcs0
[626.388972] Dynamic subtest vcs0: SUCCESS (13.837s)
[626.400410] Starting dynamic subtest: bcs0
[639.548980] Dynamic subtest bcs0: SUCCESS (13.158s)
[639.560218] Starting dynamic subtest: rcs0
[652.706784] Dynamic subtest rcs0: SUCCESS (13.155s)
[652.718411] Starting dynamic subtest: vcs1
[666.386922] Dynamic subtest vcs1: SUCCESS (13.676s)
[666.389628] Subtest duration: SUCCESS (81.963s)
[666.491997] [116/131] (355s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[666.606231] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[666.610231] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[666.719496] [117/131] (355s left) kms_draw_crc (fill-fb)
[666.818506] Starting subtest: fill-fb
[667.317515] Subtest fill-fb: SUCCESS (0.500s)
[667.434952] [118/131] (354s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[667.535020] Starting subtest: y-tiled-16bpp-rotate-90
[667.538589] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[667.662894] [119/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[667.762663] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[667.766032] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[667.866798] [120/131] (354s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[667.961244] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[674.675923] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.715s)
[674.806763] [121/131] (347s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[674.897160] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[674.899409] Starting dynamic subtest: pipe-A-default-mode
[677.625832] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[677.628207] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.729s)
[678.487573] [122/131] (343s left) gem_pxp (reject-modify-context-protection-on)
[678.627733] Starting subtest: reject-modify-context-protection-on
[678.630170] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[678.777131] [123/131] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[678.894829] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[678.898828] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[679.034966] [124/131] (343s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[679.143279] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[679.147315] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[679.274879] [125/131] (343s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[684.258899] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[684.266504] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[685.127626] [126/131] (337s left) kms_hdr (static-toggle-suspend)
[685.232750] Starting subtest: static-toggle-suspend
[685.239073] Subtest static-toggle-suspend: SKIP (0.000s)
[685.329850] [127/131] (337s left) dmabuf_sync_file (export-wait-after-attach)
[685.383291] Starting subtest: export-wait-after-attach
[685.385596] Subtest export-wait-after-attach: SUCCESS (0.001s)
[685.462066] [128/131] (336s left) kms_cursor_legacy (single-move)
[685.594122] Starting subtest: single-move
[685.596244] Starting dynamic subtest: pipe-A
[690.974498] Dynamic subtest pipe-A: SUCCESS (5.378s)
[690.985809] Starting dynamic subtest: pipe-B
[696.357830] Dynamic subtest pipe-B: SUCCESS (5.380s)
[696.368323] Starting dynamic subtest: pipe-C
[701.740097] Dynamic subtest pipe-C: SUCCESS (5.379s)
[701.750563] Starting dynamic subtest: pipe-D
[707.122053] Dynamic subtest pipe-D: SUCCESS (5.379s)
[707.132988] Starting dynamic subtest: all-pipes
[712.510911] Dynamic subtest all-pipes: SUCCESS (5.386s)
[712.513213] Subtest single-move: SUCCESS (26.914s)
[712.681682] [129/131] (309s left) gem_exec_fence (basic-wait)
[712.860877] Starting subtest: basic-wait
[712.863383] Starting dynamic subtest: rcs0
[712.945149] Dynamic subtest rcs0: SUCCESS (0.085s)
[712.956051] Starting dynamic subtest: bcs0
[713.004677] Dynamic subtest bcs0: SUCCESS (0.057s)
[713.015489] Starting dynamic subtest: vcs0
[713.068671] Dynamic subtest vcs0: SUCCESS (0.061s)
[713.079215] Starting dynamic subtest: vcs1
[713.129152] Dynamic subtest vcs1: SUCCESS (0.059s)
[713.139776] Starting dynamic subtest: vecs0
[713.196393] Dynamic subtest vecs0: SUCCESS (0.065s)
[713.206143] Starting dynamic subtest: ccs0
[713.258613] Dynamic subtest ccs0: SUCCESS (0.060s)
[713.261111] Subtest basic-wait: SUCCESS (0.401s)
[715.580962] [130/131] (306s left) gem_exec_balancer (full-late)
[715.651074] Starting subtest: full-late
[720.330284] Subtest full-late: SUCCESS (4.678s)
[720.694085] [131/131] (301s left) gem_exec_params (readonly)
[720.751536] Starting subtest: readonly
[720.756279] Subtest readonly: SUCCESS (0.003s)
[720.915586] 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.