[58.189608] Initializing watchdogs
[58.189653]   /dev/watchdog0
[58.202742] [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]
[58.207282] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.209727] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.213154] [001/131] (960s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[58.364732] Starting subtest: cursor-vs-flip-atomic-transitions
[88.357216] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.012s)
[89.248177] [002/131] (929s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[89.310899] Starting subtest: single-wait-for-submit-available-signaled
[89.313187] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[89.432781] [003/131] (929s left) i915_drm_fdinfo (memory-info-shared)
[89.478559] Starting subtest: memory-info-shared
[89.480883] Starting dynamic subtest: smem0
[89.545790] Dynamic subtest smem0: SUCCESS (0.067s)
[89.549021] Subtest memory-info-shared: SUCCESS (0.067s)
[89.639825] [004/131] (929s left) kms_atomic_interruptible (legacy-dpms)
[89.730231] Starting subtest: legacy-dpms
[89.732309] Starting dynamic subtest: pipe-A-eDP-1
[97.168100] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.438s)
[97.170315] Subtest legacy-dpms: SUCCESS (7.439s)
[98.020295] [005/131] (920s left) kms_getfb (getfb-handle-closed)
[98.109661] Starting subtest: getfb-handle-closed
[98.112037] Subtest getfb-handle-closed: SUCCESS (0.000s)
[98.221764] [006/131] (920s left) gem_ccs (suspend-resume)
[98.296712] Starting subtest: suspend-resume
[98.300873] Subtest suspend-resume: SKIP (0.000s)
[98.419935] [007/131] (920s left) gem_exec_fence (syncobj-signal)
[98.863075] Starting subtest: syncobj-signal
[98.869762] Subtest syncobj-signal: SUCCESS (0.006s)
[99.983216] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[99.986303] [008/131] (918s left) kms_flip (basic-plain-flip)
[100.085191] Starting subtest: basic-plain-flip
[100.087443] Starting dynamic subtest: A-eDP1
[101.800053] Dynamic subtest A-eDP1: SUCCESS (1.717s)
[101.809371] Starting dynamic subtest: B-eDP1
[103.451204] Dynamic subtest B-eDP1: SUCCESS (1.651s)
[103.460858] Starting dynamic subtest: C-eDP1
[105.165808] Dynamic subtest C-eDP1: SUCCESS (1.713s)
[105.178087] Starting dynamic subtest: D-eDP1
[106.803468] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[106.807905] Subtest basic-plain-flip: SUCCESS (6.726s)
[108.006303] [009/131] (911s left) kms_rotation_crc (sprite-rotation-270)
[108.109675] Starting subtest: sprite-rotation-270
[108.114198] Subtest sprite-rotation-270: SKIP (0.001s)
[108.203384] [010/131] (910s left) kms_psr (psr2-sprite-render)
[108.294108] Starting subtest: psr2-sprite-render
[108.296428] Starting dynamic subtest: eDP-1
[109.983928] Dynamic subtest eDP-1: SUCCESS (1.691s)
[109.986435] Subtest psr2-sprite-render: SUCCESS (1.691s)
[110.888560] [011/131] (908s left) gen9_exec_parse (batch-without-end)
[110.960714] Subtest batch-without-end: SKIP (0.000s)
[111.044096] [012/131] (908s left) i915_pm_rc6_residency (rc6-idle)
[111.106865] Starting subtest: rc6-idle
[111.136241] Starting dynamic subtest: gt0-rcs0
[135.494562] Dynamic subtest gt0-rcs0: SUCCESS (24.357s)
[135.503104] Starting dynamic subtest: gt0-bcs0
[159.886904] Dynamic subtest gt0-bcs0: SUCCESS (24.391s)
[159.896529] Starting dynamic subtest: gt0-ccs0
[184.161105] Dynamic subtest gt0-ccs0: SUCCESS (24.273s)
[184.170519] Starting dynamic subtest: gt1-vcs0
[190.335389] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[190.345720] Starting dynamic subtest: gt1-vecs0
[196.506370] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[196.509148] Subtest rc6-idle: SUCCESS (85.399s)
[196.609559] [013/131] (822s left) kms_pm_dc (dc5-psr)
[197.725724] Starting subtest: dc5-psr
[200.632070] Subtest dc5-psr: SUCCESS (2.906s)
[201.517204] [014/131] (817s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[206.578984] Starting subtest: psr2-cursor-plane-move-continuous-sf
[206.581373] Starting dynamic subtest: pipe-A-eDP-1
[217.669062] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.087s)
[217.680675] Starting dynamic subtest: pipe-B-eDP-1
[228.701245] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.030s)
[228.703136] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.121s)
[229.520239] [015/131] (789s left) gem_tiled_pread_basic
[229.661231] [016/131] (789s left) kms_atomic (test-only)
[229.762790] Starting subtest: test-only
[229.811852] Starting dynamic subtest: pipe-A-eDP-1
[232.333165] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[232.335451] Subtest test-only: SUCCESS (2.571s)
[233.219246] [017/131] (786s left) gem_eio (in-flight-internal-10ms)
[233.452055] Starting subtest: in-flight-internal-10ms
[234.970572] Subtest in-flight-internal-10ms: SUCCESS (1.518s)
[235.104267] [018/131] (784s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[235.199101] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[235.201317] Starting dynamic subtest: pipe-A-eDP-1
[235.223235] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.231174] Starting dynamic subtest: pipe-B-eDP-1
[235.252227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.259282] Starting dynamic subtest: pipe-C-eDP-1
[235.280663] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.288367] Starting dynamic subtest: pipe-D-eDP-1
[235.310209] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.314593] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[237.478061] [019/131] (781s left) gem_exec_params (sol-reset-invalid)
[237.537798] Starting subtest: sol-reset-invalid
[237.540162] Subtest sol-reset-invalid: SUCCESS (0.002s)
[239.012679] [020/131] (780s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[239.119637] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[239.123662] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[239.252481] [021/131] (780s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[239.312749] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[239.373549] [022/131] (780s left) prime_mmap_kms (buffer-sharing)
[239.461076] Starting subtest: buffer-sharing
[239.907289] Subtest buffer-sharing: SUCCESS (0.446s)
[240.803056] [023/131] (778s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[240.860862] Starting subtest: multi-wait-available-submitted-signaled
[240.863149] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[240.976563] [024/131] (778s left) kms_plane (plane-panning-bottom-right-suspend)
[241.074104] Starting subtest: plane-panning-bottom-right-suspend
[241.076453] Starting dynamic subtest: pipe-A
[259.331110] Dynamic subtest pipe-A: SUCCESS (6.520s)
[259.340175] Starting dynamic subtest: pipe-B
[277.324376] Dynamic subtest pipe-B: SUCCESS (3.414s)
[277.326312] Subtest plane-panning-bottom-right-suspend: SUCCESS (9.936s)
[278.146641] [025/131] (741s left) kms_big_fb (x-tiled-addfb-size-overflow)
[278.248618] Starting subtest: x-tiled-addfb-size-overflow
[278.250841] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[278.386170] [026/131] (741s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[278.498286] Starting subtest: yf-tiled-64bpp-rotate-0
[278.502650] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[278.616229] [027/131] (741s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[278.760780] Starting subtest: cursor-rapid-movement-32x32
[278.805494] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[279.094801] [028/131] (740s left) prime_vgem (fence-read-hang)
[279.169938] Subtest fence-read-hang: SKIP (0.000s)
[279.290309] [029/131] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[279.384943] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[286.991170] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.635s)
[287.171139] [030/131] (732s left) perf_pmu (idle-no-semaphores)
[287.209635] Starting subtest: idle-no-semaphores
[287.211886] Starting dynamic subtest: rcs0
[287.785805] Dynamic subtest rcs0: SUCCESS (0.576s)
[287.795677] Starting dynamic subtest: bcs0
[288.310579] Dynamic subtest bcs0: SUCCESS (0.523s)
[288.321819] Starting dynamic subtest: vcs0
[288.841005] Dynamic subtest vcs0: SUCCESS (0.529s)
[288.853171] Starting dynamic subtest: vcs1
[289.371207] Dynamic subtest vcs1: SUCCESS (0.529s)
[289.382790] Starting dynamic subtest: vecs0
[289.900033] Dynamic subtest vecs0: SUCCESS (0.528s)
[289.911277] Starting dynamic subtest: ccs0
[290.431229] Dynamic subtest ccs0: SUCCESS (0.530s)
[290.433901] Subtest idle-no-semaphores: SUCCESS (3.229s)
[290.577095] [031/131] (729s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[290.959554] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[291.727193] [032/131] (728s left) kms_chamelium_edid (dp-edid-read)
[292.117063] Subtest dp-edid-read: SKIP (0.000s)
[292.949098] [033/131] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[293.050482] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[293.054553] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[293.195423] [034/131] (726s left) prime_vgem (fence-wait)
[293.277242] Starting subtest: fence-wait
[293.279516] Starting dynamic subtest: rcs0
[294.328770] Dynamic subtest rcs0: SUCCESS (1.052s)
[294.338635] Starting dynamic subtest: bcs0
[295.407711] Dynamic subtest bcs0: SUCCESS (1.079s)
[295.418659] Starting dynamic subtest: vcs0
[296.456914] Dynamic subtest vcs0: SUCCESS (1.050s)
[296.466392] Starting dynamic subtest: vcs1
[298.198954] Dynamic subtest vcs1: SUCCESS (1.742s)
[298.210348] Starting dynamic subtest: vecs0
[299.239548] Dynamic subtest vecs0: SUCCESS (1.040s)
[299.250288] Starting dynamic subtest: ccs0
[300.284268] Dynamic subtest ccs0: SUCCESS (1.044s)
[300.287480] Subtest fence-wait: SUCCESS (7.014s)
[300.450911] [035/131] (719s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[300.521561] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[300.628461] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[300.732181] [036/131] (719s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[300.799972] Starting subtest: yf-tiled-to-vebox-yf-tiled
[300.804063] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[301.019327] [037/131] (719s left) kms_addfb_basic (too-wide)
[301.124838] Starting subtest: too-wide
[301.127042] Subtest too-wide: SUCCESS (0.000s)
[301.238365] [038/131] (718s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[301.333530] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[301.934494] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[302.153135] [039/131] (718s left) kms_joiner (invalid-modeset-ultra-joiner)
[302.258965] Starting subtest: invalid-modeset-ultra-joiner
[302.263321] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[302.345599] [040/131] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[302.439249] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[302.443197] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[302.562713] [041/131] (717s left) gem_exec_reloc (basic-write-wc-active)
[302.629435] Subtest basic-write-wc-active: SKIP (0.000s)
[302.711168] [042/131] (717s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[302.795193] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[302.797417] Starting dynamic subtest: pipe-A-eDP-1
[303.621832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[303.630800] Starting dynamic subtest: pipe-B-eDP-1
[305.169254] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[305.178001] Starting dynamic subtest: pipe-C-eDP-1
[306.733292] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.563s)
[306.743140] Starting dynamic subtest: pipe-D-eDP-1
[308.219783] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[308.222132] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.420s)
[309.416284] [043/131] (710s left) kms_frontbuffer_tracking (psr-1p-rte)
[309.524234] Starting subtest: psr-1p-rte
[314.873873] Subtest psr-1p-rte: SUCCESS (5.357s)
[315.019253] [044/131] (705s left) gem_ccs (block-copy-uncompressed)
[315.082759] Starting subtest: block-copy-uncompressed
[315.085219] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[315.104648] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[315.115607] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[315.121689] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[315.130241] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[315.138634] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[315.150223] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[315.155162] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[315.157523] Subtest block-copy-uncompressed: SUCCESS (0.073s)
[315.312712] [045/131] (705s left) kms_psr (psr-sprite-plane-onoff)
[315.403716] Starting subtest: psr-sprite-plane-onoff
[315.406033] Starting dynamic subtest: eDP-1
[317.139438] Dynamic subtest eDP-1: SUCCESS (1.735s)
[317.141659] Subtest psr-sprite-plane-onoff: SUCCESS (1.736s)
[317.983870] [046/131] (702s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[318.043243] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[318.147771] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[318.250792] [047/131] (702s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[318.383682] Starting subtest: cursorB-vs-flipB-varying-size
[318.388316] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[318.547906] [048/131] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[318.659686] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[318.663794] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[318.792800] [049/131] (701s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[318.903778] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[318.906245] Starting dynamic subtest: pipe-A-default-mode
[319.195706] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[319.200265] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.291s)
[320.008803] [050/131] (700s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[320.118173] Starting subtest: psr-rgb101010-draw-mmap-wc
[327.123247] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.011s)
[327.272880] [051/131] (693s left) gem_mmap_wc (bad-size)
[327.323567] Subtest bad-size: SKIP (0.000s)
[327.385859] [052/131] (693s left) gem_ctx_persistence (legacy-engines-cleanup)
[327.438402] Starting subtest: legacy-engines-cleanup
[327.440709] Starting dynamic subtest: render
[327.550705] Dynamic subtest render: SUCCESS (0.112s)
[327.562558] Starting dynamic subtest: bsd1
[327.602548] Dynamic subtest bsd1: SUCCESS (0.049s)
[327.613338] Starting dynamic subtest: bsd2
[327.651534] Dynamic subtest bsd2: SUCCESS (0.046s)
[327.665046] Starting dynamic subtest: blt
[327.717207] Dynamic subtest blt: SUCCESS (0.062s)
[327.728293] Starting dynamic subtest: vebox
[327.770737] Dynamic subtest vebox: SUCCESS (0.051s)
[327.773329] Subtest legacy-engines-cleanup: SUCCESS (0.334s)
[327.874220] [053/131] (692s left) perf_pmu (busy-no-semaphores)
[327.916719] Starting subtest: busy-no-semaphores
[327.918980] Starting dynamic subtest: rcs0
[328.497843] Dynamic subtest rcs0: SUCCESS (0.581s)
[328.510797] Starting dynamic subtest: bcs0
[329.046830] Dynamic subtest bcs0: SUCCESS (0.547s)
[329.058900] Starting dynamic subtest: vcs0
[329.596255] Dynamic subtest vcs0: SUCCESS (0.547s)
[329.606913] Starting dynamic subtest: vcs1
[330.723358] Dynamic subtest vcs1: SUCCESS (1.124s)
[330.735362] Starting dynamic subtest: vecs0
[332.706364] Dynamic subtest vecs0: SUCCESS (1.981s)
[332.718095] Starting dynamic subtest: ccs0
[334.755172] Dynamic subtest ccs0: SUCCESS (2.047s)
[334.758079] Subtest busy-no-semaphores: SUCCESS (6.844s)
[334.896846] [054/131] (685s left) kms_force_connector_basic (prune-stale-modes)
[334.993023] Starting subtest: prune-stale-modes
[335.464333] Subtest prune-stale-modes: SUCCESS (0.474s)
[335.636313] [055/131] (685s left) gem_set_tiling_vs_gtt
[335.779959] [056/131] (685s left) gem_ctx_exec (basic-invalid-context)
[335.844952] Starting subtest: basic-invalid-context
[335.849297] Subtest basic-invalid-context: SUCCESS (0.005s)
[336.023884] [057/131] (684s left) gem_ctx_param (invalid-size-get)
[336.080355] Starting subtest: invalid-size-get
[336.082518] Subtest invalid-size-get: SUCCESS (0.001s)
[336.212126] [058/131] (684s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[336.306903] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[336.308710] Starting dynamic subtest: pipe-A-eDP-1
[336.326824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.335015] Starting dynamic subtest: pipe-B-eDP-1
[336.353258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.360937] Starting dynamic subtest: pipe-C-eDP-1
[336.378687] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.386339] Starting dynamic subtest: pipe-D-eDP-1
[336.404033] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.407478] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[338.575392] [059/131] (682s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[338.633408] Starting subtest: invalid-multi-wait-all-unsubmitted
[338.635672] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[338.770680] [060/131] (682s left) gem_sync (basic-all)
[338.852516] Starting subtest: basic-all
[342.242030] Subtest basic-all: SUCCESS (3.401s)
[342.455580] [061/131] (678s left) kms_cursor_crc (cursor-sliding-256x256)
[342.686095] Starting subtest: cursor-sliding-256x256
[342.688370] Starting dynamic subtest: pipe-A-eDP-1
[345.924289] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.237s)
[345.953597] Starting dynamic subtest: pipe-D-eDP-1
[349.768101] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.823s)
[349.770275] Subtest cursor-sliding-256x256: SUCCESS (7.085s)
[350.645123] [062/131] (670s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[350.756037] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[350.760397] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[350.923542] [063/131] (670s left) gem_render_copy_redux (normal)
[350.979519] Starting subtest: normal
[351.241668] Subtest normal: SUCCESS (0.261s)
[351.400631] [064/131] (669s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[351.504643] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[351.508703] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[351.621554] [065/131] (669s left) kms_busy (extended-pageflip-hang-oldfb)
[351.711038] Starting subtest: extended-pageflip-hang-oldfb
[351.712901] Starting dynamic subtest: pipe-A
[352.103964] Dynamic subtest pipe-A: SUCCESS (0.392s)
[352.113388] Starting dynamic subtest: pipe-D
[353.201571] Dynamic subtest pipe-D: SUCCESS (1.096s)
[353.203829] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.492s)
[354.042250] [066/131] (667s left) kms_pm_rpm (system-suspend-idle)
[355.554481] Starting subtest: system-suspend-idle
[375.149616] Subtest system-suspend-idle: SUCCESS (4.328s)
[375.546866] [067/131] (645s left) gem_huc_copy (huc-copy)
[375.608122] Starting subtest: huc-copy
[375.613026] Subtest huc-copy: SUCCESS (0.003s)
[375.774528] [068/131] (645s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[380.738140] Starting subtest: psr2-plane-move-sf-dmg-area
[380.740518] Starting dynamic subtest: pipe-A-eDP-1
[385.910121] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.180s)
[385.920896] Starting dynamic subtest: pipe-B-eDP-1
[391.088606] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.183s)
[391.091010] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.367s)
[391.970759] [069/131] (629s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[392.079176] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[392.090907] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[392.190820] [070/131] (629s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[392.281507] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[392.428579] [071/131] (629s left) gem_eio (reset-stress)
[392.664957] Starting subtest: reset-stress
[392.666861] Starting dynamic subtest: render
[397.868232] Dynamic subtest render: SUCCESS (5.205s)
[397.883891] Starting dynamic subtest: bsd1
[415.998836] Dynamic subtest bsd1: SUCCESS (18.130s)
[416.015100] Starting dynamic subtest: bsd2
[434.053675] Dynamic subtest bsd2: SUCCESS (18.054s)
[434.069213] Starting dynamic subtest: blt
[434.073345] Dynamic subtest blt: SKIP (0.000s)
[434.081819] Starting dynamic subtest: vebox
[452.060934] Dynamic subtest vebox: SUCCESS (18.009s)
[452.063638] Subtest reset-stress: SUCCESS (59.403s)
[453.584892] [072/131] (568s left) vgem_basic (dmabuf-fence-before)
[453.632855] Starting subtest: dmabuf-fence-before
[453.635328] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[453.713034] [073/131] (567s left) gem_softpin (reverse)
[453.769592] Starting subtest: reverse
[453.775038] Subtest reverse: SUCCESS (0.004s)
[453.930684] [074/131] (567s left) kms_plane_multiple (2x-tiling-4)
[454.022291] Starting subtest: 2x-tiling-4
[454.026345] Subtest 2x-tiling-4: SKIP (0.000s)
[454.139536] [075/131] (567s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[454.208619] Subtest writes-after-reads-uncached: SKIP (0.000s)
[454.265102] [076/131] (567s left) api_intel_bb (object-noreloc-keep-cache-simple)
[454.316929] Starting subtest: object-noreloc-keep-cache-simple
[454.322742] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[454.481826] [077/131] (567s left) kms_selftest (drm_format_helper)
[454.523567] Starting subtest: drm_format_helper
[454.533745] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[454.686068] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.151s)
[454.694273] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[454.835318] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.149s)
[454.844350] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[454.997447] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.160s)
[455.007081] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[455.149110] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.152s)
[455.159613] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[455.292217] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.141s)
[455.301814] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[455.438611] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.145s)
[455.448091] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[455.577357] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.140s)
[455.587429] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[455.729624] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.149s)
[455.745874] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[455.875576] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.146s)
[455.885608] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[456.034080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.157s)
[456.042269] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[456.187068] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.153s)
[456.195763] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[456.324569] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.137s)
[456.332722] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[456.472406] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.148s)
[456.482620] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[456.630430] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.158s)
[456.638605] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[456.782231] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.150s)
[456.792401] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[456.920552] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.139s)
[456.928712] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[457.086227] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.165s)
[457.088554] Subtest drm_format_helper: SUCCESS (2.565s)
[457.324621] [078/131] (564s left) kms_vblank (wait-idle)
[457.431666] Starting subtest: wait-idle
[457.433922] Starting dynamic subtest: pipe-A-eDP-1
[459.208237] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.776s)
[459.222607] Starting dynamic subtest: pipe-D-eDP-1
[461.626511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s)
[461.628795] Subtest wait-idle: SUCCESS (4.199s)
[462.456490] [079/131] (559s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[462.557139] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[462.559526] Starting dynamic subtest: pipe-A-eDP-1
[462.579899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[462.589908] Starting dynamic subtest: pipe-B-eDP-1
[462.609395] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[462.617520] Starting dynamic subtest: pipe-C-eDP-1
[462.637057] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[462.645204] Starting dynamic subtest: pipe-D-eDP-1
[462.664327] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[462.666204] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[464.851672] [080/131] (557s left) gem_exec_whisper (basic-normal)
[464.917382] Starting subtest: basic-normal
[470.190331] Subtest basic-normal: SUCCESS (5.272s)
[470.400111] [081/131] (551s left) gem_spin_batch (user-each)
[470.463720] Starting subtest: user-each
[473.837914] Subtest user-each: SUCCESS (3.371s)
[474.583339] [082/131] (547s left) gem_ctx_shared (exec-shared-gtt)
[474.645521] Starting subtest: exec-shared-gtt
[474.647896] Starting dynamic subtest: rcs0
[474.656419] Dynamic subtest rcs0: SUCCESS (0.010s)
[474.667703] Starting dynamic subtest: bcs0
[474.670007] Dynamic subtest bcs0: SUCCESS (0.009s)
[474.679801] Starting dynamic subtest: vcs0
[474.681763] Dynamic subtest vcs0: SUCCESS (0.009s)
[474.691441] Starting dynamic subtest: vcs1
[474.693759] Dynamic subtest vcs1: SUCCESS (0.011s)
[474.702679] Starting dynamic subtest: vecs0
[474.704573] Dynamic subtest vecs0: SUCCESS (0.009s)
[474.713820] Starting dynamic subtest: ccs0
[474.716181] Dynamic subtest ccs0: SUCCESS (0.013s)
[474.718239] Subtest exec-shared-gtt: SUCCESS (0.067s)
[474.932772] [083/131] (547s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[475.051506] Starting subtest: basic-flip-after-cursor-legacy
[475.971832] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.918s)
[476.855294] [084/131] (545s left) i915_hangman (detector)
[476.923641] Starting subtest: detector
[476.925580] Starting dynamic subtest: rcs0
[488.494975] Dynamic subtest rcs0: SUCCESS (11.568s)
[488.506358] Starting dynamic subtest: bcs0
[500.462131] Dynamic subtest bcs0: SUCCESS (11.963s)
[500.473206] Starting dynamic subtest: vcs0
[512.430180] Dynamic subtest vcs0: SUCCESS (11.965s)
[512.441617] Starting dynamic subtest: vcs1
[523.438732] Dynamic subtest vcs1: SUCCESS (11.006s)
[523.451262] Starting dynamic subtest: vecs0
[535.406778] Dynamic subtest vecs0: SUCCESS (11.967s)
[535.419195] Starting dynamic subtest: ccs0
[545.453887] Dynamic subtest ccs0: SUCCESS (10.046s)
[545.456680] Subtest detector: SUCCESS (68.531s)
[545.559368] [085/131] (476s left) kms_atomic_transition (plane-all-transition-nonblocking)
[545.655971] Starting subtest: plane-all-transition-nonblocking
[545.658214] Starting dynamic subtest: pipe-A-eDP-1
[548.147372] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.493s)
[548.456207] Starting dynamic subtest: pipe-B-eDP-1
[551.715641] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.272s)
[552.010579] Subtest plane-all-transition-nonblocking: SUCCESS (6.357s)
[552.840192] [086/131] (469s left) gem_exec_schedule (semaphore-codependency)
[552.922986] Starting subtest: semaphore-codependency
[552.928687] Subtest semaphore-codependency: SUCCESS (0.012s)
[553.306851] [087/131] (468s left) gem_exec_params (sol-reset-not-gen7)
[553.366773] Starting subtest: sol-reset-not-gen7
[553.368945] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[553.510675] [088/131] (468s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[553.613202] Starting subtest: bo-too-small-due-to-tiling
[553.617547] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[553.752907] [089/131] (468s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[553.816784] Starting subtest: multi-wait-all-for-submit-signaled
[553.819128] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[553.960369] [090/131] (468s left) kms_color (invalid-gamma-lut-sizes)
[554.067263] Starting subtest: invalid-gamma-lut-sizes
[554.069596] Starting dynamic subtest: pipe-A
[554.355560] Dynamic subtest pipe-A: SUCCESS (0.289s)
[554.366029] Starting dynamic subtest: pipe-B
[554.377273] Dynamic subtest pipe-B: SUCCESS (0.001s)
[554.388168] Starting dynamic subtest: pipe-C
[554.390453] Dynamic subtest pipe-C: SUCCESS (0.001s)
[554.398808] Starting dynamic subtest: pipe-D
[554.400943] Dynamic subtest pipe-D: SUCCESS (0.001s)
[554.403054] Subtest invalid-gamma-lut-sizes: SUCCESS (0.294s)
[555.239539] [091/131] (467s left) kms_plane_alpha_blend (alpha-opaque-fb)
[555.335212] Starting subtest: alpha-opaque-fb
[555.626562] Starting dynamic subtest: pipe-A-eDP-1
[556.374079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[556.383713] Starting dynamic subtest: pipe-D-eDP-1
[557.754480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.380s)
[557.756752] Subtest alpha-opaque-fb: SUCCESS (2.422s)
[558.640140] [092/131] (463s left) kms_psr (pr-sprite-blt)
[558.752282] Starting subtest: pr-sprite-blt
[558.756532] Subtest pr-sprite-blt: SKIP (0.000s)
[558.851211] [093/131] (463s left) kms_chamelium_color (ctm-red-to-blue)
[558.959454] Subtest ctm-red-to-blue: SKIP (0.000s)
[559.008519] [094/131] (463s left) gem_mmap_gtt (big-copy)
[559.059033] Subtest big-copy: SKIP (0.000s)
[559.117689] [095/131] (463s left) gem_mmap_gtt (hang-busy)
[559.184566] Subtest hang-busy: SKIP (0.000s)
[559.261058] [096/131] (463s left) i915_suspend (basic-s3-without-i915)
[559.295461] Starting subtest: basic-s3-without-i915
[562.765442] Subtest basic-s3-without-i915: SKIP (3.469s)
[564.377714] [097/131] (458s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[564.477894] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[564.604891] [098/131] (458s left) syncobj_wait (invalid-signal-illegal-handle)
[564.661495] Starting subtest: invalid-signal-illegal-handle
[564.663724] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[564.778136] [099/131] (457s left) kms_psr (fbc-psr2-cursor-blt)
[564.869149] Starting subtest: fbc-psr2-cursor-blt
[564.871443] Starting dynamic subtest: eDP-1
[564.875713] Dynamic subtest eDP-1: SKIP (0.000s)
[564.880032] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[564.969892] [100/131] (457s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[565.077497] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[566.038335] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.960s)
[566.214262] [101/131] (456s left) gem_exec_schedule (pi-ringfull)
[566.411882] Starting subtest: pi-ringfull
[566.413867] Starting dynamic subtest: rcs0
[566.438044] Dynamic subtest rcs0: SUCCESS (0.029s)
[566.449252] Starting dynamic subtest: bcs0
[566.466578] Dynamic subtest bcs0: SUCCESS (0.028s)
[566.479342] Starting dynamic subtest: vcs0
[566.494460] Dynamic subtest vcs0: SUCCESS (0.027s)
[566.507969] Starting dynamic subtest: vcs1
[566.520713] Dynamic subtest vcs1: SUCCESS (0.025s)
[566.531602] Starting dynamic subtest: vecs0
[566.552400] Dynamic subtest vecs0: SUCCESS (0.031s)
[566.572002] Starting dynamic subtest: ccs0
[566.581949] Dynamic subtest ccs0: SUCCESS (0.029s)
[566.584255] Subtest pi-ringfull: SUCCESS (0.174s)
[566.816171] [102/131] (456s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[566.923142] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[573.720861] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.804s)
[573.847679] [103/131] (449s left) kms_addfb_basic (clobberred-modifier)
[573.903573] Starting subtest: clobberred-modifier
[573.907822] Subtest clobberred-modifier: SKIP (0.000s)
[574.053257] [104/131] (448s left) gem_exec_params (batch-first)
[574.111219] Starting subtest: batch-first
[574.113410] Subtest batch-first: SUCCESS (0.005s)
[574.258261] [105/131] (448s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[574.311539] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[574.377322] [106/131] (448s left) drm_read (empty-nonblock)
[574.533658] Starting subtest: empty-nonblock
[574.536089] Subtest empty-nonblock: SUCCESS (0.000s)
[574.684435] [107/131] (448s left) kms_content_protection (uevent)
[574.822731] Starting subtest: uevent
[574.826679] Subtest uevent: SKIP (0.000s)
[574.982131] [108/131] (448s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[575.079649] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[575.081582] Starting dynamic subtest: pipe-A
[576.127425] Dynamic subtest pipe-A: SUCCESS (1.050s)
[576.137593] Starting dynamic subtest: pipe-B
[578.214489] Dynamic subtest pipe-B: SUCCESS (2.085s)
[578.226961] Starting dynamic subtest: pipe-C
[579.427825] Dynamic subtest pipe-C: SUCCESS (1.212s)
[579.439238] Starting dynamic subtest: pipe-D
[580.657291] Dynamic subtest pipe-D: SUCCESS (1.227s)
[580.659697] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.581s)
[581.872053] [109/131] (441s left) gem_mmap_gtt (basic-write-gtt)
[581.936806] Subtest basic-write-gtt: SKIP (0.000s)
[582.014422] [110/131] (441s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[582.115520] Starting subtest: psr-farfromfence-mmap-gtt
[582.119570] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[582.255193] [111/131] (440s left) kms_dp_link_training (non-uhbr-mst)
[582.359181] Starting subtest: non-uhbr-mst
[582.367504] Subtest non-uhbr-mst: SKIP (0.000s)
[582.456508] [112/131] (440s left) gem_basic (bad-close)
[582.515685] Starting subtest: bad-close
[582.520113] Subtest bad-close: SUCCESS (0.000s)
[582.648517] [113/131] (440s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[582.740494] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[582.744859] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[582.869038] [114/131] (440s left) kms_psr (fbc-psr-primary-blt)
[582.963135] Starting subtest: fbc-psr-primary-blt
[582.964945] Starting dynamic subtest: eDP-1
[582.968245] Dynamic subtest eDP-1: SKIP (0.000s)
[582.971561] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[583.059703] [115/131] (440s left) sysfs_timeslice_duration (duration)
[583.119012] Starting subtest: duration
[583.120968] Starting dynamic subtest: vecs0
[596.399219] Dynamic subtest vecs0: SUCCESS (13.280s)
[596.411987] Starting dynamic subtest: ccs0
[609.576960] Dynamic subtest ccs0: SUCCESS (13.172s)
[609.591748] Starting dynamic subtest: vcs0
[624.430670] Dynamic subtest vcs0: SUCCESS (14.846s)
[624.442459] Starting dynamic subtest: bcs0
[637.599358] Dynamic subtest bcs0: SUCCESS (13.164s)
[637.612890] Starting dynamic subtest: rcs0
[650.775383] Dynamic subtest rcs0: SUCCESS (13.172s)
[650.787691] Starting dynamic subtest: vcs1
[665.389559] Dynamic subtest vcs1: SUCCESS (14.609s)
[665.393523] Subtest duration: SUCCESS (82.260s)
[665.491312] [116/131] (357s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[665.610771] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[665.614734] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[665.744090] [117/131] (357s left) kms_draw_crc (fill-fb)
[665.841292] Starting subtest: fill-fb
[666.381556] Subtest fill-fb: SUCCESS (0.542s)
[666.513830] [118/131] (357s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[666.613192] Starting subtest: y-tiled-16bpp-rotate-90
[666.616982] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[666.743238] [119/131] (356s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[666.840283] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[666.843659] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[666.968633] [120/131] (356s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[667.075066] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[673.767237] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.694s)
[673.904846] [121/131] (349s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[674.010900] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[674.013198] Starting dynamic subtest: pipe-A-default-mode
[676.681848] Dynamic subtest pipe-A-default-mode: SUCCESS (2.671s)
[676.684463] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.673s)
[677.579763] [122/131] (346s left) gem_pxp (reject-modify-context-protection-on)
[677.720111] Starting subtest: reject-modify-context-protection-on
[677.722671] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[677.863610] [123/131] (345s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[677.967373] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[677.971752] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[678.081757] [124/131] (345s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[678.180584] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[678.185336] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[678.325208] [125/131] (345s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[683.343970] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[683.348601] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[684.199377] [126/131] (339s left) kms_hdr (static-toggle-suspend)
[684.285714] Starting subtest: static-toggle-suspend
[684.292120] Subtest static-toggle-suspend: SKIP (0.000s)
[684.380694] [127/131] (339s left) dmabuf_sync_file (export-wait-after-attach)
[684.423633] Starting subtest: export-wait-after-attach
[684.425840] Subtest export-wait-after-attach: SUCCESS (0.001s)
[684.501296] [128/131] (339s left) kms_cursor_legacy (single-move)
[684.622292] Starting subtest: single-move
[684.624560] Starting dynamic subtest: pipe-A
[690.004565] Dynamic subtest pipe-A: SUCCESS (5.378s)
[690.014937] Starting dynamic subtest: pipe-B
[695.386246] Dynamic subtest pipe-B: SUCCESS (5.379s)
[695.396541] Starting dynamic subtest: pipe-C
[700.766882] Dynamic subtest pipe-C: SUCCESS (5.379s)
[700.777178] Starting dynamic subtest: pipe-D
[706.148631] Dynamic subtest pipe-D: SUCCESS (5.379s)
[706.158927] Starting dynamic subtest: all-pipes
[711.535767] Dynamic subtest all-pipes: SUCCESS (5.386s)
[711.537981] Subtest single-move: SUCCESS (26.913s)
[711.706146] [129/131] (312s left) gem_exec_fence (basic-wait)
[711.887345] Starting subtest: basic-wait
[711.889695] Starting dynamic subtest: rcs0
[711.986011] Dynamic subtest rcs0: SUCCESS (0.101s)
[711.997206] Starting dynamic subtest: bcs0
[712.047707] Dynamic subtest bcs0: SUCCESS (0.060s)
[712.058407] Starting dynamic subtest: vcs0
[712.111306] Dynamic subtest vcs0: SUCCESS (0.062s)
[712.121343] Starting dynamic subtest: vcs1
[712.179210] Dynamic subtest vcs1: SUCCESS (0.065s)
[712.190402] Starting dynamic subtest: vecs0
[712.241269] Dynamic subtest vecs0: SUCCESS (0.060s)
[712.251707] Starting dynamic subtest: ccs0
[712.303332] Dynamic subtest ccs0: SUCCESS (0.060s)
[712.305731] Subtest basic-wait: SUCCESS (0.421s)
[714.596189] [130/131] (309s left) gem_exec_balancer (full-late)
[714.670821] Starting subtest: full-late
[719.383715] Subtest full-late: SUCCESS (4.713s)
[719.747932] [131/131] (304s left) gem_exec_params (readonly)
[719.813816] Starting subtest: readonly
[719.819653] Subtest readonly: SUCCESS (0.004s)
[719.980909] 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.