[81.690271] Initializing watchdogs
[81.690338]   /dev/watchdog0
[81.710750] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[81.722270] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[81.725869] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[81.728300] [001/133] (960s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[81.917923] Starting subtest: flip-vs-dpms-on-nop-interruptible
[81.922383] Starting dynamic subtest: A-DP3
[83.105232] Dynamic subtest A-DP3: SUCCESS (1.183s)
[83.119792] Starting dynamic subtest: B-DP3
[84.143643] Dynamic subtest B-DP3: SUCCESS (1.038s)
[84.152519] Starting dynamic subtest: C-DP3
[85.197592] Dynamic subtest C-DP3: SUCCESS (1.053s)
[85.209392] Starting dynamic subtest: D-DP3
[86.243734] Dynamic subtest D-DP3: SUCCESS (1.045s)
[86.245552] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.330s)
[86.567960] [002/133] (955s left) kms_joiner (invalid-modeset-big-joiner)
[86.752272] Starting subtest: invalid-modeset-big-joiner
[86.754007] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[86.840634] [003/133] (955s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[87.102341] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[87.247477] [004/133] (955s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[87.433207] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[87.483642] [005/133] (954s left) gem_exec_params (batch-first)
[87.565332] Starting subtest: batch-first
[87.599783] Subtest batch-first: SUCCESS (0.034s)
[87.763567] [006/133] (954s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[87.937947] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[87.938896] Starting dynamic subtest: pipe-A-DP-3
[87.947158] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[87.955113] Starting dynamic subtest: pipe-B-DP-3
[87.963279] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[87.971099] Starting dynamic subtest: pipe-C-DP-3
[87.979184] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[87.986913] Starting dynamic subtest: pipe-D-DP-3
[87.995227] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[87.997237] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[88.367940] [007/133] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[88.551458] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[88.553165] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[88.752581] [008/133] (953s left) i915_drm_fdinfo (virtual-idle)
[88.816462] Starting subtest: virtual-idle
[92.413293] Subtest virtual-idle: SUCCESS (3.596s)
[92.499434] [009/133] (950s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[92.675916] Starting subtest: plane-scaler-unity-scaling-with-rotation
[92.676731] Starting dynamic subtest: pipe-A
[93.068069] Dynamic subtest pipe-A: SUCCESS (0.392s)
[93.086071] Starting dynamic subtest: pipe-B
[93.547394] Dynamic subtest pipe-B: SUCCESS (0.479s)
[93.559540] Starting dynamic subtest: pipe-C
[94.009341] Dynamic subtest pipe-C: SUCCESS (0.462s)
[94.022437] Starting dynamic subtest: pipe-D
[94.488902] Dynamic subtest pipe-D: SUCCESS (0.479s)
[94.490299] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.814s)
[94.818231] [010/133] (948s left) perf_pmu (busy-check-all)
[94.881439] Starting subtest: busy-check-all
[94.882356] Starting dynamic subtest: rcs0
[95.464917] Dynamic subtest rcs0: SUCCESS (0.582s)
[95.476367] Starting dynamic subtest: bcs0
[96.020225] Dynamic subtest bcs0: SUCCESS (0.555s)
[96.030830] Starting dynamic subtest: vcs0
[96.572095] Dynamic subtest vcs0: SUCCESS (0.552s)
[96.582060] Starting dynamic subtest: vcs1
[97.124242] Dynamic subtest vcs1: SUCCESS (0.552s)
[97.134499] Starting dynamic subtest: vecs0
[97.676162] Dynamic subtest vecs0: SUCCESS (0.551s)
[97.686742] Starting dynamic subtest: vecs1
[98.229169] Dynamic subtest vecs1: SUCCESS (0.553s)
[98.239698] Starting dynamic subtest: ccs0
[98.783509] Dynamic subtest ccs0: SUCCESS (0.554s)
[98.784565] Subtest busy-check-all: SUCCESS (3.902s)
[98.899724] [011/133] (943s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[99.096394] Starting subtest: x-tiled-64bpp-rotate-180
[100.984145] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.888s)
[101.150958] [012/133] (941s left) gem_exec_params (no-blt)
[101.235452] Starting subtest: no-blt
[101.237531] Subtest no-blt: SUCCESS (0.002s)
[101.416970] [013/133] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[101.603480] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[101.605150] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[101.737878] [014/133] (941s left) kms_cursor_edge_walk (64x64-right-edge)
[101.916783] Starting subtest: 64x64-right-edge
[101.918572] Starting dynamic subtest: pipe-A-DP-3
[105.350560] Dynamic subtest pipe-A-DP-3: SUCCESS (3.433s)
[105.362229] Starting dynamic subtest: pipe-D-DP-3
[108.629215] Dynamic subtest pipe-D-DP-3: SUCCESS (3.276s)
[108.630330] Subtest 64x64-right-edge: SUCCESS (6.712s)
[108.889520] [015/133] (934s left) gem_mmap_gtt (hang)
[108.958990] Subtest hang: SKIP (0.000s)
[109.026429] [016/133] (934s left) kms_psr (fbc-psr-sprite-blt)
[109.207270] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[109.260028] [017/133] (934s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[109.433967] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[109.434921] Starting dynamic subtest: pipe-A-valid-mode
[111.876629] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.440s)
[111.878049] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.442s)
[112.125764] [018/133] (931s left) gem_pwrite (basic-exhaustion)
[112.196989] Subtest basic-exhaustion: SKIP (0.000s)
[112.273240] [019/133] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[112.453404] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[115.456963] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.003s)
[115.654990] [020/133] (927s left) kms_big_fb (linear-8bpp-rotate-270)
[115.844572] Starting subtest: linear-8bpp-rotate-270
[115.906847] Subtest linear-8bpp-rotate-270: SKIP (0.062s)
[116.089369] [021/133] (927s left) vgem_basic (second-client)
[116.189460] Starting subtest: second-client
[116.223999] Subtest second-client: SUCCESS (0.034s)
[116.358054] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[116.359848] [022/133] (927s left) gem_mmap (short-mmap)
[116.438053] Subtest short-mmap: SKIP (0.000s)
[116.518729] [023/133] (927s left) kms_hdr (bpc-switch-suspend)
[116.706782] Starting subtest: bpc-switch-suspend
[120.034788] Starting dynamic subtest: pipe-A-DP-3
[139.887213] Dynamic subtest pipe-A-DP-3: SUCCESS (4.715s)
[139.889219] Subtest bpc-switch-suspend: SUCCESS (8.044s)
[159.266625] [024/133] (903s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[159.470386] Starting subtest: stress-xrgb8888-xtiled
[168.070044] Subtest stress-xrgb8888-xtiled: SUCCESS (8.478s)
[168.352245] [025/133] (894s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[168.430862] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[168.431832] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[168.571069] [026/133] (894s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[168.761208] Starting subtest: plane-ctm3x4-lut1d
[168.977208] Starting dynamic subtest: pipe-A-plane-0
[169.177823] Dynamic subtest pipe-A-plane-0: SUCCESS (0.199s)
[169.220200] Starting dynamic subtest: pipe-A-plane-1
[169.377770] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[169.389060] Starting dynamic subtest: pipe-A-plane-2
[169.546795] Dynamic subtest pipe-A-plane-2: SUCCESS (0.167s)
[169.938927] Starting dynamic subtest: pipe-B-plane-0
[170.104155] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[170.141066] Starting dynamic subtest: pipe-B-plane-1
[170.304000] Dynamic subtest pipe-B-plane-1: SUCCESS (0.197s)
[170.315066] Starting dynamic subtest: pipe-B-plane-2
[170.473166] Dynamic subtest pipe-B-plane-2: SUCCESS (0.167s)
[170.857567] Starting dynamic subtest: pipe-C-plane-0
[171.023080] Dynamic subtest pipe-C-plane-0: SUCCESS (0.199s)
[171.060414] Starting dynamic subtest: pipe-C-plane-1
[171.240973] Dynamic subtest pipe-C-plane-1: SUCCESS (0.214s)
[171.258908] Starting dynamic subtest: pipe-C-plane-2
[171.406898] Dynamic subtest pipe-C-plane-2: SUCCESS (0.164s)
[171.734777] Starting dynamic subtest: pipe-D-plane-0
[171.909400] Dynamic subtest pipe-D-plane-0: SUCCESS (0.184s)
[171.945456] Starting dynamic subtest: pipe-D-plane-1
[172.126930] Dynamic subtest pipe-D-plane-1: SUCCESS (0.214s)
[172.162107] Starting dynamic subtest: pipe-D-plane-2
[172.344487] Dynamic subtest pipe-D-plane-2: SUCCESS (0.214s)
[172.436084] Subtest plane-ctm3x4-lut1d: SUCCESS (3.653s)
[172.692420] [027/133] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[172.885415] Starting subtest: addfb25-yf-tiled-legacy
[172.886229] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[173.016259] [028/133] (890s left) kms_chamelium_edid (dp-mode-timings)
[173.290473] Subtest dp-mode-timings: SKIP (0.000s)
[173.442800] [029/133] (889s left) gem_lmem_swapping (parallel-random-verify-ccs)
[175.942528] Starting subtest: parallel-random-verify-ccs
[175.943472] Starting dynamic subtest: lmem0
[239.435566] Dynamic subtest lmem0: SUCCESS (63.472s)
[239.436840] Subtest parallel-random-verify-ccs: SUCCESS (63.472s)
[240.399661] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[240.400601] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[240.402299] [030/133] (822s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[242.063542] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[242.064489] Starting dynamic subtest: pipe-A-DP-3
[242.067874] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[242.078080] Starting dynamic subtest: pipe-B-DP-3
[242.081671] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[242.091749] Starting dynamic subtest: pipe-C-DP-3
[242.095107] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[242.105977] Starting dynamic subtest: pipe-D-DP-3
[242.109479] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[242.111119] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[242.555546] [FACT kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[242.558149] [FACT kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[242.560550] [031/133] (820s left) gem_exec_balancer (busy)
[242.655498] Starting subtest: busy
[243.589946] Subtest busy: SUCCESS (0.934s)
[244.048518] [032/133] (819s left) kms_cursor_crc (cursor-onscreen-64x21)
[244.403040] Starting subtest: cursor-onscreen-64x21
[244.407227] Starting dynamic subtest: pipe-A-DP-3
[247.137701] Dynamic subtest pipe-A-DP-3: SUCCESS (2.729s)
[247.182090] Starting dynamic subtest: pipe-D-DP-3
[249.827324] Dynamic subtest pipe-D-DP-3: SUCCESS (2.654s)
[249.828226] Subtest cursor-onscreen-64x21: SUCCESS (5.423s)
[250.257967] [033/133] (813s left) kms_plane_multiple (2x-tiling-yf)
[250.445870] Starting subtest: 2x-tiling-yf
[250.453440] Subtest 2x-tiling-yf: SKIP (0.000s)
[250.540481] [034/133] (812s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[250.622074] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[250.727381] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[250.873214] [035/133] (812s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[251.066327] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[253.112293] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.046s)
[253.330014] [036/133] (810s left) gem_mmap_wc (coherency)
[253.409633] Subtest coherency: SKIP (0.000s)
[253.490171] [037/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[253.683651] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[253.685506] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[253.846606] [038/133] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[254.037492] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[254.039125] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[254.182837] [039/133] (809s left) gem_eio (wait-wedge-10ms)
[254.472912] Starting subtest: wait-wedge-10ms
[256.032176] Subtest wait-wedge-10ms: SUCCESS (1.560s)
[256.311401] [040/133] (807s left) perf_pmu (semaphore-busy)
[256.385798] Starting subtest: semaphore-busy
[256.386787] Starting dynamic subtest: rcs0
[258.067197] Dynamic subtest rcs0: SUCCESS (1.682s)
[258.085102] Starting dynamic subtest: bcs0
[259.701775] Dynamic subtest bcs0: SUCCESS (1.629s)
[259.716256] Starting dynamic subtest: vcs0
[261.331670] Dynamic subtest vcs0: SUCCESS (1.627s)
[261.345874] Starting dynamic subtest: vcs1
[262.961557] Dynamic subtest vcs1: SUCCESS (1.627s)
[262.976013] Starting dynamic subtest: vecs0
[264.593597] Dynamic subtest vecs0: SUCCESS (1.629s)
[264.609440] Starting dynamic subtest: vecs1
[266.239849] Dynamic subtest vecs1: SUCCESS (1.643s)
[266.256430] Starting dynamic subtest: ccs0
[267.888877] Dynamic subtest ccs0: SUCCESS (1.646s)
[267.890742] Subtest semaphore-busy: SUCCESS (11.504s)
[268.083351] [041/133] (795s left) gem_exec_whisper (basic-contexts-all)
[268.176124] Starting subtest: basic-contexts-all
[290.204035] Subtest basic-contexts-all: SUCCESS (22.024s)
[290.424780] [042/133] (773s left) gem_pxp (reject-modify-context-protection-on)
[293.031486] Starting subtest: reject-modify-context-protection-on
[293.033563] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[293.135833] [043/133] (770s left) gem_exec_params (sol-reset-not-gen7)
[293.220266] Starting subtest: sol-reset-not-gen7
[293.222349] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[293.374361] [044/133] (770s left) kms_pm_rpm (pm-caching)
[295.190590] Starting subtest: pm-caching
[295.194354] Subtest pm-caching: SKIP (0.000s)
[295.510791] [045/133] (768s left) api_intel_bb (bb-with-allocator)
[295.590794] Starting subtest: bb-with-allocator
[295.621585] Subtest bb-with-allocator: SUCCESS (0.031s)
[295.783151] [046/133] (768s left) gem_exec_reloc (basic-concurrent16)
[295.871872] Subtest basic-concurrent16: SKIP (0.000s)
[295.970194] [047/133] (768s left) gem_exec_whisper (basic-queues-priority)
[296.061127] Starting subtest: basic-queues-priority
[318.427828] Subtest basic-queues-priority: SUCCESS (22.360s)
[318.682495] [048/133] (745s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[318.868781] Starting subtest: flip-vs-cursor-busy-crc-legacy
[319.624190] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.755s)
[319.912589] [049/133] (744s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[320.113982] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[321.414784] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.300s)
[321.601389] [050/133] (743s left) kms_big_fb (yf-tiled-addfb)
[321.795903] Starting subtest: yf-tiled-addfb
[321.797657] Subtest yf-tiled-addfb: SKIP (0.000s)
[322.008346] [051/133] (742s left) vgem_basic (bad-handle)
[322.065772] Starting subtest: bad-handle
[322.066999] Subtest bad-handle: SUCCESS (0.000s)
[322.167693] [052/133] (742s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[322.353748] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[322.410389] [053/133] (742s left) drm_read (short-buffer-wakeup)
[322.664610] Starting subtest: short-buffer-wakeup
[354.886663] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[355.140415] [054/133] (709s left) kms_pm_rpm (basic-pci-d3-state)
[357.152455] Starting subtest: basic-pci-d3-state
[357.702132] Subtest basic-pci-d3-state: SUCCESS (0.550s)
[357.953377] [055/133] (707s left) kms_plane (pixel-format-4-tiled-modifier)
[358.145845] Starting subtest: pixel-format-4-tiled-modifier
[358.166853] Starting dynamic subtest: pipe-A-plane-0
[359.267261] Dynamic subtest pipe-A-plane-0: SUCCESS (1.100s)
[359.310611] Starting dynamic subtest: pipe-A-plane-3
[359.917515] Dynamic subtest pipe-A-plane-3: SUCCESS (0.648s)
[359.958976] Starting dynamic subtest: pipe-A-plane-5
[359.961176] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[360.153088] Starting dynamic subtest: pipe-B-plane-0
[361.098213] Dynamic subtest pipe-B-plane-0: SUCCESS (0.966s)
[361.115131] Starting dynamic subtest: pipe-B-plane-3
[361.749040] Dynamic subtest pipe-B-plane-3: SUCCESS (0.649s)
[361.765155] Starting dynamic subtest: pipe-B-plane-5
[361.766936] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[361.839675] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.693s)
[362.169329] [056/133] (702s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[362.360697] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[362.362500] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[362.522901] [057/133] (702s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[362.709983] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[362.710913] Starting dynamic subtest: pipe-A-DP-3
[362.719302] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[362.731975] Starting dynamic subtest: pipe-B-DP-3
[362.740411] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[362.752745] Starting dynamic subtest: pipe-C-DP-3
[362.760875] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[362.773280] Starting dynamic subtest: pipe-D-DP-3
[362.783365] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[362.785255] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[363.203716] [058/133] (702s left) gem_ctx_isolation (preservation)
[363.292995] Starting subtest: preservation
[363.293963] Starting dynamic subtest: rcs0
[363.701077] Dynamic subtest rcs0: SUCCESS (0.401s)
[363.714786] Starting dynamic subtest: bcs0
[364.152124] Dynamic subtest bcs0: SUCCESS (0.450s)
[364.164879] Starting dynamic subtest: vcs0
[364.592840] Dynamic subtest vcs0: SUCCESS (0.447s)
[364.607154] Starting dynamic subtest: vcs1
[365.016451] Dynamic subtest vcs1: SUCCESS (0.415s)
[365.029022] Starting dynamic subtest: vecs0
[365.443849] Dynamic subtest vecs0: SUCCESS (0.432s)
[365.456313] Starting dynamic subtest: vecs1
[365.871871] Dynamic subtest vecs1: SUCCESS (0.428s)
[365.884721] Starting dynamic subtest: ccs0
[366.298138] Dynamic subtest ccs0: SUCCESS (0.425s)
[366.299047] Subtest preservation: SUCCESS (3.005s)
[366.565934] [059/133] (698s left) kms_selftest (drm_plane_helper)
[366.618855] Starting subtest: drm_plane_helper
[366.657025] Starting dynamic subtest: drm_test_check_plane_state
[366.730308] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.074s)
[366.763557] Starting dynamic subtest: drm_test_check_invalid_plane_state
[366.798110] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.066s)
[366.799197] Subtest drm_plane_helper: SUCCESS (0.179s)
[366.985417] [060/133] (698s left) gem_exec_reloc (basic-write-cpu-noreloc)
[367.070165] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[367.146660] [061/133] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[367.338350] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[367.339922] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[367.532411] [062/133] (698s left) gen7_exec_parse (basic-rejected)
[367.618007] Subtest basic-rejected: SKIP (0.000s)
[367.679714] [063/133] (697s left) gem_spin_batch (resubmit-new-all)
[367.774997] Starting subtest: resubmit-new-all
[367.775979] Starting dynamic subtest: rcs0
[367.813786] Dynamic subtest rcs0: SUCCESS (0.038s)
[367.826316] Starting dynamic subtest: bcs0
[367.827216] Dynamic subtest bcs0: SUCCESS (0.008s)
[367.839687] Starting dynamic subtest: vcs0
[367.840569] Dynamic subtest vcs0: SUCCESS (0.010s)
[367.853418] Starting dynamic subtest: vcs1
[367.854327] Dynamic subtest vcs1: SUCCESS (0.009s)
[367.867052] Starting dynamic subtest: vecs0
[367.867913] Dynamic subtest vecs0: SUCCESS (0.008s)
[367.880223] Starting dynamic subtest: vecs1
[367.881400] Dynamic subtest vecs1: SUCCESS (0.011s)
[367.893913] Starting dynamic subtest: ccs0
[367.895141] Dynamic subtest ccs0: SUCCESS (0.008s)
[367.896195] Subtest resubmit-new-all: SUCCESS (0.099s)
[368.204996] [064/133] (697s left) kms_lease (lease-revoke)
[368.392824] Starting subtest: lease-revoke
[368.393769] Starting dynamic subtest: pipe-A-DP-3
[368.491334] Dynamic subtest pipe-A-DP-3: SUCCESS (0.099s)
[368.505556] Starting dynamic subtest: pipe-B-DP-3
[368.567988] Dynamic subtest pipe-B-DP-3: SUCCESS (0.074s)
[368.581044] Starting dynamic subtest: pipe-C-DP-3
[368.638137] Dynamic subtest pipe-C-DP-3: SUCCESS (0.070s)
[368.651942] Starting dynamic subtest: pipe-D-DP-3
[368.707974] Dynamic subtest pipe-D-DP-3: SUCCESS (0.068s)
[368.708911] Subtest lease-revoke: SUCCESS (0.317s)
[368.884759] [065/133] (696s left) kms_flip (2x-flip-vs-modeset)
[369.068510] Starting subtest: 2x-flip-vs-modeset
[369.083680] Subtest 2x-flip-vs-modeset: SKIP (0.014s)
[369.192562] [066/133] (696s left) tools_test (sysfs_l3_parity)
[369.246464] Starting subtest: sysfs_l3_parity
[369.320015] Subtest sysfs_l3_parity: SKIP (0.077s)
[369.425232] [067/133] (696s left) gem_eio (in-flight-internal-10ms)
[369.735069] Starting subtest: in-flight-internal-10ms
[371.039504] Subtest in-flight-internal-10ms: SUCCESS (1.305s)
[371.264734] [068/133] (694s left) kms_cursor_crc (cursor-random-512x170)
[371.759749] Starting subtest: cursor-random-512x170
[371.761541] Subtest cursor-random-512x170: SKIP (0.001s)
[371.973585] [069/133] (694s left) gem_wait (write-wait)
[372.077062] Starting subtest: write-wait
[372.078130] Starting dynamic subtest: all-engines
[373.211566] Dynamic subtest all-engines: SUCCESS (1.135s)
[373.228379] Starting dynamic subtest: rcs0
[374.271455] Dynamic subtest rcs0: SUCCESS (1.056s)
[374.290209] Starting dynamic subtest: bcs0
[375.334499] Dynamic subtest bcs0: SUCCESS (1.058s)
[375.351989] Starting dynamic subtest: vcs0
[376.394004] Dynamic subtest vcs0: SUCCESS (1.055s)
[376.413182] Starting dynamic subtest: vcs1
[377.456250] Dynamic subtest vcs1: SUCCESS (1.058s)
[377.479004] Starting dynamic subtest: vecs0
[378.521649] Dynamic subtest vecs0: SUCCESS (1.060s)
[378.538703] Starting dynamic subtest: vecs1
[379.581341] Dynamic subtest vecs1: SUCCESS (1.055s)
[379.602852] Starting dynamic subtest: ccs0
[380.646348] Dynamic subtest ccs0: SUCCESS (1.060s)
[380.652301] Subtest write-wait: SUCCESS (8.570s)
[380.979892] [070/133] (685s left) kms_flip (dpms-off-confusion)
[381.167031] Starting subtest: dpms-off-confusion
[381.171801] Starting dynamic subtest: A-DP3
[389.052412] Dynamic subtest A-DP3: SUCCESS (7.882s)
[389.067821] Starting dynamic subtest: B-DP3
[396.838657] Dynamic subtest B-DP3: SUCCESS (7.787s)
[396.853341] Starting dynamic subtest: C-DP3
[404.630948] Dynamic subtest C-DP3: SUCCESS (7.793s)
[404.646217] Starting dynamic subtest: D-DP3
[412.416204] Dynamic subtest D-DP3: SUCCESS (7.785s)
[412.418595] Subtest dpms-off-confusion: SUCCESS (31.258s)
[412.739208] [071/133] (653s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[412.925897] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[412.926839] Starting dynamic subtest: pipe-A-DP-3
[412.935141] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[412.948049] Starting dynamic subtest: pipe-B-DP-3
[412.956746] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[412.969482] Starting dynamic subtest: pipe-C-DP-3
[412.977607] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[412.990505] Starting dynamic subtest: pipe-D-DP-3
[413.001161] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[413.003164] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[413.380059] [072/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[413.571789] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[413.573577] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[413.689774] [073/133] (652s left) gem_ctx_persistence (heartbeat-many)
[413.776411] Starting subtest: heartbeat-many
[413.778598] Subtest heartbeat-many: SKIP (0.000s)
[413.981475] [074/133] (652s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[416.210477] Starting subtest: gem-execbuf-stress-pc8
[416.306893] Subtest gem-execbuf-stress-pc8: SKIP (0.096s)
[416.603509] [075/133] (649s left) gem_exec_fence (basic-wait)
[416.809677] Starting subtest: basic-wait
[416.810788] Starting dynamic subtest: rcs0
[416.922603] Dynamic subtest rcs0: SUCCESS (0.112s)
[416.939906] Starting dynamic subtest: bcs0
[416.977457] Dynamic subtest bcs0: SUCCESS (0.053s)
[417.002287] Starting dynamic subtest: vcs0
[417.029681] Dynamic subtest vcs0: SUCCESS (0.051s)
[417.063066] Starting dynamic subtest: vcs1
[417.082988] Dynamic subtest vcs1: SUCCESS (0.051s)
[417.103795] Starting dynamic subtest: vecs0
[417.135934] Dynamic subtest vecs0: SUCCESS (0.051s)
[417.158151] Starting dynamic subtest: vecs1
[417.193322] Dynamic subtest vecs1: SUCCESS (0.056s)
[417.229936] Starting dynamic subtest: ccs0
[417.251824] Dynamic subtest ccs0: SUCCESS (0.056s)
[417.252848] Subtest basic-wait: SUCCESS (0.443s)
[417.971519] [076/133] (648s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[418.162867] Starting subtest: 2x-cursor-vs-flip-atomic
[418.165878] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[418.283832] [077/133] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[418.481780] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[418.483518] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[418.595933] [078/133] (648s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[418.683847] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[418.745798] [079/133] (648s left) gen9_exec_parse (unaligned-access)
[418.838781] Subtest unaligned-access: SKIP (0.000s)
[418.932248] [080/133] (647s left) kms_properties (invalid-properties-atomic)
[419.120913] Starting subtest: invalid-properties-atomic
[419.625905] Subtest invalid-properties-atomic: SUCCESS (0.506s)
[419.716539] [081/133] (647s left) gem_ctx_shared (q-in-order)
[419.810041] Starting subtest: Q-in-order
[419.810928] Starting dynamic subtest: rcs0
[420.086869] Dynamic subtest rcs0: SUCCESS (0.277s)
[420.101979] Starting dynamic subtest: bcs0
[420.274992] Dynamic subtest bcs0: SUCCESS (0.187s)
[420.290257] Starting dynamic subtest: vcs0
[420.476423] Dynamic subtest vcs0: SUCCESS (0.200s)
[420.490531] Starting dynamic subtest: vcs1
[420.673717] Dynamic subtest vcs1: SUCCESS (0.196s)
[420.688947] Starting dynamic subtest: vecs0
[420.872040] Dynamic subtest vecs0: SUCCESS (0.197s)
[420.887220] Starting dynamic subtest: vecs1
[421.091546] Dynamic subtest vecs1: SUCCESS (0.218s)
[421.106176] Starting dynamic subtest: ccs0
[421.292225] Dynamic subtest ccs0: SUCCESS (0.199s)
[421.293108] Subtest Q-in-order: SUCCESS (1.484s)
[421.631320] [082/133] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[421.823776] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[421.825569] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[421.988187] [083/133] (645s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[422.176137] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[422.178332] Starting dynamic subtest: pipe-A-DP-3
[422.187436] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[422.200590] Starting dynamic subtest: pipe-B-DP-3
[422.209807] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[422.222650] Starting dynamic subtest: pipe-C-DP-3
[422.231633] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[422.244753] Starting dynamic subtest: pipe-D-DP-3
[422.256757] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[422.259082] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[422.607690] [084/133] (644s left) kms_feature_discovery (chamelium)
[422.800376] Starting subtest: chamelium
[422.802084] Subtest chamelium: SKIP (0.000s)
[422.892492] [085/133] (644s left) gem_ctx_engines (none)
[422.983196] Starting subtest: none
[422.985884] Subtest none: SUCCESS (0.003s)
[423.245523] [086/133] (644s left) kms_flip (dpms-vs-vblank-race-interruptible)
[423.437536] Starting subtest: dpms-vs-vblank-race-interruptible
[423.442338] Starting dynamic subtest: A-DP3
[426.657582] Dynamic subtest A-DP3: SUCCESS (3.214s)
[426.677317] Starting dynamic subtest: B-DP3
[429.662695] Dynamic subtest B-DP3: SUCCESS (3.003s)
[429.678652] Starting dynamic subtest: C-DP3
[432.645623] Dynamic subtest C-DP3: SUCCESS (2.982s)
[432.658727] Starting dynamic subtest: D-DP3
[435.743974] Dynamic subtest D-DP3: SUCCESS (3.095s)
[435.747507] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.310s)
[436.067602] [087/133] (631s left) api_intel_bb (simple-bb-ctx)
[436.148142] Starting subtest: simple-bb-ctx
[436.184363] Subtest simple-bb-ctx: SUCCESS (0.036s)
[436.382510] [088/133] (631s left) gem_fenced_exec_thrash (too-many-fences)
[436.466070] Subtest too-many-fences: SKIP (0.000s)
[436.541001] [089/133] (631s left) gem_exec_schedule (semaphore-resolve)
[436.636081] Starting subtest: semaphore-resolve
[436.722366] Subtest semaphore-resolve: SUCCESS (0.086s)
[437.110737] [090/133] (630s left) kms_psr (pr-no-drrs)
[437.298292] Subtest pr-no-drrs: SKIP (0.000s)
[437.358235] [091/133] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[437.553724] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[437.555447] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[437.677874] [092/133] (630s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[437.869725] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[437.940140] [093/133] (629s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[438.553434] Starting subtest: syncobj-stationary-timeline-chain-engines
[438.722426] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.170s)
[439.016150] [094/133] (628s left) kms_dp_link_training (non-uhbr-mst)
[439.204044] Starting subtest: non-uhbr-mst
[439.207547] Subtest non-uhbr-mst: SKIP (0.000s)
[439.332955] [095/133] (628s left) gem_userptr_blits (create-destroy-sync)
[439.427408] Starting subtest: create-destroy-sync
[444.447516] Subtest create-destroy-sync: SUCCESS (5.020s)
[444.642800] [096/133] (623s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[444.720105] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[444.721038] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[444.906894] [097/133] (623s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[445.102365] Starting subtest: 2x-plain-flip-ts-check-interruptible
[445.117843] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.015s)
[445.275514] [098/133] (622s left) kms_psr (psr2-primary-blt)
[445.458598] Subtest psr2-primary-blt: SKIP (0.000s)
[445.525505] [099/133] (622s left) i915_pm_rps (waitboost)
[445.612954] Starting subtest: waitboost
[449.244900] Subtest waitboost: SUCCESS (3.632s)
[449.413748] [100/133] (618s left) perf_pmu (rc6)
[449.486093] Starting subtest: rc6
[449.487039] Starting dynamic subtest: gt0
[455.839785] Dynamic subtest gt0: SUCCESS (6.351s)
[455.856105] Starting dynamic subtest: runtime-pm-gt0
[463.876263] Dynamic subtest runtime-pm-gt0: SUCCESS (8.032s)
[463.890004] Starting dynamic subtest: runtime-pm-long-gt0
[476.486693] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.607s)
[476.501572] Starting dynamic subtest: other-idle-gt0
[476.503417] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[476.504210] Subtest rc6: SUCCESS (27.001s)
[477.272516] [101/133] (591s left) sw_sync (timeline_closed_signaled)
[477.323105] Starting subtest: timeline_closed_signaled
[477.324013] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[477.373599] [102/133] (591s left) kms_atomic (test-only)
[477.556192] Starting subtest: test-only
[478.023596] Starting dynamic subtest: pipe-A-DP-3
[478.931549] Dynamic subtest pipe-A-DP-3: SUCCESS (0.908s)
[478.932599] Subtest test-only: SUCCESS (1.376s)
[479.143627] [103/133] (589s left) kms_psr (fbc-pr-sprite-plane-onoff)
[479.329937] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[479.400668] [104/133] (589s left) gem_fence_thrash (bo-write-verify-x)
[479.455836] Starting subtest: bo-write-verify-x
[479.485849] Subtest bo-write-verify-x: SKIP (0.029s)
[479.567845] [105/133] (589s left) perf_pmu (busy-hang)
[479.639799] Starting subtest: busy-hang
[479.640763] Starting dynamic subtest: rcs0
[480.950216] Dynamic subtest rcs0: SUCCESS (1.307s)
[480.966116] Starting dynamic subtest: bcs0
[482.188323] Dynamic subtest bcs0: SUCCESS (1.237s)
[482.204510] Starting dynamic subtest: vcs0
[483.434667] Dynamic subtest vcs0: SUCCESS (1.240s)
[483.447936] Starting dynamic subtest: vcs1
[484.678967] Dynamic subtest vcs1: SUCCESS (1.242s)
[484.695670] Starting dynamic subtest: vecs0
[485.921377] Dynamic subtest vecs0: SUCCESS (1.242s)
[485.938271] Starting dynamic subtest: vecs1
[487.162583] Dynamic subtest vecs1: SUCCESS (1.239s)
[487.179549] Starting dynamic subtest: ccs0
[488.397193] Dynamic subtest ccs0: SUCCESS (1.231s)
[488.398493] Subtest busy-hang: SUCCESS (8.755s)
[488.504488] [106/133] (580s left) gem_exec_suspend (basic)
[488.598299] Starting subtest: basic
[488.599206] Starting dynamic subtest: smem
[489.780260] Dynamic subtest smem: SUCCESS (1.181s)
[489.795818] Starting dynamic subtest: lmem0
[490.910270] Dynamic subtest lmem0: SUCCESS (1.129s)
[490.911185] Subtest basic: SUCCESS (2.312s)
[491.148876] [107/133] (577s left) sw_sync (alloc_fence)
[491.198016] Starting subtest: alloc_fence
[491.198907] Subtest alloc_fence: SUCCESS (0.000s)
[491.298233] [108/133] (577s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[491.488641] Starting subtest: psr-rgb101010-draw-pwrite
[491.490392] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[491.573012] [109/133] (577s left) testdisplay
[510.685922] [110/133] (558s left) gem_eio (wait-immediate)
[511.078287] Starting subtest: wait-immediate
[511.757531] Subtest wait-immediate: SUCCESS (0.680s)
[511.932604] [111/133] (557s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[512.126499] Starting subtest: psr-1p-pri-indfb-multidraw
[512.128234] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[512.200027] [112/133] (556s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[512.281011] Starting subtest: invalid-multi-wait-unsubmitted
[512.281937] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[512.370090] [113/133] (556s left) gem_ccs (block-copy-compressed)
[512.457479] Starting subtest: block-copy-compressed
[512.459811] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[512.504622] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.046s)
[512.519865] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[512.623056] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.117s)
[512.638141] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[512.641132] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[512.656357] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[512.759260] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.117s)
[512.774373] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[512.777345] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[512.792519] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[512.895079] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.117s)
[512.910241] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[512.914762] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[512.929856] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[513.032090] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.116s)
[513.033001] Subtest block-copy-compressed: SUCCESS (0.575s)
[513.150576] [114/133] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[513.344788] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[516.282808] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.938s)
[516.471494] [115/133] (552s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[516.670874] Starting subtest: y-tiled-8bpp-rotate-270
[516.672745] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[516.776504] [116/133] (552s left) syncobj_timeline (single-wait-all-signaled)
[516.857183] Starting subtest: single-wait-all-signaled
[516.858107] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[516.964543] [117/133] (552s left) kms_addfb_basic (invalid-get-prop)
[517.047164] Starting subtest: invalid-get-prop
[517.048062] Subtest invalid-get-prop: SUCCESS (0.000s)
[517.233417] [118/133] (552s left) gem_render_copy (y-tiled-to-vebox-linear)
[517.319790] Starting subtest: y-tiled-to-vebox-linear
[517.321834] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[517.527167] [119/133] (552s left) kms_busy (extended-pageflip-hang-oldfb)
[517.723950] Starting subtest: extended-pageflip-hang-oldfb
[517.724840] Starting dynamic subtest: pipe-A
[517.964853] Dynamic subtest pipe-A: SUCCESS (0.239s)
[517.995440] Starting dynamic subtest: pipe-D
[518.221569] Dynamic subtest pipe-D: SUCCESS (0.248s)
[518.222575] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.499s)
[518.438421] [120/133] (551s left) kms_vblank (ts-continuation-idle-hang)
[518.624036] Starting subtest: ts-continuation-idle-hang
[518.624916] Starting dynamic subtest: pipe-A-DP-3
[544.739260] Dynamic subtest pipe-A-DP-3: SUCCESS (26.109s)
[544.755973] Starting dynamic subtest: pipe-D-DP-3
[569.685163] Dynamic subtest pipe-D-DP-3: SUCCESS (24.938s)
[569.686045] Subtest ts-continuation-idle-hang: SUCCESS (51.054s)
[569.875859] [121/133] (499s left) kms_scaling_modes (scaling-mode-full)
[570.063346] Starting subtest: scaling-mode-full
[570.068524] Subtest scaling-mode-full: SKIP (0.001s)
[570.130397] [122/133] (499s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[570.208261] Starting subtest: etime-single-wait-for-submit-unsubmitted
[570.311126] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[570.416720] [123/133] (499s left) kms_content_protection (dp-mst-type-0)
[570.666376] Starting subtest: dp-mst-type-0
[570.668085] Subtest dp-mst-type-0: SKIP (0.000s)
[570.777817] [124/133] (499s left) gem_exec_schedule (preempt-hang)
[570.978907] Starting subtest: preempt-hang
[570.979835] Starting dynamic subtest: rcs0
[571.338674] Dynamic subtest rcs0: SUCCESS (0.359s)
[571.352741] Starting dynamic subtest: bcs0
[571.690613] Dynamic subtest bcs0: SUCCESS (0.351s)
[571.704833] Starting dynamic subtest: vcs0
[572.043079] Dynamic subtest vcs0: SUCCESS (0.351s)
[572.057181] Starting dynamic subtest: vcs1
[572.403976] Dynamic subtest vcs1: SUCCESS (0.360s)
[572.418105] Starting dynamic subtest: vecs0
[572.761698] Dynamic subtest vecs0: SUCCESS (0.357s)
[572.775940] Starting dynamic subtest: vecs1
[573.108939] Dynamic subtest vecs1: SUCCESS (0.346s)
[573.122774] Starting dynamic subtest: ccs0
[573.448047] Dynamic subtest ccs0: SUCCESS (0.338s)
[573.448936] Subtest preempt-hang: SUCCESS (2.469s)
[573.681824] [125/133] (496s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[573.873602] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[573.875309] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[573.948420] [126/133] (496s left) gem_sync (basic-many-each)
[574.052863] Starting subtest: basic-many-each
[576.522135] Subtest basic-many-each: SUCCESS (2.469s)
[576.780193] [127/133] (493s left) gem_userptr_blits (coherency-unsync)
[576.866499] Subtest coherency-unsync: SKIP (0.000s)
[576.982504] [128/133] (493s left) syncobj_wait (multi-wait-all-signaled)
[577.061047] Starting subtest: multi-wait-all-signaled
[577.062049] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[577.154394] [129/133] (493s left) syncobj_wait (invalid-signal-one-illegal-handle)
[577.235030] Starting subtest: invalid-signal-one-illegal-handle
[577.236008] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[577.316301] [130/133] (492s left) gem_mmap_offset (clear)
[577.395193] Starting subtest: clear
[577.396079] Starting dynamic subtest: lmem0
[605.410143] Dynamic subtest lmem0: SUCCESS (28.002s)
[605.437798] Starting dynamic subtest: smem0
[630.475078] Dynamic subtest smem0: SUCCESS (25.064s)
[630.477300] Subtest clear: SUCCESS (53.069s)
[630.767347] [131/133] (439s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[631.020598] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[631.022292] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[631.176365] [132/133] (439s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[631.409212] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[631.410119] Starting dynamic subtest: pipe-A
[631.492594] Dynamic subtest pipe-A: SUCCESS (0.083s)
[631.511923] Starting dynamic subtest: pipe-B
[631.689261] Dynamic subtest pipe-B: SUCCESS (0.196s)
[631.712648] Starting dynamic subtest: pipe-C
[631.917918] Dynamic subtest pipe-C: SUCCESS (0.227s)
[631.937565] Starting dynamic subtest: pipe-D
[632.114551] Dynamic subtest pipe-D: SUCCESS (0.195s)
[632.115612] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.706s)
[632.367549] [133/133] (438s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[632.570035] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[633.311354] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.740s)
[633.481728] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_joiner
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_pwrite
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: vgem_basic
results: parsing output: 21/ for test: gem_mmap
results: parsing output: 22/ for test: kms_hdr
results: parsing output: 23/ for test: kms_pipe_stress
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_color_pipeline
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_chamelium_edid
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: drm_read
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: kms_selftest
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: tools_test
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: gem_wait
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: i915_pm_rpm
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pipe_b_c_ivb
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_feature_discovery
results: parsing output: 84/ for test: gem_ctx_engines
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_dp_link_training
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_suspend
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: testdisplay
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_scaling_modes
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_sync
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_big_fb
Done.