[57.300181] Initializing watchdogs
[57.300228]   /dev/watchdog0
[57.314542] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.319087] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.321991] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.325242] [001/133] (960s left) gem_ctx_param (set-priority-invalid-size)
[57.394623] Starting subtest: set-priority-invalid-size
[57.396780] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[57.482488] [002/133] (960s left) api_intel_bb (simple-bb-ctx)
[57.541740] Starting subtest: simple-bb-ctx
[57.555656] Subtest simple-bb-ctx: SUCCESS (0.016s)
[57.659278] [003/133] (960s left) kms_big_fb (linear-64bpp-rotate-0)
[57.757683] Starting subtest: linear-64bpp-rotate-0
[59.448247] Subtest linear-64bpp-rotate-0: SUCCESS (1.691s)
[59.609705] [004/133] (958s left) i915_power (sanity)
[59.666788] Starting subtest: sanity
[63.711817] Subtest sanity: SUCCESS (4.038s)
[64.943179] [005/133] (953s left) syncobj_timeline (invalid-transfer-bad-pad)
[65.011096] Starting subtest: invalid-transfer-bad-pad
[65.013331] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[65.129648] [006/133] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[65.227014] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[71.843962] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.619s)
[71.955808] [007/133] (946s left) kms_invalid_mode (bad-hsync-start)
[72.063624] Starting subtest: bad-hsync-start
[72.066063] Starting dynamic subtest: pipe-A-eDP-1
[72.351311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[72.360203] Starting dynamic subtest: pipe-B-eDP-1
[72.362333] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[72.369730] Starting dynamic subtest: pipe-C-eDP-1
[72.371716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[72.379245] Starting dynamic subtest: pipe-D-eDP-1
[72.381919] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[72.384834] Subtest bad-hsync-start: SUCCESS (0.292s)
[73.181939] [008/133] (944s left) kms_plane_lowres (tiling-yf)
[73.271259] Starting subtest: tiling-yf
[73.275650] Subtest tiling-yf: SKIP (0.000s)
[73.356086] [009/133] (944s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[73.456834] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[73.461277] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[73.558209] [010/133] (944s left) gem_mmap_wc (write-read-distinct)
[73.618572] Subtest write-read-distinct: SKIP (0.000s)
[73.679196] [011/133] (944s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[73.784117] Starting subtest: fbc-psr-cursor-mmap-cpu
[73.786502] Starting dynamic subtest: eDP-1
[73.790975] Dynamic subtest eDP-1: SKIP (0.000s)
[73.795652] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[73.872902] [012/133] (944s left) kms_pm_dc (dc5-retention-flops)
[74.974763] Starting subtest: dc5-retention-flops
[74.979327] Subtest dc5-retention-flops: SKIP (0.000s)
[75.055875] [013/133] (943s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[75.183993] Starting subtest: short-busy-flip-before-cursor-toggle
[75.188671] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[75.339338] [014/133] (943s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[75.436121] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[75.440155] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[75.532532] [015/133] (942s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[75.625541] Starting subtest: 4-tiled-16bpp-rotate-90
[75.647359] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.021s)
[75.761675] [016/133] (942s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[75.817239] Starting subtest: etime-multi-wait-all-for-submit-submitted
[75.922044] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[75.993763] [017/133] (942s left) perf (polling)
[76.133953] Starting subtest: polling
[76.136246] Starting dynamic subtest: 0-rcs0
[86.156420] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[86.166686] Starting dynamic subtest: 1-vecs0
[96.231167] Dynamic subtest 1-vecs0: SUCCESS (10.025s)
[96.233825] Subtest polling: SUCCESS (20.047s)
[96.270675] [018/133] (922s left) kms_addfb_basic (basic)
[96.341869] Starting subtest: basic
[96.344254] Subtest basic: SUCCESS (0.000s)
[96.490910] [019/133] (922s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[96.591126] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[96.593340] Starting dynamic subtest: A-eDP1
[100.230461] Dynamic subtest A-eDP1: SUCCESS (3.638s)
[100.239767] Starting dynamic subtest: B-eDP1
[103.439540] Dynamic subtest B-eDP1: SUCCESS (3.210s)
[103.448888] Starting dynamic subtest: C-eDP1
[106.550277] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[106.561321] Starting dynamic subtest: D-eDP1
[109.739432] Dynamic subtest D-eDP1: SUCCESS (3.189s)
[109.741698] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.153s)
[110.534078] [020/133] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[110.636850] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[110.641308] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[110.719737] [021/133] (907s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[110.810969] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[110.813158] Starting dynamic subtest: pipe-A-eDP-1
[110.871332] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[110.880382] Starting dynamic subtest: pipe-B-eDP-1
[110.937976] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[110.948735] Starting dynamic subtest: pipe-C-eDP-1
[111.004162] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[111.012037] Starting dynamic subtest: pipe-D-eDP-1
[111.066699] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[111.071157] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[113.095048] [022/133] (905s left) kms_cursor_crc (cursor-random-32x10)
[113.272784] Starting subtest: cursor-random-32x10
[113.320265] Subtest cursor-random-32x10: SKIP (0.043s)
[113.600860] [023/133] (905s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[113.697726] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[113.700093] Starting dynamic subtest: pipe-A-default-mode
[114.855795] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[114.860368] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.156s)
[114.999981] [024/133] (903s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[115.097270] Starting subtest: x-tiled-addfb-size-offset-overflow
[115.099519] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[115.209169] [025/133] (903s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[115.305923] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[115.308232] Starting dynamic subtest: pipe-A-eDP-1
[126.288413] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.985s)
[126.297691] Starting dynamic subtest: pipe-B-eDP-1
[138.030304] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.741s)
[138.032288] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.728s)
[138.902055] [026/133] (879s left) gem_mmap_wc (write-wc-read-gtt)
[138.959331] Subtest write-wc-read-gtt: SKIP (0.000s)
[139.023742] [027/133] (879s left) syncobj_basic (bad-flags-handle-to-fd)
[139.081840] Starting subtest: bad-flags-handle-to-fd
[139.084074] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[139.170910] [028/133] (879s left) sysfs_preempt_timeout (invalid)
[139.228637] Starting subtest: invalid
[139.231069] Starting dynamic subtest: vecs0
[139.233479] Dynamic subtest vecs0: SUCCESS (0.000s)
[139.242959] Starting dynamic subtest: ccs0
[139.244906] Dynamic subtest ccs0: SUCCESS (0.000s)
[139.252221] Starting dynamic subtest: vcs0
[139.254114] Dynamic subtest vcs0: SUCCESS (0.000s)
[139.261154] Starting dynamic subtest: bcs0
[139.263038] Dynamic subtest bcs0: SUCCESS (0.000s)
[139.270676] Starting dynamic subtest: rcs0
[139.272757] Dynamic subtest rcs0: SUCCESS (0.000s)
[139.282051] Starting dynamic subtest: vcs1
[139.283995] Dynamic subtest vcs1: SUCCESS (0.000s)
[139.286061] Subtest invalid: SUCCESS (0.004s)
[139.342340] [029/133] (879s left) gem_exec_balancer (smoke)
[139.404041] Starting subtest: smoke
[162.038098] Subtest smoke: SUCCESS (22.583s)
[163.134140] [030/133] (855s left) prime_busy (hang)
[163.188093] Starting subtest: hang
[163.190392] Starting dynamic subtest: rcs0
[189.433495] Dynamic subtest rcs0: SUCCESS (26.232s)
[189.444224] Starting dynamic subtest: bcs0
[196.581089] Dynamic subtest bcs0: SUCCESS (7.154s)
[196.590671] Starting dynamic subtest: vcs0
[203.552269] Dynamic subtest vcs0: SUCCESS (6.973s)
[203.562812] Starting dynamic subtest: vcs1
[210.590741] Dynamic subtest vcs1: SUCCESS (7.038s)
[210.600882] Starting dynamic subtest: vecs0
[217.565551] Dynamic subtest vecs0: SUCCESS (6.974s)
[217.575972] Starting dynamic subtest: ccs0
[231.407368] Dynamic subtest ccs0: SUCCESS (13.835s)
[231.409934] Subtest hang: SUCCESS (68.216s)
[231.511541] [031/133] (787s left) i915_pm_rpm (gem-execbuf-stress)
[233.027281] Starting subtest: gem-execbuf-stress
[233.029706] Starting dynamic subtest: smem0
[245.921806] Dynamic subtest smem0: SUCCESS (12.892s)
[245.932899] Starting dynamic subtest: extra-wait-smem0
[308.913104] Dynamic subtest extra-wait-smem0: SUCCESS (62.938s)
[308.915382] Subtest gem-execbuf-stress: SUCCESS (75.833s)
[309.249258] [032/133] (709s left) gem_partial_pwrite_pread (writes-after-reads)
[309.325416] Subtest writes-after-reads: SKIP (0.000s)
[309.388997] [033/133] (709s left) kms_cursor_crc (cursor-offscreen-32x32)
[309.514888] Starting subtest: cursor-offscreen-32x32
[309.565310] Subtest cursor-offscreen-32x32: SKIP (0.045s)
[309.831627] [034/133] (709s left) kms_psr (fbc-psr2-sprite-blt)
[309.928857] Starting subtest: fbc-psr2-sprite-blt
[309.931219] Starting dynamic subtest: eDP-1
[309.935564] Dynamic subtest eDP-1: SKIP (0.000s)
[309.939967] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[310.002998] [035/133] (709s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[310.052844] Starting subtest: etime-single-wait-available-unsubmitted
[310.152383] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[310.228760] [036/133] (708s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[310.281519] Starting subtest: legacy-engines-hostile-preempt
[310.283527] Starting dynamic subtest: render
[310.350084] Dynamic subtest render: SUCCESS (0.068s)
[310.362616] Starting dynamic subtest: bsd1
[311.823736] Dynamic subtest bsd1: SUCCESS (1.468s)
[311.835287] Starting dynamic subtest: bsd2
[313.879798] Dynamic subtest bsd2: SUCCESS (2.053s)
[313.891647] Starting dynamic subtest: blt
[313.907737] Dynamic subtest blt: SUCCESS (0.027s)
[313.915477] Starting dynamic subtest: vebox
[315.896512] Dynamic subtest vebox: SUCCESS (1.986s)
[315.899296] Subtest legacy-engines-hostile-preempt: SUCCESS (5.614s)
[316.014806] [037/133] (703s left) kms_lease (lease-invalid-plane)
[316.116243] Starting subtest: lease-invalid-plane
[316.118499] Starting dynamic subtest: pipe-A-eDP-1
[316.120776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[316.136930] Starting dynamic subtest: pipe-B-eDP-1
[316.139023] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[316.150775] Starting dynamic subtest: pipe-C-eDP-1
[316.153279] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[316.164216] Starting dynamic subtest: pipe-D-eDP-1
[316.166420] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[316.168665] Subtest lease-invalid-plane: SUCCESS (0.003s)
[316.203156] [038/133] (703s left) kms_psr (pr-sprite-blt)
[316.288091] Starting subtest: pr-sprite-blt
[316.292290] Subtest pr-sprite-blt: SKIP (0.000s)
[316.360563] [039/133] (702s left) sw_sync (sync_random_merge)
[316.397507] Starting subtest: sync_random_merge
[316.435406] Subtest sync_random_merge: SUCCESS (0.043s)
[316.492837] [040/133] (702s left) gem_exec_schedule (preempt)
[316.561943] Starting subtest: preempt
[316.564246] Starting dynamic subtest: rcs0
[316.577051] Dynamic subtest rcs0: SUCCESS (0.022s)
[316.585387] Starting dynamic subtest: bcs0
[316.595811] Dynamic subtest bcs0: SUCCESS (0.018s)
[316.604504] Starting dynamic subtest: vcs0
[316.618649] Dynamic subtest vcs0: SUCCESS (0.022s)
[316.626792] Starting dynamic subtest: vcs1
[316.639535] Dynamic subtest vcs1: SUCCESS (0.020s)
[316.647752] Starting dynamic subtest: vecs0
[316.666754] Dynamic subtest vecs0: SUCCESS (0.027s)
[316.674791] Starting dynamic subtest: ccs0
[316.688094] Dynamic subtest ccs0: SUCCESS (0.021s)
[316.690428] Subtest preempt: SUCCESS (0.134s)
[317.978507] [041/133] (701s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[318.075166] Starting subtest: primary-4-tiled-reflect-x-0
[325.045055] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.971s)
[326.187402] [042/133] (693s left) kms_plane (plane-panning-bottom-right-suspend)
[326.275897] Starting subtest: plane-panning-bottom-right-suspend
[326.278727] Starting dynamic subtest: pipe-A
[344.439561] Dynamic subtest pipe-A: SUCCESS (2.971s)
[344.449310] Starting dynamic subtest: pipe-B
[362.408048] Dynamic subtest pipe-B: SUCCESS (3.450s)
[362.410942] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.423s)
[363.219750] [043/133] (656s left) kms_pm_rpm (fences-dpms)
[364.850993] Starting subtest: fences-dpms
[364.856937] Subtest fences-dpms: SKIP (0.000s)
[365.478078] [044/133] (654s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[365.595808] Starting subtest: basic-flip-before-cursor-legacy
[366.507979] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.912s)
[367.389032] [045/133] (652s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[367.474046] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[367.476834] Starting dynamic subtest: pipe-A-eDP-1
[367.500708] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[367.510785] Starting dynamic subtest: pipe-B-eDP-1
[367.533726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[367.542047] Starting dynamic subtest: pipe-C-eDP-1
[367.565085] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[367.574935] Starting dynamic subtest: pipe-D-eDP-1
[367.598063] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[367.600490] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.011s)
[369.759338] [046/133] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[369.852560] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[369.857460] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[369.947893] [047/133] (649s left) gem_softpin (evict-snoop-interruptible)
[370.017717] Starting subtest: evict-snoop-interruptible
[370.022851] Subtest evict-snoop-interruptible: SKIP (0.000s)
[370.132297] [048/133] (649s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[370.243354] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[370.248509] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[370.336198] [049/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[370.431912] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[370.436528] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[370.525496] [050/133] (649s left) gem_exec_schedule (u-submit-late-slice)
[370.599369] Starting subtest: u-submit-late-slice
[370.601920] Starting dynamic subtest: rcs0
[370.624379] Dynamic subtest rcs0: SUCCESS (0.036s)
[370.636680] Starting dynamic subtest: bcs0
[370.649833] Dynamic subtest bcs0: SUCCESS (0.025s)
[370.659350] Starting dynamic subtest: vcs0
[370.677515] Dynamic subtest vcs0: SUCCESS (0.027s)
[370.686769] Starting dynamic subtest: vcs1
[370.707540] Dynamic subtest vcs1: SUCCESS (0.030s)
[370.719240] Starting dynamic subtest: vecs0
[370.733916] Dynamic subtest vecs0: SUCCESS (0.025s)
[370.744125] Starting dynamic subtest: ccs0
[370.768273] Dynamic subtest ccs0: SUCCESS (0.034s)
[370.770410] Subtest u-submit-late-slice: SUCCESS (0.182s)
[372.728341] [051/133] (647s left) syncobj_timeline (multi-wait-submitted-signaled)
[372.787545] Starting subtest: multi-wait-submitted-signaled
[372.790414] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[372.890266] [052/133] (646s left) gen9_exec_parse (secure-batches)
[372.954862] Subtest secure-batches: SKIP (0.000s)
[373.034231] [053/133] (646s left) gem_exec_params (invalid-fence-in-submit)
[373.094950] Starting subtest: invalid-fence-in-submit
[373.099991] Subtest invalid-fence-in-submit: SUCCESS (0.005s)
[373.213902] [054/133] (646s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[373.338528] Starting subtest: flip-vs-cursor-busy-crc-legacy
[374.160665] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.820s)
[374.994835] [055/133] (644s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[375.105103] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[375.107854] Starting dynamic subtest: pipe-A
[375.357602] Dynamic subtest pipe-A: SUCCESS (0.255s)
[375.366974] Starting dynamic subtest: pipe-B
[376.688553] Dynamic subtest pipe-B: SUCCESS (1.329s)
[376.697864] Starting dynamic subtest: pipe-C
[378.022946] Dynamic subtest pipe-C: SUCCESS (1.332s)
[378.037995] Starting dynamic subtest: pipe-D
[379.345830] Dynamic subtest pipe-D: SUCCESS (1.320s)
[379.348676] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.242s)
[380.526218] [056/133] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[380.629535] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[380.634735] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[380.709356] [057/133] (639s left) kms_chamelium_frames (hdmi-crc-single)
[381.099640] Subtest hdmi-crc-single: SKIP (0.000s)
[381.939996] [058/133] (638s left) gem_create (hog-create)
[381.991636] Starting subtest: hog-create
[381.993910] Starting dynamic subtest: smem0
[415.578914] Dynamic subtest smem0: SUCCESS (33.576s)
[415.582103] Subtest hog-create: SUCCESS (33.578s)
[415.775365] [059/133] (604s left) kms_concurrent (multi-plane-atomic-lowres)
[415.879328] Starting subtest: multi-plane-atomic-lowres
[415.881852] Starting dynamic subtest: pipe-A-eDP-1
[416.417842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[416.427739] Starting dynamic subtest: pipe-B-eDP-1
[417.704008] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.283s)
[417.721901] Starting dynamic subtest: pipe-C-eDP-1
[418.961032] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.255s)
[418.971870] Starting dynamic subtest: pipe-D-eDP-1
[420.207662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[420.210212] Subtest multi-plane-atomic-lowres: SUCCESS (4.325s)
[421.012867] [060/133] (599s left) gem_exec_nop (basic-parallel)
[421.089541] Starting subtest: basic-parallel
[436.642258] Subtest basic-parallel: SUCCESS (15.560s)
[436.874410] [061/133] (583s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[436.976068] Starting subtest: fbc-rgb565-draw-blt
[441.101828] Subtest fbc-rgb565-draw-blt: SUCCESS (4.129s)
[442.229413] [062/133] (578s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[442.333892] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[442.338978] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[442.459718] [063/133] (577s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[442.553952] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[442.559002] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[442.628901] [064/133] (577s left) i915_drm_fdinfo (idle)
[442.672749] Starting subtest: idle
[442.675477] Starting dynamic subtest: rcs0
[443.232126] Dynamic subtest rcs0: SUCCESS (0.563s)
[443.244872] Starting dynamic subtest: bcs0
[443.738791] Dynamic subtest bcs0: SUCCESS (0.503s)
[443.749882] Starting dynamic subtest: vcs0
[444.247844] Dynamic subtest vcs0: SUCCESS (0.503s)
[444.258924] Starting dynamic subtest: vcs1
[444.749967] Dynamic subtest vcs1: SUCCESS (0.503s)
[444.761087] Starting dynamic subtest: vecs0
[445.255736] Dynamic subtest vecs0: SUCCESS (0.503s)
[445.268074] Starting dynamic subtest: ccs0
[445.761433] Dynamic subtest ccs0: SUCCESS (0.503s)
[445.764311] Subtest idle: SUCCESS (3.093s)
[445.839192] [065/133] (574s left) api_intel_bb (blit-noreloc-purge-cache)
[445.899004] Starting subtest: blit-noreloc-purge-cache
[445.912690] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[446.031309] [066/133] (574s left) kms_psr (psr2-sprite-blt)
[446.138515] Starting subtest: psr2-sprite-blt
[446.140972] Starting dynamic subtest: eDP-1
[447.924062] Dynamic subtest eDP-1: SUCCESS (1.786s)
[447.926856] Subtest psr2-sprite-blt: SUCCESS (1.787s)
[448.785320] [067/133] (571s left) gem_mmap_gtt (big-bo-tiledy)
[448.837066] Subtest big-bo-tiledY: SKIP (0.000s)
[448.890531] [068/133] (571s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[448.993087] Starting subtest: x-tiled-32bpp-rotate-270
[449.013603] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[449.130116] [069/133] (571s left) gem_watchdog (default-virtual)
[449.196416] Starting subtest: default-virtual
[455.467615] Subtest default-virtual: SUCCESS (6.282s)
[455.549921] [070/133] (565s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[455.647314] Starting subtest: primary-yf-tiled-reflect-x-0
[455.707427] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[455.809911] [071/133] (564s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[455.865064] Subtest writes-after-reads-snoop: SKIP (0.000s)
[455.936381] [072/133] (564s left) device_reset (unbind-reset-rebind)
[455.988794] Starting subtest: unbind-reset-rebind
[458.995114] Subtest unbind-reset-rebind: SUCCESS (3.002s)
[459.041478] [073/133] (561s left) syncobj_basic (bad-destroy)
[459.098234] Starting subtest: bad-destroy
[459.101079] Subtest bad-destroy: SUCCESS (0.000s)
[459.196630] [074/133] (561s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[459.587510] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[460.373430] [075/133] (560s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[460.500746] Starting subtest: basic-busy-flip-before-cursor-atomic
[460.505340] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[460.643583] [076/133] (560s left) gem_mmap (bad-size)
[460.701054] Subtest bad-size: SKIP (0.000s)
[460.756821] [077/133] (560s left) gem_close_race (basic-threads)
[460.823039] Starting subtest: basic-threads
[462.195094] Subtest basic-threads: SUCCESS (1.373s)
[462.393352] [078/133] (558s left) gem_tiled_pread_pwrite
[462.514310] [079/133] (558s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[462.642077] Starting subtest: protected-encrypted-src-copy-not-readible
[462.751508] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[462.860222] [080/133] (558s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[462.952810] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[462.955234] Starting dynamic subtest: pipe-A-eDP-1
[463.040250] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[463.051842] Starting dynamic subtest: pipe-B-eDP-1
[464.173619] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[464.179060] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.224s)
[465.353722] [081/133] (555s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[465.459871] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[465.465069] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[465.554529] [082/133] (555s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[465.645550] Starting subtest: dsc-fractional-bpp-with-bpc
[465.681205] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[465.721978] [083/133] (555s left) perf_pmu (enable-race)
[465.767062] Starting subtest: enable-race
[465.769868] Starting dynamic subtest: rcs0
[478.553747] Dynamic subtest rcs0: SUCCESS (12.775s)
[478.571362] Starting dynamic subtest: bcs0
[491.298195] Dynamic subtest bcs0: SUCCESS (12.748s)
[491.309894] Starting dynamic subtest: vcs0
[506.593848] Dynamic subtest vcs0: SUCCESS (15.314s)
[506.606737] Starting dynamic subtest: vcs1
[522.593460] Dynamic subtest vcs1: SUCCESS (15.997s)
[522.607066] Starting dynamic subtest: vecs0
[538.593427] Dynamic subtest vecs0: SUCCESS (15.997s)
[538.604907] Starting dynamic subtest: ccs0
[551.338943] Dynamic subtest ccs0: SUCCESS (12.742s)
[551.341729] Subtest enable-race: SUCCESS (85.586s)
[551.442449] [084/133] (469s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[551.545819] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[560.872238] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.327s)
[561.009687] [085/133] (460s left) kms_selftest (drm_format_helper)
[561.053203] Starting subtest: drm_format_helper
[561.092382] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[561.186325] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.091s)
[561.197118] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[561.284610] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.097s)
[561.294948] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[561.377355] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.094s)
[561.387940] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[561.470942] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.092s)
[561.481356] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[561.566225] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.096s)
[561.583238] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[561.673552] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.106s)
[561.683905] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[561.766914] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.093s)
[561.776933] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[561.862061] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.093s)
[561.872555] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[561.954327] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.092s)
[561.964366] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[562.043873] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.090s)
[562.054298] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[562.132713] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.088s)
[562.142916] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[562.226082] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.091s)
[562.235594] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[562.313291] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.088s)
[562.327069] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[562.409557] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.093s)
[562.418887] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[562.499379] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.089s)
[562.508099] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[562.591912] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.092s)
[562.602232] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[562.687868] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.095s)
[562.689986] Subtest drm_format_helper: SUCCESS (1.636s)
[562.828430] [086/133] (458s left) kms_vrr (flip-basic-fastset)
[562.919607] Starting subtest: flip-basic-fastset
[562.926697] Subtest flip-basic-fastset: SKIP (0.000s)
[562.990615] [087/133] (458s left) kms_psr (fbc-pr-cursor-blt)
[563.080841] Starting subtest: fbc-pr-cursor-blt
[563.085071] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[563.153688] [088/133] (458s left) fbdev (pan)
[563.199755] Starting subtest: pan
[563.226680] Subtest pan: SUCCESS (0.032s)
[563.294531] [089/133] (458s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[563.404234] Starting subtest: plane-lut1d-pre-ctm3x4
[563.563656] Starting dynamic subtest: pipe-A-plane-0
[563.927663] Dynamic subtest pipe-A-plane-0: FAIL (0.216s)
[563.937353] Starting dynamic subtest: pipe-A-plane-1
[564.174262] Dynamic subtest pipe-A-plane-1: FAIL (0.185s)
[564.184237] Starting dynamic subtest: pipe-A-plane-2
[564.433326] Dynamic subtest pipe-A-plane-2: FAIL (0.172s)
[565.331570] Starting dynamic subtest: pipe-B-plane-0
[565.817524] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[565.828766] Starting dynamic subtest: pipe-B-plane-1
[566.179684] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[566.189711] Starting dynamic subtest: pipe-B-plane-2
[566.522992] Dynamic subtest pipe-B-plane-2: FAIL (0.653s)
[567.543070] Starting dynamic subtest: pipe-C-plane-0
[568.081196] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[568.093080] Starting dynamic subtest: pipe-C-plane-1
[568.541718] Dynamic subtest pipe-C-plane-1: FAIL (0.682s)
[568.551686] Starting dynamic subtest: pipe-C-plane-2
[568.956908] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[569.778977] Starting dynamic subtest: pipe-D-plane-0
[570.447696] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[570.458059] Starting dynamic subtest: pipe-D-plane-1
[570.971458] Dynamic subtest pipe-D-plane-1: FAIL (0.697s)
[570.981972] Starting dynamic subtest: pipe-D-plane-2
[571.496671] Dynamic subtest pipe-D-plane-2: FAIL (0.632s)
[571.540924] Subtest plane-lut1d-pre-ctm3x4: FAIL (8.134s)
[572.339140] [090/133] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[572.444050] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[572.449417] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[572.540031] [091/133] (448s left) gem_exec_async (concurrent-writes)
[572.601828] Starting subtest: concurrent-writes
[572.604216] Starting dynamic subtest: rcs0
[572.622008] Dynamic subtest rcs0: SUCCESS (0.020s)
[572.631522] Starting dynamic subtest: bcs0
[572.633580] Dynamic subtest bcs0: SUCCESS (0.006s)
[572.644033] Starting dynamic subtest: vcs0
[572.646711] Dynamic subtest vcs0: SUCCESS (0.004s)
[572.656241] Starting dynamic subtest: vcs1
[572.658793] Dynamic subtest vcs1: SUCCESS (0.008s)
[572.668509] Starting dynamic subtest: vecs0
[572.670691] Dynamic subtest vecs0: SUCCESS (0.010s)
[572.679690] Starting dynamic subtest: ccs0
[572.681925] Dynamic subtest ccs0: SUCCESS (0.010s)
[572.684332] Subtest concurrent-writes: SUCCESS (0.064s)
[572.892549] [092/133] (448s left) kms_cdclk (plane-scaling)
[572.980754] Starting subtest: plane-scaling
[572.983194] Starting dynamic subtest: pipe-A-eDP-1
[573.275923] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[573.286160] Starting dynamic subtest: pipe-B-eDP-1
[573.291298] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[573.300867] Starting dynamic subtest: pipe-C-eDP-1
[573.306550] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[573.318006] Starting dynamic subtest: pipe-D-eDP-1
[573.323731] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[573.328884] Subtest plane-scaling: SKIP (0.301s)
[574.085771] [093/133] (447s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[574.173775] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[574.175886] Starting dynamic subtest: pipe-A-eDP-1
[574.597743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s)
[574.609318] Starting dynamic subtest: pipe-B-eDP-1
[574.632805] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[574.643401] Starting dynamic subtest: pipe-C-eDP-1
[574.665930] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[574.675591] Starting dynamic subtest: pipe-D-eDP-1
[574.698546] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[574.701077] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.440s)
[576.851267] [094/133] (444s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[576.977850] Starting subtest: cursorB-vs-flipA-varying-size
[576.982622] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[577.121196] [095/133] (444s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[577.215045] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[577.219843] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[577.310211] [096/133] (444s left) i915_module_load (resize-bar)
[577.348774] Starting subtest: resize-bar
[577.357006] Subtest resize-bar: SKIP (0.006s)
[577.400444] [097/133] (444s left) gem_userptr_blits (unsync-overlap)
[577.477060] Subtest unsync-overlap: SKIP (0.000s)
[577.599776] [098/133] (444s left) kms_addfb_basic (unused-handle)
[577.649083] Starting subtest: unused-handle
[577.651681] Subtest unused-handle: SUCCESS (0.000s)
[577.781699] [099/133] (443s left) gem_close (basic)
[577.843998] Starting subtest: basic
[577.846274] Subtest basic: SUCCESS (0.000s)
[577.944629] [100/133] (443s left) gem_mmap_offset (bad-object)
[577.996865] Starting subtest: bad-object
[577.999113] Subtest bad-object: SUCCESS (0.001s)
[578.081239] [101/133] (443s left) kms_cursor_crc (cursor-sliding-512x512)
[578.349104] Starting subtest: cursor-sliding-512x512
[578.354218] Subtest cursor-sliding-512x512: SKIP (0.001s)
[578.505658] [102/133] (443s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[578.596819] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[578.600855] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[578.683412] [103/133] (443s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[578.780787] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[578.784691] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[578.870679] [104/133] (443s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[578.929550] Starting subtest: yf-tiled-to-vebox-x-tiled
[578.933851] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[579.110453] [105/133] (442s left) gem_userptr_blits (sync-unmap-cycles)
[579.179100] Starting subtest: sync-unmap-cycles
[584.558581] Subtest sync-unmap-cycles: SUCCESS (5.381s)
[584.675527] [106/133] (437s left) kms_addfb_basic (basic-y-tiled-legacy)
[584.725680] Starting subtest: basic-y-tiled-legacy
[584.729563] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[584.858318] [107/133] (437s left) gem_exec_balancer (noheartbeat)
[585.116789] Starting subtest: noheartbeat
[585.121910] Subtest noheartbeat: SKIP (0.001s)
[585.226649] [108/133] (436s left) gem_reg_read (timestamp-monotonic)
[585.282730] Starting subtest: timestamp-monotonic
[589.510760] Subtest timestamp-monotonic: SUCCESS (4.177s)
[589.548853] [109/133] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[589.654045] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[589.659295] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[589.756357] [110/133] (432s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[589.856329] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[589.882033] Starting dynamic subtest: pipe-A-plane-0
[590.525898] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[590.535794] Starting dynamic subtest: pipe-A-plane-3
[590.981427] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[592.131049] Starting dynamic subtest: pipe-B-plane-0
[592.756031] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[592.765990] Starting dynamic subtest: pipe-B-plane-3
[593.201667] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[593.511664] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.655s)
[594.304608] [111/133] (427s left) kms_plane_alpha_blend (alpha-opaque-fb)
[594.410577] Starting subtest: alpha-opaque-fb
[594.697843] Starting dynamic subtest: pipe-A-eDP-1
[595.375671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s)
[595.386689] Starting dynamic subtest: pipe-D-eDP-1
[596.729527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[596.732165] Subtest alpha-opaque-fb: SUCCESS (2.321s)
[597.607550] [112/133] (424s left) gem_mmap (short-mmap)
[597.678240] Subtest short-mmap: SKIP (0.000s)
[597.745314] [113/133] (424s left) gem_spin_batch (legacy-resubmit-new)
[597.806865] Starting subtest: legacy-resubmit-new
[597.809712] Starting dynamic subtest: default
[597.816999] Dynamic subtest default: SUCCESS (0.009s)
[597.829109] Starting dynamic subtest: render
[597.832069] Dynamic subtest render: SUCCESS (0.003s)
[597.842052] Starting dynamic subtest: bsd
[597.844668] Dynamic subtest bsd: SUCCESS (0.004s)
[597.854432] Starting dynamic subtest: bsd1
[597.856926] Dynamic subtest bsd1: SUCCESS (0.003s)
[597.868529] Starting dynamic subtest: bsd2
[597.871067] Dynamic subtest bsd2: SUCCESS (0.005s)
[597.880494] Starting dynamic subtest: blt
[597.883079] Dynamic subtest blt: SUCCESS (0.006s)
[597.892621] Starting dynamic subtest: vebox
[597.895066] Dynamic subtest vebox: SUCCESS (0.005s)
[597.897870] Subtest legacy-resubmit-new: SUCCESS (0.043s)
[599.687607] [114/133] (422s left) gem_ctx_param (invalid-get-ringsize)
[599.736720] Starting subtest: invalid-get-ringsize
[599.739689] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[599.832038] [115/133] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[599.937004] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[607.274075] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.341s)
[607.423670] [116/133] (415s left) gem_exec_reloc (basic-write-cpu-active)
[607.482869] Subtest basic-write-cpu-active: SKIP (0.000s)
[607.547415] [117/133] (414s left) kms_atomic (crtc-invalid-params)
[607.640693] Starting subtest: crtc-invalid-params
[607.643221] Starting dynamic subtest: pipe-A-eDP-1
[608.006515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[608.009354] Subtest crtc-invalid-params: SUCCESS (0.369s)
[608.832875] [118/133] (413s left) gem_exec_fence (submit-chain)
[609.018638] Starting subtest: submit-chain
[609.043334] Subtest submit-chain: SUCCESS (0.025s)
[610.677798] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[610.681821] [119/133] (411s left) gem_exec_reloc (basic-write-read-noreloc)
[610.744490] Subtest basic-write-read-noreloc: SKIP (0.000s)
[610.812885] [120/133] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[610.919335] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[618.308108] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.391s)
[618.423969] [121/133] (404s left) perf (non-zero-reason)
[618.559974] Starting subtest: non-zero-reason
[618.562787] Starting dynamic subtest: 0-rcs0
[624.015049] Dynamic subtest 0-rcs0: SUCCESS (5.401s)
[624.027664] Starting dynamic subtest: 1-vecs0
[627.918953] Dynamic subtest 1-vecs0: SUCCESS (3.905s)
[627.922051] Subtest non-zero-reason: SUCCESS (9.308s)
[627.965073] [122/133] (394s left) gem_basic (create-close)
[628.027347] Starting subtest: create-close
[628.032954] Subtest create-close: SUCCESS (0.000s)
[628.135156] [123/133] (394s left) gem_exec_schedule (smoketest)
[628.316910] Starting subtest: smoketest
[628.319479] Starting dynamic subtest: rcs0
[633.958125] Dynamic subtest rcs0: SUCCESS (5.527s)
[633.969997] Starting dynamic subtest: bcs0
[639.432281] Dynamic subtest bcs0: SUCCESS (5.519s)
[639.444474] Starting dynamic subtest: vcs0
[644.911412] Dynamic subtest vcs0: SUCCESS (5.497s)
[644.923606] Starting dynamic subtest: vcs1
[650.493805] Dynamic subtest vcs1: SUCCESS (5.512s)
[650.516061] Starting dynamic subtest: vecs0
[656.023163] Dynamic subtest vecs0: SUCCESS (5.524s)
[656.034735] Starting dynamic subtest: ccs0
[661.529168] Dynamic subtest ccs0: SUCCESS (5.510s)
[661.532225] Subtest smoketest: SUCCESS (33.099s)
[661.629774] [124/133] (361s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[661.689818] Starting subtest: single-wait-for-submit-available-signaled
[661.692751] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[661.791524] [125/133] (361s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[661.886635] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[661.889106] Starting dynamic subtest: pipe-A-eDP-1
[661.915520] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[661.929644] Starting dynamic subtest: pipe-B-eDP-1
[661.954947] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[661.965330] Starting dynamic subtest: pipe-C-eDP-1
[661.990683] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[661.999866] Starting dynamic subtest: pipe-D-eDP-1
[662.025993] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[662.031552] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[664.133792] [126/133] (358s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[664.232972] Starting subtest: fbc-indfb-scaledprimary
[667.239814] Subtest fbc-indfb-scaledprimary: SUCCESS (3.011s)
[668.422953] [127/133] (354s left) kms_flip (blocking-absolute-wf_vblank)
[668.516140] Starting subtest: blocking-absolute-wf_vblank
[668.519009] Starting dynamic subtest: A-eDP1
[677.306052] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[677.317613] Starting dynamic subtest: B-eDP1
[686.039738] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[686.052534] Starting dynamic subtest: C-eDP1
[694.762374] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[694.775056] Starting dynamic subtest: D-eDP1
[703.497294] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[703.500003] Subtest blocking-absolute-wf_vblank: SUCCESS (34.939s)
[704.692869] [128/133] (318s left) gem_tiled_wb
[704.821693] [129/133] (318s left) gem_exec_reloc (basic-wc-noreloc)
[704.873789] Subtest basic-wc-noreloc: SKIP (0.000s)
[704.940728] [130/133] (318s left) gem_exec_whisper (basic-queues-all)
[705.001198] Starting subtest: basic-queues-all
[714.945682] Subtest basic-queues-all: SUCCESS (9.941s)
[715.133674] [131/133] (308s left) perf_pmu (all-busy-check-all)
[715.178859] Starting subtest: all-busy-check-all
[716.641600] Subtest all-busy-check-all: SUCCESS (1.461s)
[716.749240] [132/133] (306s left) gem_render_copy (linear)
[716.809584] Starting subtest: linear
[716.811953] Starting dynamic subtest: smem
[716.854279] Dynamic subtest smem: SUCCESS (0.044s)
[716.857081] Subtest linear: SUCCESS (0.045s)
[717.047862] [133/133] (306s left) gem_exec_flush (basic-uc-pro-default)
[717.103609] Starting subtest: basic-uc-pro-default
[722.609918] Subtest basic-uc-pro-default: SUCCESS (5.467s)
[722.756540] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_param
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: i915_power
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_invalid_mode
results: parsing output: 7/ for test: kms_plane_lowres
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_pm_dc
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: syncobj_basic
results: parsing output: 27/ for test: sysfs_preempt_timeout
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: prime_busy
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: sw_sync
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: kms_pm_rpm
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: gem_exec_params
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: gem_create
results: parsing output: 58/ for test: kms_concurrent
results: parsing output: 59/ for test: gem_exec_nop
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_watchdog
results: parsing output: 69/ for test: kms_rotation_crc
results: parsing output: 70/ for test: gem_partial_pwrite_pread
results: parsing output: 71/ for test: device_reset
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_mmap
results: parsing output: 76/ for test: gem_close_race
results: parsing output: 77/ for test: gem_tiled_pread_pwrite
results: parsing output: 78/ for test: gem_pxp
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_dsc
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_selftest
results: parsing output: 85/ for test: kms_vrr
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: kms_color_pipeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_async
results: parsing output: 91/ for test: kms_cdclk
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: i915_module_load
results: parsing output: 96/ for test: gem_userptr_blits
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: gem_close
results: parsing output: 99/ for test: gem_mmap_offset
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: gem_reg_read
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: kms_plane_alpha_blend
results: parsing output: 111/ for test: gem_mmap
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_atomic
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: gem_basic
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_tiled_wb
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: gem_exec_flush
Done.