[68.013888] Initializing watchdogs
[68.013931]   /dev/watchdog0
[68.027783] [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]
[68.032000] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.038078] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.041235] [001/131] (960s left) gem_partial_pwrite_pread (write-snoop)
[68.123713] Subtest write-snoop: SKIP (0.000s)
[68.194197] [002/131] (960s left) kms_lease (simple-lease)
[68.281832] Starting subtest: simple-lease
[68.284161] Starting dynamic subtest: pipe-A-eDP-1
[68.830418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[68.839050] Starting dynamic subtest: pipe-B-eDP-1
[70.326583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[70.333443] Starting dynamic subtest: pipe-C-eDP-1
[71.729367] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[71.737978] Starting dynamic subtest: pipe-D-eDP-1
[73.143451] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.415s)
[73.145712] Subtest simple-lease: SUCCESS (4.867s)
[73.958352] [003/131] (954s left) syncobj_timeline (device-signal-unordered)
[74.020237] Starting subtest: device-signal-unordered
[74.022682] Subtest device-signal-unordered: SUCCESS (0.001s)
[74.155607] [004/131] (954s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[74.256633] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[75.046909] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[75.240613] [005/131] (953s left) syncobj_wait (reset-signaled)
[75.299435] Starting subtest: reset-signaled
[75.301598] Subtest reset-signaled: SUCCESS (0.000s)
[75.395318] [006/131] (953s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[75.485068] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[75.487315] Starting dynamic subtest: pipe-A-eDP-1
[75.511092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.518451] Starting dynamic subtest: pipe-B-eDP-1
[75.539602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.546315] Starting dynamic subtest: pipe-C-eDP-1
[75.568140] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.574865] Starting dynamic subtest: pipe-D-eDP-1
[75.597089] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.601560] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[77.803376] [007/131] (951s left) gem_render_copy_redux (normal)
[77.862217] Starting subtest: normal
[78.117462] Subtest normal: SUCCESS (0.255s)
[78.229605] [008/131] (950s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[78.330232] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[78.334649] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[78.399725] [009/131] (950s left) kms_dp_linktrain_fallback (dsc-fallback)
[78.497800] Starting subtest: dsc-fallback
[78.504386] Subtest dsc-fallback: SKIP (0.000s)
[78.578542] [010/131] (950s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[78.631946] Starting subtest: invalid-single-wait-all-unsubmitted
[78.634248] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[78.739669] [011/131] (950s left) gem_lmem_swapping (basic)
[78.778294] Subtest basic: SKIP (0.000s)
[78.821663] [012/131] (950s left) kms_psr (fbc-psr-cursor-plane-move)
[78.909107] Starting subtest: fbc-psr-cursor-plane-move
[78.911094] Starting dynamic subtest: eDP-1
[78.914773] Dynamic subtest eDP-1: SKIP (0.000s)
[78.918499] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[78.980956] [013/131] (950s left) gem_eio (in-flight-external)
[79.185383] Starting subtest: in-flight-external
[80.957531] Subtest in-flight-external: SUCCESS (1.772s)
[81.098480] [014/131] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[81.204397] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[81.209047] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[81.302893] [015/131] (947s left) gem_create (create-invalid-size)
[81.363022] Starting subtest: create-invalid-size
[81.365354] Subtest create-invalid-size: SUCCESS (0.000s)
[81.557477] [016/131] (947s left) syncobj_wait (single-wait-all-submitted)
[81.604090] Starting subtest: single-wait-all-submitted
[81.713212] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[81.797462] [017/131] (947s left) kms_content_protection (atomic)
[81.929902] Starting subtest: atomic
[81.934622] Subtest atomic: SKIP (0.000s)
[82.058232] [018/131] (947s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[82.155508] Starting subtest: yf-tiled-64bpp-rotate-0
[82.159896] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[82.234871] [019/131] (947s left) kms_plane (pixel-format-linear-modifier)
[82.333390] Starting subtest: pixel-format-linear-modifier
[82.359610] Starting dynamic subtest: pipe-A-plane-0
[86.026361] Dynamic subtest pipe-A-plane-0: SUCCESS (3.667s)
[86.034999] Starting dynamic subtest: pipe-A-plane-3
[87.693207] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s)
[87.700408] Starting dynamic subtest: pipe-A-plane-5
[87.904545] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[88.997655] Starting dynamic subtest: pipe-B-plane-0
[92.678548] Dynamic subtest pipe-B-plane-0: SUCCESS (3.689s)
[92.685870] Starting dynamic subtest: pipe-B-plane-3
[94.467903] Dynamic subtest pipe-B-plane-3: SUCCESS (1.788s)
[94.476106] Starting dynamic subtest: pipe-B-plane-5
[94.679594] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[94.989528] Subtest pixel-format-linear-modifier: SUCCESS (12.654s)
[95.880594] [020/131] (933s left) kms_feature_discovery (display)
[95.994970] Starting subtest: display
[95.997387] Subtest display: SUCCESS (0.000s)
[96.063007] [021/131] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[96.159796] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[96.164375] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[96.260305] [022/131] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[96.358617] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[100.835497] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.481s)
[101.991318] [023/131] (927s left) kms_cursor_crc (cursor-onscreen-128x128)
[102.205761] Starting subtest: cursor-onscreen-128x128
[102.210632] Starting dynamic subtest: pipe-A-eDP-1
[104.308209] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[104.335842] Starting dynamic subtest: pipe-D-eDP-1
[107.066427] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.735s)
[107.068747] Subtest cursor-onscreen-128x128: SUCCESS (4.858s)
[107.893647] [024/131] (921s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[107.995708] Starting subtest: bad-pixel-format-y-tiled-ccs
[107.998013] Starting dynamic subtest: pipe-A-eDP-1
[108.020615] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.028884] Starting dynamic subtest: pipe-B-eDP-1
[108.049960] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.057680] Starting dynamic subtest: pipe-C-eDP-1
[108.079134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.086491] Starting dynamic subtest: pipe-D-eDP-1
[108.108376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.112732] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[110.225249] [025/131] (919s left) kms_flip_event_leak (basic)
[110.316408] Starting subtest: basic
[110.318708] Starting dynamic subtest: pipe-A-eDP-1
[110.737514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[110.746674] Starting dynamic subtest: pipe-B-eDP-1
[111.852688] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.114s)
[111.865551] Starting dynamic subtest: pipe-C-eDP-1
[112.951427] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s)
[112.960646] Starting dynamic subtest: pipe-D-eDP-1
[114.082240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[114.084538] Subtest basic: SUCCESS (3.767s)
[114.944238] [026/131] (914s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[115.064890] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[115.194573] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s)
[115.314271] [027/131] (914s left) kms_psr (pr-no-drrs)
[115.400828] Starting subtest: pr-no-drrs
[115.404763] Subtest pr-no-drrs: SKIP (0.000s)
[115.471868] [028/131] (914s left) gem_create (hog-create)
[115.522077] Starting subtest: hog-create
[115.524324] Starting dynamic subtest: smem0
[147.923823] Dynamic subtest smem0: SUCCESS (32.398s)
[147.927040] Subtest hog-create: SUCCESS (32.399s)
[148.104358] [029/131] (881s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[148.197778] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[148.200097] Starting dynamic subtest: pipe-A-eDP-1
[148.208871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[148.218693] Starting dynamic subtest: pipe-B-eDP-1
[148.227592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[148.236854] Starting dynamic subtest: pipe-C-eDP-1
[148.245319] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[148.252483] Starting dynamic subtest: pipe-D-eDP-1
[148.260769] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[148.264746] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[150.488962] [030/131] (879s left) kms_flip (2x-wf_vblank-ts-check)
[150.601299] Starting subtest: 2x-wf_vblank-ts-check
[150.610040] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[150.690274] [031/131] (879s left) gen9_exec_parse (bb-start-param)
[150.749025] Subtest bb-start-param: SKIP (0.000s)
[150.817263] [032/131] (878s left) kms_plane_scaling (planes-downscale-factor-0-5)
[150.909878] Starting subtest: planes-downscale-factor-0-5
[150.912228] Starting dynamic subtest: pipe-A
[150.930055] Dynamic subtest pipe-A: SKIP (0.017s)
[150.939376] Starting dynamic subtest: pipe-B
[150.961613] Dynamic subtest pipe-B: SKIP (0.030s)
[150.970039] Starting dynamic subtest: pipe-C
[150.991896] Dynamic subtest pipe-C: SKIP (0.030s)
[151.000028] Starting dynamic subtest: pipe-D
[151.020947] Dynamic subtest pipe-D: SKIP (0.029s)
[151.024630] Subtest planes-downscale-factor-0-5: SKIP (0.107s)
[151.119435] [033/131] (878s left) i915_hangman (detector)
[151.183308] Starting subtest: detector
[151.185185] Starting dynamic subtest: rcs0
[162.867850] Dynamic subtest rcs0: SUCCESS (11.684s)
[162.878955] Starting dynamic subtest: bcs0
[173.874689] Dynamic subtest bcs0: SUCCESS (11.005s)
[173.885641] Starting dynamic subtest: vcs0
[184.819094] Dynamic subtest vcs0: SUCCESS (10.943s)
[184.829224] Starting dynamic subtest: vcs1
[195.826959] Dynamic subtest vcs1: SUCCESS (11.006s)
[195.838155] Starting dynamic subtest: vecs0
[206.835825] Dynamic subtest vecs0: SUCCESS (11.006s)
[206.846974] Starting dynamic subtest: ccs0
[218.867287] Dynamic subtest ccs0: SUCCESS (12.029s)
[218.870067] Subtest detector: SUCCESS (67.683s)
[218.949125] [034/131] (810s left) api_intel_allocator (two-level-inception-interruptible)
[219.012133] Starting subtest: two-level-inception-interruptible
[224.467604] Subtest two-level-inception-interruptible: SUCCESS (5.403s)
[224.541569] [035/131] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[224.646075] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[231.534914] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.892s)
[231.687750] [036/131] (798s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[231.748709] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[231.857465] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[231.944579] [037/131] (798s left) api_intel_bb (intel-bb-blit-x)
[231.994995] Starting subtest: intel-bb-blit-x
[235.661082] Subtest intel-bb-blit-x: SUCCESS (3.666s)
[235.780532] [038/131] (794s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[235.880609] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[235.892551] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[235.975403] [039/131] (794s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[236.073380] Starting subtest: psr-rgb101010-draw-render
[243.331322] Subtest psr-rgb101010-draw-render: SUCCESS (7.260s)
[243.470034] [040/131] (786s left) kms_color (ctm-green-to-red)
[243.552187] Starting subtest: ctm-green-to-red
[243.554436] Starting dynamic subtest: pipe-A-eDP-1
[244.219236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.666s)
[244.228244] Starting dynamic subtest: pipe-B-eDP-1
[245.708889] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.489s)
[245.717897] Starting dynamic subtest: pipe-C-eDP-1
[247.002875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.295s)
[247.012272] Starting dynamic subtest: pipe-D-eDP-1
[248.349324] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[248.351527] Subtest ctm-green-to-red: SUCCESS (4.798s)
[249.181148] [041/131] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[249.278797] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[249.283181] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[249.376133] [042/131] (780s left) prime_self_import (basic-llseek-bad)
[249.411167] Starting subtest: basic-llseek-bad
[249.423164] Subtest basic-llseek-bad: SUCCESS (0.013s)
[249.508046] [043/131] (780s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[249.701622] Starting subtest: cursor-rapid-movement-64x21
[249.744021] Subtest cursor-rapid-movement-64x21: SKIP (0.040s)
[250.021926] [044/131] (780s left) kms_selftest (drm_damage_helper)
[250.067155] Starting subtest: drm_damage_helper
[250.115285] Starting dynamic subtest: drm_test_damage_iter_no_damage
[250.209159] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.094s)
[250.218478] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[250.313483] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.102s)
[250.322531] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[250.419403] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.106s)
[250.428412] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[250.512290] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.092s)
[250.520561] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[250.615110] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.103s)
[250.622334] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[250.701105] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.085s)
[250.708350] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[250.796209] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.094s)
[250.804587] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[250.890832] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.093s)
[250.897827] Starting dynamic subtest: drm_test_damage_iter_single_damage
[250.986354] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.096s)
[250.994880] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[251.071119] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.084s)
[251.079657] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[251.161203] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.089s)
[251.169674] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[251.252325] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.091s)
[251.260800] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[251.335700] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.082s)
[251.342905] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[251.435393] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.099s)
[251.443801] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[251.522873] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.087s)
[251.529929] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[251.617423] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.089s)
[251.624911] Starting dynamic subtest: drm_test_damage_iter_damage
[251.707341] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.092s)
[251.715562] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[251.800161] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.092s)
[251.808076] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[251.884789] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.084s)
[251.891803] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[251.974051] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.089s)
[251.983077] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[252.075087] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.099s)
[252.076829] Subtest drm_damage_helper: SUCCESS (2.008s)
[252.230733] [045/131] (778s left) kms_chamelium_edid (dp-edid-read)
[252.621681] Subtest dp-edid-read: SKIP (0.000s)
[253.395386] [046/131] (776s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[253.499090] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[253.501282] Starting dynamic subtest: A-eDP1
[257.056065] Dynamic subtest A-eDP1: SUCCESS (3.553s)
[257.064486] Starting dynamic subtest: B-eDP1
[260.282030] Dynamic subtest B-eDP1: SUCCESS (3.225s)
[260.292658] Starting dynamic subtest: C-eDP1
[263.398716] Dynamic subtest C-eDP1: SUCCESS (3.116s)
[263.408257] Starting dynamic subtest: D-eDP1
[266.596598] Dynamic subtest D-eDP1: SUCCESS (3.197s)
[266.598952] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.099s)
[267.401512] [047/131] (763s left) prime_vgem (basic-blt)
[267.513999] Starting subtest: basic-blt
[267.538864] Subtest basic-blt: SUCCESS (0.025s)
[267.646942] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true
[267.650206] [048/131] (762s left) kms_addfb_basic (too-high)
[267.754585] Starting subtest: too-high
[267.757043] Subtest too-high: SUCCESS (0.001s)
[267.861909] [049/131] (762s left) kms_flip (2x-plain-flip-interruptible)
[267.952226] Starting subtest: 2x-plain-flip-interruptible
[267.963542] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[268.056117] [050/131] (762s left) kms_addfb_basic (basic-y-tiled-legacy)
[268.116257] Starting subtest: basic-y-tiled-legacy
[268.120489] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[268.255857] [051/131] (762s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[268.358040] Starting subtest: psr-1p-pri-indfb-multidraw
[291.117351] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.761s)
[291.249348] [052/131] (739s left) gem_basic (create-fd-close)
[291.315459] Starting subtest: create-fd-close
[291.319258] Subtest create-fd-close: SUCCESS (0.000s)
[291.443806] [053/131] (739s left) kms_invalid_mode (int-max-clock)
[291.528533] Starting subtest: int-max-clock
[291.530515] Starting dynamic subtest: pipe-A-eDP-1
[291.816248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[291.824926] Starting dynamic subtest: pipe-B-eDP-1
[291.827228] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[291.834887] Starting dynamic subtest: pipe-C-eDP-1
[291.837280] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[291.845087] Starting dynamic subtest: pipe-D-eDP-1
[291.847434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[291.849787] Subtest int-max-clock: SUCCESS (0.292s)
[292.668019] [054/131] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[292.761824] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[292.766233] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[292.843747] [055/131] (737s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[292.934343] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[293.602612] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[293.777861] [056/131] (737s left) gen9_exec_parse (unaligned-access)
[293.837677] Subtest unaligned-access: SKIP (0.000s)
[293.897700] [057/131] (736s left) sw_sync (alloc_merge_fence)
[293.942190] Starting subtest: alloc_merge_fence
[293.944413] Subtest alloc_merge_fence: SUCCESS (0.000s)
[293.999690] [058/131] (736s left) kms_pm_rpm (cursor)
[296.037046] Starting subtest: cursor
[296.042350] Subtest cursor: SKIP (0.000s)
[296.424583] [059/131] (734s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[296.517362] Starting subtest: extended-modeset-hang-oldfb-with-reset
[296.519380] Starting dynamic subtest: pipe-A
[308.198267] Dynamic subtest pipe-A: SUCCESS (11.679s)
[308.206753] Starting dynamic subtest: pipe-D
[320.463106] Dynamic subtest pipe-D: SUCCESS (12.261s)
[320.465442] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.944s)
[321.269423] [060/131] (709s left) gem_mmap_wc (set-cache-level)
[321.337730] Subtest set-cache-level: SKIP (0.000s)
[321.398748] [061/131] (709s left) kms_prime (basic-modeset-hybrid)
[321.476780] Subtest basic-modeset-hybrid: SKIP (0.000s)
[321.584553] [062/131] (709s left) gem_exec_schedule (u-semaphore-codependency)
[321.674060] Starting subtest: u-semaphore-codependency
[321.684727] Subtest u-semaphore-codependency: SUCCESS (0.018s)
[322.048190] [063/131] (709s left) gem_exec_balancer (sequential)
[322.107590] Starting subtest: sequential
[325.170725] Subtest sequential: SUCCESS (3.063s)
[325.503900] [064/131] (705s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[325.633278] Starting subtest: flip-primary-invalidate-overlay
[337.328654] Subtest flip-primary-invalidate-overlay: SUCCESS (11.702s)
[337.491740] [065/131] (693s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[337.587386] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[344.628778] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.043s)
[344.747325] [066/131] (686s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[344.806865] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[344.809086] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[344.892928] [067/131] (686s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[344.991059] Starting subtest: 2x-flip-vs-rmfb-interruptible
[345.003094] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[345.080669] [068/131] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[345.175717] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[345.179895] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[345.290981] [069/131] (686s left) syncobj_timeline (single-wait-available-signaled)
[345.351136] Starting subtest: single-wait-available-signaled
[345.353419] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[345.437216] [070/131] (685s left) gem_exec_async (concurrent-writes)
[345.509828] Starting subtest: concurrent-writes
[345.512246] Starting dynamic subtest: rcs0
[345.526940] Dynamic subtest rcs0: SUCCESS (0.017s)
[345.536474] Starting dynamic subtest: bcs0
[345.538738] Dynamic subtest bcs0: SUCCESS (0.006s)
[345.547653] Starting dynamic subtest: vcs0
[345.549581] Dynamic subtest vcs0: SUCCESS (0.005s)
[345.558313] Starting dynamic subtest: vcs1
[345.560173] Dynamic subtest vcs1: SUCCESS (0.006s)
[345.568356] Starting dynamic subtest: vecs0
[345.570037] Dynamic subtest vecs0: SUCCESS (0.006s)
[345.577247] Starting dynamic subtest: ccs0
[345.578821] Dynamic subtest ccs0: SUCCESS (0.009s)
[345.580464] Subtest concurrent-writes: SUCCESS (0.053s)
[345.799437] [071/131] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[345.886447] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[345.889727] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[345.990089] [072/131] (685s left) gem_spin_batch (resubmit-new-all)
[346.063574] Starting subtest: resubmit-new-all
[346.065252] Starting dynamic subtest: rcs0
[346.074957] Dynamic subtest rcs0: SUCCESS (0.014s)
[346.084491] Starting dynamic subtest: bcs0
[346.088822] Dynamic subtest bcs0: SUCCESS (0.011s)
[346.096384] Starting dynamic subtest: vcs0
[346.099986] Dynamic subtest vcs0: SUCCESS (0.012s)
[346.109775] Starting dynamic subtest: vcs1
[346.116038] Dynamic subtest vcs1: SUCCESS (0.014s)
[346.128304] Starting dynamic subtest: vecs0
[346.132906] Dynamic subtest vecs0: SUCCESS (0.014s)
[346.144092] Starting dynamic subtest: ccs0
[346.145943] Dynamic subtest ccs0: SUCCESS (0.010s)
[346.147808] Subtest resubmit-new-all: SUCCESS (0.080s)
[347.965592] [073/131] (683s left) perf_pmu (busy-idle)
[348.011534] Starting subtest: busy-idle
[348.013844] Starting dynamic subtest: rcs0
[348.704278] Dynamic subtest rcs0: SUCCESS (0.693s)
[348.716439] Starting dynamic subtest: bcs0
[349.373256] Dynamic subtest bcs0: SUCCESS (0.667s)
[349.385308] Starting dynamic subtest: vcs0
[350.933216] Dynamic subtest vcs0: SUCCESS (1.556s)
[350.944050] Starting dynamic subtest: vcs1
[352.916939] Dynamic subtest vcs1: SUCCESS (1.981s)
[352.929224] Starting dynamic subtest: vecs0
[354.900764] Dynamic subtest vecs0: SUCCESS (1.981s)
[354.913016] Starting dynamic subtest: ccs0
[355.566267] Dynamic subtest ccs0: SUCCESS (0.664s)
[355.568826] Subtest busy-idle: SUCCESS (7.556s)
[355.674406] [074/131] (675s left) gem_exec_schedule (noreorder)
[355.867995] Starting subtest: noreorder
[355.871013] Starting dynamic subtest: rcs0
[355.946767] Dynamic subtest rcs0: SUCCESS (0.080s)
[355.958446] Starting dynamic subtest: vcs0
[357.907032] Dynamic subtest vcs0: SUCCESS (1.957s)
[357.918284] Starting dynamic subtest: vcs1
[359.870057] Dynamic subtest vcs1: SUCCESS (1.960s)
[359.883069] Starting dynamic subtest: vecs0
[361.990713] Dynamic subtest vecs0: SUCCESS (2.065s)
[362.002740] Starting dynamic subtest: ccs0
[362.005287] Dynamic subtest ccs0: SUCCESS (0.066s)
[362.007935] Subtest noreorder: SUCCESS (6.138s)
[362.212492] [075/131] (669s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[362.318777] Starting subtest: y-tiled-8bpp-rotate-180
[362.323264] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[362.420243] [076/131] (669s left) kms_plane_multiple (tiling-4)
[362.516248] Starting subtest: tiling-4
[362.518581] Starting dynamic subtest: pipe-A-eDP-1
[366.257034] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.741s)
[366.265686] Starting dynamic subtest: pipe-B-eDP-1
[370.676233] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.418s)
[370.685432] Starting dynamic subtest: pipe-C-eDP-1
[375.089500] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.410s)
[375.099422] Starting dynamic subtest: pipe-D-eDP-1
[379.407678] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.317s)
[379.409961] Subtest tiling-4: SUCCESS (16.892s)
[380.228202] [077/131] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[380.331136] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[387.444418] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.114s)
[387.574575] [078/131] (644s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[387.666269] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[387.668541] Starting dynamic subtest: pipe-A
[387.775059] Dynamic subtest pipe-A: SKIP (0.106s)
[387.784293] Starting dynamic subtest: pipe-B
[388.928266] Dynamic subtest pipe-B: SKIP (1.150s)
[388.941600] Starting dynamic subtest: pipe-C
[390.149128] Dynamic subtest pipe-C: SUCCESS (1.227s)
[390.158875] Starting dynamic subtest: pipe-D
[391.291824] Dynamic subtest pipe-D: SUCCESS (1.142s)
[391.294093] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.628s)
[392.480926] [079/131] (639s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[392.576136] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[392.578528] Starting dynamic subtest: pipe-A-eDP-1
[399.201050] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.630s)
[399.213404] Starting dynamic subtest: pipe-B-eDP-1
[406.112706] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.909s)
[406.114930] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.542s)
[406.992929] [080/131] (624s left) i915_pm_rpm (debugfs-read)
[409.020422] Starting subtest: debugfs-read
[410.192612] Subtest debugfs-read: SUCCESS (1.171s)
[410.561283] [081/131] (621s left) gem_ccs (block-multicopy-inplace)
[410.618609] Starting subtest: block-multicopy-inplace
[410.622657] Subtest block-multicopy-inplace: SKIP (0.000s)
[410.754632] [082/131] (621s left) syncobj_wait (invalid-signal-illegal-handle)
[410.803296] Starting subtest: invalid-signal-illegal-handle
[410.805182] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[410.889976] [083/131] (621s left) gem_ctx_param (invalid-get-ringsize)
[410.941885] Starting subtest: invalid-get-ringsize
[410.944191] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[411.053113] [084/131] (620s left) kms_cursor_edge_walk (128x128-right-edge)
[411.144068] Starting subtest: 128x128-right-edge
[411.146239] Starting dynamic subtest: pipe-A-eDP-1
[414.628545] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[414.642327] Starting dynamic subtest: pipe-D-eDP-1
[417.751541] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[417.753876] Subtest 128x128-right-edge: SUCCESS (6.609s)
[418.555449] [085/131] (613s left) gem_eio (wait-10ms)
[418.772092] Starting subtest: wait-10ms
[419.101836] Subtest wait-10ms: SUCCESS (0.330s)
[419.263592] [086/131] (612s left) gem_userptr_blits (dmabuf-unsync)
[419.333810] Subtest dmabuf-unsync: SKIP (0.000s)
[419.468595] [087/131] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[419.562900] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[419.566340] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[419.661522] [088/131] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[419.761401] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[419.764888] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[419.851301] [089/131] (612s left) kms_getfb (getfb2-accept-nv12)
[419.953712] Starting subtest: getfb2-accept-nv12
[419.955760] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[420.090412] [090/131] (612s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[420.160613] Starting subtest: etime-single-wait-for-submit-submitted
[420.263381] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s)
[420.347023] [091/131] (611s left) i915_query (query-regions-unallocated)
[420.420058] Starting subtest: query-regions-unallocated
[420.421941] Subtest query-regions-unallocated: SUCCESS (0.000s)
[420.531095] [092/131] (611s left) kms_psr (fbc-psr2-cursor-plane-move)
[420.624629] Starting subtest: fbc-psr2-cursor-plane-move
[420.626547] Starting dynamic subtest: eDP-1
[420.630073] Dynamic subtest eDP-1: SKIP (0.000s)
[420.633583] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[420.698699] [093/131] (611s left) gem_ppgtt (blt-vs-render-ctx0)
[420.771354] Starting subtest: blt-vs-render-ctx0
[453.815781] Subtest blt-vs-render-ctx0: SUCCESS (33.044s)
[453.953539] [094/131] (578s left) gem_workarounds (reset-fd)
[454.067284] Starting subtest: reset-fd
[454.284072] Subtest reset-fd: SUCCESS (0.217s)
[454.403706] [095/131] (578s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[454.510078] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[454.512403] Starting dynamic subtest: pipe-A-eDP-1
[487.357027] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.091s)
[487.368384] Starting dynamic subtest: pipe-B-eDP-1
[521.218575] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.743s)
[521.229172] Starting dynamic subtest: pipe-C-eDP-1
[554.219922] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.629s)
[554.240878] Starting dynamic subtest: pipe-D-eDP-1
[587.231975] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.704s)
[587.234130] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.171s)
[588.446574] [096/131] (444s left) sysfs_timeslice_duration (timeout)
[588.520412] Starting subtest: timeout
[588.522750] Starting dynamic subtest: vecs0
[598.564577] Dynamic subtest vecs0: SUCCESS (10.101s)
[598.580309] Starting dynamic subtest: ccs0
[599.838968] Dynamic subtest ccs0: SUCCESS (1.279s)
[599.853507] Starting dynamic subtest: vcs0
[609.573324] Dynamic subtest vcs0: SUCCESS (9.747s)
[609.584931] Starting dynamic subtest: bcs0
[610.130489] Dynamic subtest bcs0: SUCCESS (0.557s)
[610.143164] Starting dynamic subtest: rcs0
[611.398270] Dynamic subtest rcs0: SUCCESS (1.266s)
[611.408149] Starting dynamic subtest: vcs1
[620.578886] Dynamic subtest vcs1: SUCCESS (9.178s)
[620.581428] Subtest timeout: SUCCESS (32.139s)
[620.662369] [097/131] (411s left) gem_mmap_gtt (cpuset-big-copy-odd)
[620.731424] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[620.794279] [098/131] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[620.899845] Starting subtest: psr-1p-primscrn-spr-indfb-move
[628.415649] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.514s)
[628.550853] [099/131] (404s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[628.689662] Starting subtest: cursorB-vs-flipA-atomic-transitions
[628.694151] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[628.836144] [100/131] (403s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[628.892585] Starting subtest: x-tiled-to-vebox-yf-tiled
[628.896983] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[629.077997] [101/131] (403s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[629.143056] Starting subtest: multi-wait-all-for-submit-submitted
[629.252906] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[629.330641] [102/131] (403s left) kms_psr (psr2-sprite-plane-onoff)
[629.430076] Starting subtest: psr2-sprite-plane-onoff
[629.432254] Starting dynamic subtest: eDP-1
[631.196846] Dynamic subtest eDP-1: SUCCESS (1.768s)
[631.199249] Subtest psr2-sprite-plane-onoff: SUCCESS (1.769s)
[632.059611] [103/131] (400s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[632.148909] Starting subtest: random-ccs-data-y-tiled-ccs
[632.152202] Starting dynamic subtest: pipe-A-eDP-1
[632.182280] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.194428] Starting dynamic subtest: pipe-B-eDP-1
[632.218174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.231546] Starting dynamic subtest: pipe-C-eDP-1
[632.255061] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.264821] Starting dynamic subtest: pipe-D-eDP-1
[632.288587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.292531] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[634.434050] [104/131] (398s left) gem_exec_flush (basic-uc-ro-default)
[634.496149] Starting subtest: basic-uc-ro-default
[639.985200] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[640.144109] [105/131] (392s left) kms_force_connector_basic (prune-stale-modes)
[640.221342] Starting subtest: prune-stale-modes
[640.669432] Subtest prune-stale-modes: SUCCESS (0.450s)
[640.807211] [106/131] (392s left) gem_mmap_offset (bad-extensions)
[640.854113] Starting subtest: bad-extensions
[640.856409] Subtest bad-extensions: SUCCESS (0.000s)
[640.956255] [107/131] (392s left) kms_mmap_write_crc (main)
[641.045142] Starting subtest: main
[641.047092] Starting dynamic subtest: pipe-A-eDP-1
[644.550795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[644.553167] Subtest main: SUCCESS (3.504s)
[645.351141] [108/131] (387s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[645.458987] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[645.463051] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[645.530000] [109/131] (387s left) kms_vblank (ts-continuation-dpms-rpm)
[645.621120] Starting subtest: ts-continuation-dpms-rpm
[645.623201] Starting dynamic subtest: pipe-A-eDP-1
[648.102103] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.481s)
[648.118628] Starting dynamic subtest: pipe-D-eDP-1
[650.282926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.180s)
[650.285366] Subtest ts-continuation-dpms-rpm: SUCCESS (4.664s)
[651.167984] [110/131] (381s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[651.255659] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[651.259967] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[651.337044] [111/131] (381s left) gem_ctx_persistence (heartbeat-many)
[651.397880] Starting subtest: heartbeat-many
[651.402222] Subtest heartbeat-many: SKIP (0.000s)
[651.505042] [112/131] (381s left) syncobj_wait (wait-all-snapshot)
[651.558393] Starting subtest: wait-all-snapshot
[651.639149] Subtest wait-all-snapshot: SUCCESS (0.082s)
[651.716607] [113/131] (381s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[652.098979] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[652.917704] [114/131] (380s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[653.022576] Starting subtest: primary-yf-tiled-reflect-x-90
[653.027136] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[653.100284] [115/131] (380s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[653.191765] Starting subtest: plane-use-after-nonblocking-unbind
[653.194073] Starting dynamic subtest: pipe-A-eDP-1
[653.251739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[653.556184] Starting dynamic subtest: pipe-B-eDP-1
[654.317657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.772s)
[654.618171] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.425s)
[655.458089] [116/131] (377s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[655.531094] Starting subtest: yf-tiled-ccs-to-y-tiled
[655.535503] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[655.717092] [117/131] (377s left) gem_readwrite (read-write)
[655.768249] Subtest read-write: SKIP (0.000s)
[655.824023] [118/131] (377s left) gem_vm_create (invalid-create)
[655.878237] Starting subtest: invalid-create
[655.883698] Subtest invalid-create: SUCCESS (0.002s)
[655.977451] [119/131] (377s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[656.072750] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[656.077008] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[656.168642] [120/131] (377s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[656.259974] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[656.262100] Starting dynamic subtest: pipe-A-eDP-1
[656.357776] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[656.368700] Starting dynamic subtest: pipe-B-eDP-1
[657.483119] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[657.487870] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.223s)
[658.758154] [121/131] (374s left) kms_async_flips (invalid-async-flip-atomic)
[658.855521] Starting subtest: invalid-async-flip-atomic
[659.247784] Starting dynamic subtest: pipe-A-eDP-1
[660.033149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[660.393093] Starting dynamic subtest: pipe-B-eDP-1
[661.233202] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.849s)
[661.591726] Starting dynamic subtest: pipe-C-eDP-1
[662.438064] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.856s)
[662.795689] Starting dynamic subtest: pipe-D-eDP-1
[663.617117] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.831s)
[663.619605] Subtest invalid-async-flip-atomic: SUCCESS (4.763s)
[664.855478] [122/131] (368s left) gem_exec_fence (submit67)
[665.034233] Starting subtest: submit67
[665.038426] Subtest submit67: SKIP (0.000s)
[666.696325] [123/131] (366s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[666.790946] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[666.794985] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[666.896475] [124/131] (366s left) kms_big_fb (linear-32bpp-rotate-270)
[666.992185] Starting subtest: linear-32bpp-rotate-270
[667.011651] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[667.115662] [125/131] (366s left) gem_exec_schedule (fifo)
[667.193663] Starting subtest: fifo
[667.195608] Starting dynamic subtest: rcs0
[667.292732] Dynamic subtest rcs0: SUCCESS (0.108s)
[667.306155] Starting dynamic subtest: vcs0
[667.376916] Dynamic subtest vcs0: SUCCESS (0.081s)
[667.392799] Starting dynamic subtest: vcs1
[667.452275] Dynamic subtest vcs1: SUCCESS (0.074s)
[667.465087] Starting dynamic subtest: vecs0
[667.531846] Dynamic subtest vecs0: SUCCESS (0.079s)
[667.548815] Starting dynamic subtest: ccs0
[667.618638] Dynamic subtest ccs0: SUCCESS (0.085s)
[667.621382] Subtest fifo: SUCCESS (0.434s)
[668.681207] [126/131] (365s left) core_setmaster (master-drop-set-root)
[668.749995] Starting subtest: master-drop-set-root
[668.771439] Subtest master-drop-set-root: SUCCESS (0.024s)
[668.823782] [127/131] (364s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[668.883916] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[668.886132] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[669.000269] [128/131] (364s left) gem_exec_store (pages)
[669.060534] Starting subtest: pages
[669.062751] Starting dynamic subtest: rcs0
[669.159472] Dynamic subtest rcs0: SUCCESS (0.100s)
[669.172123] Starting dynamic subtest: bcs0
[669.234749] Dynamic subtest bcs0: SUCCESS (0.073s)
[669.248135] Starting dynamic subtest: vcs0
[669.305458] Dynamic subtest vcs0: SUCCESS (0.070s)
[669.317991] Starting dynamic subtest: vcs1
[669.384767] Dynamic subtest vcs1: SUCCESS (0.078s)
[669.397373] Starting dynamic subtest: vecs0
[669.466478] Dynamic subtest vecs0: SUCCESS (0.081s)
[669.478377] Starting dynamic subtest: ccs0
[669.541849] Dynamic subtest ccs0: SUCCESS (0.074s)
[669.544373] Subtest pages: SUCCESS (0.484s)
[669.748055] [129/131] (364s left) gem_exec_balancer (parallel)
[670.012666] Starting subtest: parallel
[670.937252] Subtest parallel: SUCCESS (0.924s)
[671.650891] [130/131] (362s left) perf_pmu (busy-check-all)
[671.696387] Starting subtest: busy-check-all
[671.698283] Starting dynamic subtest: rcs0
[672.257398] Dynamic subtest rcs0: SUCCESS (0.563s)
[672.271910] Starting dynamic subtest: bcs0
[672.811671] Dynamic subtest bcs0: SUCCESS (0.552s)
[672.825137] Starting dynamic subtest: vcs0
[674.600572] Dynamic subtest vcs0: SUCCESS (1.785s)
[674.614654] Starting dynamic subtest: vcs1
[676.584862] Dynamic subtest vcs1: SUCCESS (1.981s)
[676.597785] Starting dynamic subtest: vecs0
[678.567961] Dynamic subtest vecs0: SUCCESS (1.980s)
[678.581125] Starting dynamic subtest: ccs0
[679.124884] Dynamic subtest ccs0: SUCCESS (0.555s)
[679.127237] Subtest busy-check-all: SUCCESS (7.432s)
[679.239419] [131/131] (354s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[679.358824] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[679.362926] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[679.488179] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: gem_render_copy_redux
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_dp_linktrain_fallback
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_create
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_feature_discovery
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_flip_event_leak
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: i915_hangman
results: parsing output: 33/ for test: api_intel_allocator
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_self_import
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: kms_chamelium_edid
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: prime_vgem
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_basic
results: parsing output: 52/ for test: kms_invalid_mode
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_busy
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_prime
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_psr_stress_test
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_exec_async
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_plane_multiple
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: gem_ccs
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_ctx_param
results: parsing output: 83/ for test: kms_cursor_edge_walk
results: parsing output: 84/ for test: gem_eio
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_getfb
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_ppgtt
results: parsing output: 93/ for test: gem_workarounds
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: sysfs_timeslice_duration
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: kms_force_connector_basic
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: kms_mmap_write_crc
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: gem_readwrite
results: parsing output: 117/ for test: gem_vm_create
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_async_flips
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: core_setmaster
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_store
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_big_fb
Done.