[57.898430] Initializing watchdogs
[57.898480]   /dev/watchdog0
[57.914259] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.918940] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.921215] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.924506] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[58.064317] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[58.068551] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[58.157615] [002/133] (960s left) syncobj_timeline (wait-all-for-submit-snapshot)
[58.212652] Starting subtest: wait-all-for-submit-snapshot
[58.294533] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[58.396954] [003/133] (960s left) kms_getfb (getfb-handle-not-fb)
[58.485186] Starting subtest: getfb-handle-not-fb
[58.487428] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[58.584452] [004/133] (959s left) gem_exec_alignment (single)
[58.640053] Starting subtest: single
[58.644809] Subtest single: SUCCESS (0.004s)
[58.752120] [005/133] (959s left) gem_mmap_gtt (basic-small-copy-odd)
[58.799861] Subtest basic-small-copy-odd: SKIP (0.000s)
[58.853963] [006/133] (959s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[58.943322] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[58.946663] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[59.008694] [007/133] (959s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[59.068410] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[59.070541] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[59.169453] [008/133] (959s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[59.263379] Starting subtest: y-tiled-16bpp-rotate-270
[59.267139] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[59.349800] [009/133] (959s left) core_hotunplug (unbind-rebind)
[59.417104] Starting subtest: unbind-rebind
[63.697459] Subtest unbind-rebind: SUCCESS (4.277s)
[63.733761] [010/133] (955s left) kms_selftest (drm_format)
[63.784952] Starting subtest: drm_format
[63.790419] Starting dynamic subtest: drm_test_format_block_width_invalid
[63.872533] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.081s)
[63.881690] Starting dynamic subtest: drm_test_format_block_width_one_plane
[63.953860] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.082s)
[63.962576] Starting dynamic subtest: drm_test_format_block_width_two_plane
[64.038078] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.084s)
[64.049453] Starting dynamic subtest: drm_test_format_block_width_three_plane
[64.116483] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.077s)
[64.123974] Starting dynamic subtest: drm_test_format_block_width_tiled
[64.204656] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.088s)
[64.213259] Starting dynamic subtest: drm_test_format_block_height_invalid
[64.301284] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.097s)
[64.308795] Starting dynamic subtest: drm_test_format_block_height_one_plane
[64.386321] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.084s)
[64.393807] Starting dynamic subtest: drm_test_format_block_height_two_plane
[64.463950] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.075s)
[64.471137] Starting dynamic subtest: drm_test_format_block_height_three_plane
[64.547102] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.084s)
[64.556511] Starting dynamic subtest: drm_test_format_block_height_tiled
[64.631406] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.084s)
[64.640769] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[64.720482] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.090s)
[64.727861] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[64.804554] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.083s)
[64.811712] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[64.897139] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.092s)
[64.903945] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[64.987454] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.091s)
[64.994632] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[65.086400] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.097s)
[65.093484] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[65.162635] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.075s)
[65.169614] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[65.267548] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.104s)
[65.274305] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[65.360062] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.092s)
[65.361683] Subtest drm_format: SUCCESS (1.576s)
[65.506430] [011/133] (953s left) gem_exec_balancer (bonded-true-hang)
[65.765237] Starting subtest: bonded-true-hang
[65.770320] Subtest bonded-true-hang: SKIP (0.000s)
[65.884684] [012/133] (952s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[65.929683] Starting subtest: etime-multi-wait-available-unsubmitted
[66.034260] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[66.109845] [013/133] (952s left) sw_sync (alloc_fence_invalid_timeline)
[66.142701] Starting subtest: alloc_fence_invalid_timeline
[66.145248] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[66.196898] [014/133] (952s left) kms_joiner (basic-big-joiner)
[66.296239] Starting subtest: basic-big-joiner
[66.300118] Subtest basic-big-joiner: SKIP (0.000s)
[66.360936] [015/133] (952s left) kms_flip (2x-plain-flip)
[66.452119] Starting subtest: 2x-plain-flip
[66.463824] Subtest 2x-plain-flip: SKIP (0.011s)
[66.567497] [016/133] (952s left) gem_exec_reloc (basic-gtt-cpu-active)
[66.628163] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[66.698963] [017/133] (952s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[66.782532] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[66.786752] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[66.974734] [018/133] (952s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[67.175702] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[67.180277] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[67.327919] [019/133] (951s left) kms_cursor_edge_walk (128x128-top-bottom)
[67.515732] Starting subtest: 128x128-top-bottom
[67.518123] Starting dynamic subtest: pipe-A-eDP-1
[70.983892] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[70.993489] Starting dynamic subtest: pipe-D-eDP-1
[74.091416] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[74.093702] Subtest 128x128-top-bottom: SUCCESS (6.575s)
[74.926932] [020/133] (944s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[77.080242] Starting subtest: modeset-lpsp-stress-no-wait
[86.752542] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.673s)
[86.830901] [021/133] (932s left) gem_mmap_offset (bad-extensions)
[86.882901] Starting subtest: bad-extensions
[86.885386] Subtest bad-extensions: SUCCESS (0.000s)
[86.978089] [022/133] (932s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[87.071783] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[87.076239] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[87.140271] [023/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[87.240972] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[87.245281] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[87.318423] [024/133] (932s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[87.411882] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[87.414091] Starting dynamic subtest: pipe-A
[88.459311] Dynamic subtest pipe-A: SUCCESS (1.050s)
[88.467471] Starting dynamic subtest: pipe-B
[90.620929] Dynamic subtest pipe-B: SUCCESS (2.161s)
[90.634435] Starting dynamic subtest: pipe-C
[91.819454] Dynamic subtest pipe-C: SUCCESS (1.197s)
[91.828087] Starting dynamic subtest: pipe-D
[92.977051] Dynamic subtest pipe-D: SUCCESS (1.157s)
[92.979477] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.567s)
[94.181083] [025/133] (925s left) syncobj_wait (single-wait-submitted)
[94.248306] Starting subtest: single-wait-submitted
[94.353942] Subtest single-wait-submitted: SUCCESS (0.105s)
[94.429929] [026/133] (924s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[94.518375] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[94.522661] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[94.590699] [027/133] (924s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[94.690979] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[98.852594] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.166s)
[99.974331] [028/133] (919s left) syncobj_wait (single-wait-for-submit-signaled)
[100.028288] Starting subtest: single-wait-for-submit-signaled
[100.030671] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[100.132809] [029/133] (919s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[100.252321] Starting subtest: cursorA-vs-flipA-atomic
[111.380903] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.128s)
[112.194820] [030/133] (907s left) gem_ctx_param (invalid-get-no-zeromap)
[112.249640] Starting subtest: invalid-get-no-zeromap
[112.252140] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[112.353054] [031/133] (907s left) gem_exec_create (madvise)
[112.412395] Starting subtest: madvise
[112.414756] Starting dynamic subtest: smem
[133.975566] Dynamic subtest smem: SUCCESS (21.555s)
[133.978208] Subtest madvise: SUCCESS (21.555s)
[135.177948] [032/133] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[135.282187] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[135.286215] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[135.381008] [033/133] (884s left) prime_vgem (sync)
[135.530978] Starting subtest: sync
[135.533421] Starting dynamic subtest: rcs0
[135.573358] Dynamic subtest rcs0: SUCCESS (0.045s)
[135.581757] Starting dynamic subtest: bcs0
[135.632535] Dynamic subtest bcs0: SUCCESS (0.059s)
[135.640418] Starting dynamic subtest: vcs0
[135.680180] Dynamic subtest vcs0: SUCCESS (0.047s)
[135.688235] Starting dynamic subtest: vcs1
[135.726795] Dynamic subtest vcs1: SUCCESS (0.046s)
[135.734741] Starting dynamic subtest: vecs0
[135.772697] Dynamic subtest vecs0: SUCCESS (0.045s)
[135.780756] Starting dynamic subtest: ccs0
[135.818195] Dynamic subtest ccs0: SUCCESS (0.045s)
[135.820616] Subtest sync: SUCCESS (0.290s)
[135.940353] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[135.943485] [034/133] (883s left) gem_exec_fence (basic-busy)
[136.126071] Starting subtest: basic-busy
[136.128909] Starting dynamic subtest: rcs0
[136.207686] Dynamic subtest rcs0: SUCCESS (0.082s)
[136.218260] Starting dynamic subtest: bcs0
[136.261702] Dynamic subtest bcs0: SUCCESS (0.053s)
[136.274460] Starting dynamic subtest: vcs0
[136.327261] Dynamic subtest vcs0: SUCCESS (0.064s)
[136.337270] Starting dynamic subtest: vcs1
[136.383709] Dynamic subtest vcs1: SUCCESS (0.054s)
[136.394471] Starting dynamic subtest: vecs0
[136.440696] Dynamic subtest vecs0: SUCCESS (0.055s)
[136.450915] Starting dynamic subtest: ccs0
[136.498061] Dynamic subtest ccs0: SUCCESS (0.056s)
[136.500642] Subtest basic-busy: SUCCESS (0.373s)
[137.971960] [035/133] (881s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[138.075197] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[143.468348] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.391s)
[144.620138] [036/133] (875s left) kms_big_fb (linear-addfb)
[144.722231] Starting subtest: linear-addfb
[144.724213] Subtest linear-addfb: SUCCESS (0.000s)
[144.828873] [037/133] (875s left) gem_vm_create (isolation)
[144.889705] Starting subtest: isolation
[144.897301] Subtest isolation: SUCCESS (0.008s)
[145.025299] [038/133] (874s left) gem_exec_params (invalid-fence-in-submit)
[145.092705] Starting subtest: invalid-fence-in-submit
[145.097649] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[145.216046] [039/133] (874s left) perf_pmu (invalid-open)
[145.262291] Starting subtest: invalid-open
[145.264580] Subtest invalid-open: SUCCESS (0.000s)
[145.370720] [040/133] (874s left) gem_busy (busy)
[145.441527] Starting subtest: busy
[145.444223] Starting dynamic subtest: all-engines
[145.494999] Dynamic subtest all-engines: SUCCESS (0.054s)
[145.503658] Starting dynamic subtest: rcs0
[146.844954] Dynamic subtest rcs0: SUCCESS (1.348s)
[146.854990] Starting dynamic subtest: bcs0
[146.894033] Dynamic subtest bcs0: SUCCESS (0.049s)
[146.903452] Starting dynamic subtest: vcs0
[146.933028] Dynamic subtest vcs0: SUCCESS (0.038s)
[146.941749] Starting dynamic subtest: vcs1
[148.891140] Dynamic subtest vcs1: SUCCESS (1.955s)
[148.901485] Starting dynamic subtest: vecs0
[150.938926] Dynamic subtest vecs0: SUCCESS (2.046s)
[150.949043] Starting dynamic subtest: ccs0
[152.923940] Dynamic subtest ccs0: SUCCESS (1.984s)
[152.926369] Subtest busy: SUCCESS (7.479s)
[153.276161] [041/133] (866s left) kms_draw_crc (draw-method-render)
[153.372132] Starting subtest: draw-method-render
[153.374465] Starting dynamic subtest: xrgb8888-untiled
[153.627752] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s)
[153.636026] Starting dynamic subtest: rgb565-untiled
[153.859822] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[153.870056] Starting dynamic subtest: xrgb2101010-untiled
[154.082455] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[154.094637] Starting dynamic subtest: xbgr16161616f-untiled
[154.326040] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[154.334928] Starting dynamic subtest: xrgb8888-xtiled
[154.448079] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[154.456812] Starting dynamic subtest: rgb565-xtiled
[154.559440] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[154.569506] Starting dynamic subtest: xrgb2101010-xtiled
[154.681490] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[154.689811] Starting dynamic subtest: xbgr16161616f-xtiled
[154.815415] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[154.823685] Starting dynamic subtest: xrgb8888-4tiled
[154.937323] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[154.945959] Starting dynamic subtest: rgb565-4tiled
[155.071162] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[155.080151] Starting dynamic subtest: xrgb2101010-4tiled
[155.192818] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[155.201574] Starting dynamic subtest: xbgr16161616f-4tiled
[155.326196] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[155.328097] Subtest draw-method-render: SUCCESS (1.957s)
[155.440901] [042/133] (864s left) gem_exec_reloc (basic-cpu-active)
[155.504991] Subtest basic-cpu-active: SKIP (0.000s)
[155.565973] [043/133] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[155.657915] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[162.219894] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.563s)
[162.338694] [044/133] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[162.432544] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[162.436897] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[162.525590] [045/133] (857s left) gem_softpin (softpin)
[162.584268] Starting subtest: softpin
[194.962974] Subtest softpin: SUCCESS (32.372s)
[195.070099] [046/133] (825s left) gem_pxp (create-regular-context-1)
[195.189687] Starting subtest: create-regular-context-1
[195.192236] Subtest create-regular-context-1: SUCCESS (0.002s)
[195.307870] [047/133] (824s left) kms_dp_link_training (non-uhbr-mst)
[195.406846] Starting subtest: non-uhbr-mst
[195.415134] Subtest non-uhbr-mst: SKIP (0.000s)
[195.480745] [048/133] (824s left) gem_exec_fence (syncobj-timeline-chain-engines)
[196.046696] Starting subtest: syncobj-timeline-chain-engines
[196.159864] Subtest syncobj-timeline-chain-engines: SUCCESS (0.114s)
[196.981473] [049/133] (823s left) kms_async_flips (crc-atomic)
[197.068085] Starting subtest: crc-atomic
[197.440724] Starting dynamic subtest: pipe-A-eDP-1
[200.368794] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.926s)
[200.742902] Starting dynamic subtest: pipe-B-eDP-1
[203.696405] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.961s)
[204.070947] Starting dynamic subtest: pipe-C-eDP-1
[206.997079] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.934s)
[207.359724] Starting dynamic subtest: pipe-D-eDP-1
[210.213284] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.862s)
[210.215570] Subtest crc-atomic: SUCCESS (13.146s)
[211.397666] [050/133] (809s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[211.506706] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[212.142156] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[212.315839] [051/133] (808s left) gen9_exec_parse (allowed-all)
[212.376135] Subtest allowed-all: SKIP (0.000s)
[212.440375] [052/133] (808s left) kms_legacy_colorkey (invalid-plane)
[212.532970] Starting subtest: invalid-plane
[212.535188] Starting dynamic subtest: zero-id
[212.536988] Dynamic subtest zero-id: SUCCESS (0.000s)
[212.545778] Starting dynamic subtest: outrange-id
[212.547835] Dynamic subtest outrange-id: SUCCESS (0.000s)
[212.549902] Subtest invalid-plane: SUCCESS (0.001s)
[212.616406] [053/133] (807s left) kms_psr (fbc-psr2-primary-blt)
[212.706082] Starting subtest: fbc-psr2-primary-blt
[212.708020] Starting dynamic subtest: eDP-1
[212.712065] Dynamic subtest eDP-1: SKIP (0.000s)
[212.716142] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[212.777136] [054/133] (807s left) gem_exec_create (basic)
[212.840759] Starting subtest: basic
[212.842625] Starting dynamic subtest: smem
[214.931313] Dynamic subtest smem: SUCCESS (2.092s)
[214.933728] Subtest basic: SUCCESS (2.094s)
[215.115292] [055/133] (805s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[215.164082] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[215.166355] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[215.256370] [056/133] (805s left) kms_getfb (getfb-handle-protection)
[215.354764] Starting subtest: getfb-handle-protection
[215.374039] Subtest getfb-handle-protection: SUCCESS (0.020s)
[215.484847] [057/133] (805s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[215.589230] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[215.591554] Starting dynamic subtest: pipe-A-eDP-1
[215.614122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.624895] Starting dynamic subtest: pipe-B-eDP-1
[215.646595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.654583] Starting dynamic subtest: pipe-C-eDP-1
[215.676045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.683957] Starting dynamic subtest: pipe-D-eDP-1
[215.705604] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.709633] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[217.866811] [058/133] (802s left) kms_vblank (wait-busy)
[217.957232] Starting subtest: wait-busy
[217.959504] Starting dynamic subtest: pipe-A-eDP-1
[219.833815] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[219.847473] Starting dynamic subtest: pipe-D-eDP-1
[222.437418] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[222.439388] Subtest wait-busy: SUCCESS (4.478s)
[223.237567] [059/133] (797s left) i915_hangman (engine-error-state-capture)
[223.299108] Starting subtest: engine-error-state-capture
[223.301394] Starting dynamic subtest: rcs0
[226.869285] Dynamic subtest rcs0: SUCCESS (3.569s)
[226.880320] Starting dynamic subtest: bcs0
[232.884822] Dynamic subtest bcs0: SUCCESS (6.013s)
[232.896900] Starting dynamic subtest: vcs0
[238.836211] Dynamic subtest vcs0: SUCCESS (5.949s)
[238.848538] Starting dynamic subtest: vcs1
[243.827992] Dynamic subtest vcs1: SUCCESS (4.989s)
[243.839934] Starting dynamic subtest: vecs0
[248.820426] Dynamic subtest vecs0: SUCCESS (4.989s)
[248.832102] Starting dynamic subtest: ccs0
[253.876361] Dynamic subtest ccs0: SUCCESS (5.053s)
[253.879426] Subtest engine-error-state-capture: SUCCESS (30.577s)
[253.964692] [060/133] (766s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[254.022409] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[254.130097] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[254.207746] [061/133] (766s left) gem_create (create-clear)
[254.258598] Starting subtest: create-clear
[254.260855] Starting dynamic subtest: smem0
[287.189219] Dynamic subtest smem0: SUCCESS (32.924s)
[287.191186] Subtest create-clear: SUCCESS (32.926s)
[287.381900] [062/133] (733s left) gem_exec_schedule (smoketest)
[287.562507] Starting subtest: smoketest
[287.564882] Starting dynamic subtest: rcs0
[293.136314] Dynamic subtest rcs0: SUCCESS (5.524s)
[293.151424] Starting dynamic subtest: bcs0
[298.650785] Dynamic subtest bcs0: SUCCESS (5.518s)
[298.663889] Starting dynamic subtest: vcs0
[304.157132] Dynamic subtest vcs0: SUCCESS (5.500s)
[304.168281] Starting dynamic subtest: vcs1
[309.660308] Dynamic subtest vcs1: SUCCESS (5.505s)
[309.676241] Starting dynamic subtest: vecs0
[315.163213] Dynamic subtest vecs0: SUCCESS (5.496s)
[315.175440] Starting dynamic subtest: ccs0
[320.662277] Dynamic subtest ccs0: SUCCESS (5.500s)
[320.664208] Subtest smoketest: SUCCESS (33.052s)
[320.854487] [063/133] (700s left) kms_big_fb (yf-tiled-addfb)
[320.962530] Starting subtest: yf-tiled-addfb
[320.966720] Subtest yf-tiled-addfb: SKIP (0.000s)
[321.069939] [064/133] (699s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[321.173759] Starting subtest: psr-rgb101010-draw-mmap-gtt
[321.178187] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[321.284126] [065/133] (699s left) kms_panel_fitting (legacy)
[321.373154] Starting subtest: legacy
[321.375358] Starting dynamic subtest: pipe-A-eDP-1
[321.916492] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[321.942428] Starting dynamic subtest: pipe-B-eDP-1
[323.470760] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.536s)
[323.497771] Starting dynamic subtest: pipe-C-eDP-1
[324.984455] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[325.010735] Starting dynamic subtest: pipe-D-eDP-1
[326.521276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s)
[326.523494] Subtest legacy: SUCCESS (5.150s)
[327.763738] [066/133] (693s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[327.852383] Starting subtest: random-ccs-data-y-tiled-ccs
[327.854587] Starting dynamic subtest: pipe-A-eDP-1
[327.879043] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.888649] Starting dynamic subtest: pipe-B-eDP-1
[327.912495] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.920626] Starting dynamic subtest: pipe-C-eDP-1
[327.944388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.952718] Starting dynamic subtest: pipe-D-eDP-1
[327.976806] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.980784] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[330.121932] [067/133] (690s left) perf (create-destroy-userspace-config)
[330.261314] Starting subtest: create-destroy-userspace-config
[330.279057] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[330.327809] [068/133] (690s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[330.389827] Starting subtest: yf-tiled-ccs-to-yf-tiled
[330.394078] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[330.571410] [069/133] (690s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[330.673225] Starting subtest: blocking-absolute-wf_vblank-interruptible
[330.675588] Starting dynamic subtest: A-eDP1
[339.383486] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[339.400920] Starting dynamic subtest: B-eDP1
[348.115837] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[348.129086] Starting dynamic subtest: C-eDP1
[356.840255] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[356.852665] Starting dynamic subtest: D-eDP1
[365.575907] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[365.581382] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.907s)
[366.801569] [070/133] (654s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[366.908122] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[366.910385] Starting dynamic subtest: pipe-A-eDP-1
[372.797463] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.894s)
[372.806106] Starting dynamic subtest: pipe-B-eDP-1
[379.482849] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.683s)
[379.485307] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.580s)
[380.366934] [071/133] (640s left) api_intel_bb (delta-check)
[380.427334] Starting subtest: delta-check
[380.430140] Subtest delta-check: SUCCESS (0.005s)
[380.546182] [072/133] (640s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[380.643403] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[380.647652] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[380.747386] [073/133] (640s left) gem_ctx_sseu (invalid-sseu)
[380.801803] Subtest invalid-sseu: SKIP (0.000s)
[380.863801] [074/133] (640s left) gem_exec_flush (basic-wb-rw-before-default)
[380.930571] Starting subtest: basic-wb-rw-before-default
[386.425653] Subtest basic-wb-rw-before-default: SUCCESS (5.497s)
[386.610661] [075/133] (634s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[386.715790] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[387.506899] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[387.668550] [076/133] (633s left) kms_vblank (crtc-id)
[387.762164] Starting subtest: crtc-id
[387.764314] Starting dynamic subtest: pipe-A-eDP-1
[388.204062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[388.216915] Starting dynamic subtest: pipe-D-eDP-1
[389.372326] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[389.374605] Subtest crtc-id: SUCCESS (1.612s)
[390.225190] [077/133] (631s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[390.325735] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[390.330134] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[390.427500] [078/133] (631s left) kms_psr (fbc-psr-primary-mmap-cpu)
[390.520021] Starting subtest: fbc-psr-primary-mmap-cpu
[390.522308] Starting dynamic subtest: eDP-1
[390.526387] Dynamic subtest eDP-1: SKIP (0.000s)
[390.530631] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[390.606359] [079/133] (631s left) kms_content_protection (dp-mst-lic-type-0)
[390.739057] Starting subtest: dp-mst-lic-type-0
[390.743756] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[390.867971] [080/133] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[390.965524] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[390.969969] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[391.058342] [081/133] (630s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[391.144197] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[391.146107] Starting dynamic subtest: pipe-A-default-mode
[392.274512] Dynamic subtest pipe-A-default-mode: SKIP (1.127s)
[392.278762] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.129s)
[392.431774] [082/133] (629s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[392.524173] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[392.615893] [083/133] (629s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[392.706408] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[392.708642] Starting dynamic subtest: pipe-A-eDP-1
[392.850210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[392.860238] Starting dynamic subtest: pipe-B-eDP-1
[392.880907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[392.889425] Starting dynamic subtest: pipe-C-eDP-1
[392.908777] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[392.916819] Starting dynamic subtest: pipe-D-eDP-1
[392.936235] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[392.938189] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[395.107450] [084/133] (626s left) gem_exec_schedule (in-order)
[395.180243] Starting subtest: in-order
[395.182145] Starting dynamic subtest: rcs0
[395.282143] Dynamic subtest rcs0: SUCCESS (0.108s)
[395.291188] Starting dynamic subtest: vcs0
[395.373023] Dynamic subtest vcs0: SUCCESS (0.089s)
[395.384319] Starting dynamic subtest: vcs1
[395.453718] Dynamic subtest vcs1: SUCCESS (0.080s)
[395.462915] Starting dynamic subtest: vecs0
[395.531635] Dynamic subtest vecs0: SUCCESS (0.077s)
[395.540208] Starting dynamic subtest: ccs0
[395.633752] Dynamic subtest ccs0: SUCCESS (0.101s)
[395.636613] Subtest in-order: SUCCESS (0.461s)
[397.001433] [085/133] (624s left) i915_drm_fdinfo (busy-idle-check-all)
[397.041212] Starting subtest: busy-idle-check-all
[397.043436] Starting dynamic subtest: rcs0
[397.047603] Dynamic subtest rcs0: SKIP (0.004s)
[397.057043] Starting dynamic subtest: bcs0
[397.060947] Dynamic subtest bcs0: SKIP (0.000s)
[397.071708] Starting dynamic subtest: vcs0
[397.076146] Dynamic subtest vcs0: SKIP (0.000s)
[397.084074] Starting dynamic subtest: vcs1
[397.088073] Dynamic subtest vcs1: SKIP (0.000s)
[397.096024] Starting dynamic subtest: vecs0
[397.100066] Dynamic subtest vecs0: SKIP (0.000s)
[397.110314] Starting dynamic subtest: ccs0
[397.114279] Dynamic subtest ccs0: SKIP (0.000s)
[397.118210] Subtest busy-idle-check-all: SKIP (0.010s)
[397.156578] [086/133] (624s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[397.272103] Starting subtest: nonblocking-crc-frame-sequence
[397.274308] Starting dynamic subtest: pipe-A-eDP-1
[398.019726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[398.029561] Starting dynamic subtest: pipe-B-eDP-1
[399.417729] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[399.427270] Starting dynamic subtest: pipe-C-eDP-1
[400.808928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[400.818991] Starting dynamic subtest: pipe-D-eDP-1
[402.151520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[402.153750] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.879s)
[402.957074] [087/133] (618s left) vgem_basic (setversion)
[403.003035] Starting subtest: setversion
[403.007331] Subtest setversion: SUCCESS (0.000s)
[403.063350] [088/133] (618s left) gem_eio (wait-wedge-1us)
[403.304036] Starting subtest: wait-wedge-1us
[404.964310] Subtest wait-wedge-1us: SUCCESS (1.658s)
[405.102719] [089/133] (616s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[405.217272] Starting subtest: 2x-flip-vs-cursor-legacy
[405.221588] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[405.363886] [090/133] (616s left) kms_psr (fbc-psr-sprite-render)
[405.456045] Starting subtest: fbc-psr-sprite-render
[405.458356] Starting dynamic subtest: eDP-1
[405.462630] Dynamic subtest eDP-1: SKIP (0.000s)
[405.467075] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[405.531189] [091/133] (616s left) i915_pm_rpm (gem-execbuf)
[407.052513] Starting subtest: gem-execbuf
[407.054982] Starting dynamic subtest: smem0
[409.421351] Dynamic subtest smem0: SUCCESS (2.367s)
[409.423628] Subtest gem-execbuf: SUCCESS (2.369s)
[409.521055] [092/133] (612s left) api_intel_allocator (fork-simple-once)
[409.585893] Starting subtest: fork-simple-once
[409.599439] Subtest fork-simple-once: SUCCESS (0.016s)
[409.711834] [093/133] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[409.824707] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[409.828666] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[409.919574] [094/133] (612s left) gem_userptr_blits (unsync-unmap)
[409.985493] Subtest unsync-unmap: SKIP (0.000s)
[410.098645] [095/133] (612s left) perf_pmu (busy-accuracy-2)
[410.137917] Starting subtest: busy-accuracy-2
[410.140296] Starting dynamic subtest: rcs0
[413.187108] Dynamic subtest rcs0: SUCCESS (3.046s)
[413.196224] Starting dynamic subtest: bcs0
[416.243735] Dynamic subtest bcs0: SUCCESS (3.054s)
[416.255350] Starting dynamic subtest: vcs0
[419.291541] Dynamic subtest vcs0: SUCCESS (3.045s)
[419.303066] Starting dynamic subtest: vcs1
[422.339228] Dynamic subtest vcs1: SUCCESS (3.045s)
[422.350064] Starting dynamic subtest: vecs0
[425.389827] Dynamic subtest vecs0: SUCCESS (3.048s)
[425.402546] Starting dynamic subtest: ccs0
[428.452478] Dynamic subtest ccs0: SUCCESS (3.060s)
[428.454945] Subtest busy-accuracy-2: SUCCESS (18.313s)
[428.583035] [096/133] (593s left) kms_psr (psr2-suspend)
[428.682998] Starting subtest: psr2-suspend
[428.685367] Starting dynamic subtest: eDP-1
[447.101480] Dynamic subtest eDP-1: SUCCESS (3.321s)
[447.103922] Subtest psr2-suspend: SUCCESS (3.322s)
[457.918915] [097/133] (574s left) gem_ctx_persistence (file)
[458.012839] Starting subtest: file
[458.130430] Subtest file: SUCCESS (0.117s)
[458.262154] [098/133] (574s left) kms_frontbuffer_tracking (fbc-2p-rte)
[458.371197] Starting subtest: fbc-2p-rte
[458.375611] Subtest fbc-2p-rte: SKIP (0.000s)
[458.474449] [099/133] (574s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[458.568730] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[465.612411] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.013s)
[465.752684] [100/133] (566s left) kms_cursor_crc (cursor-random-32x32)
[465.898197] Starting subtest: cursor-random-32x32
[465.952137] Subtest cursor-random-32x32: SKIP (0.048s)
[466.244417] [101/133] (566s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[466.326559] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[466.330839] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[467.429354] [102/133] (565s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[467.816925] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[468.637031] [103/133] (564s left) kms_atomic_transition (plane-toggle-modeset-transition)
[468.738563] Starting subtest: plane-toggle-modeset-transition
[468.740776] Starting dynamic subtest: pipe-A-eDP-1
[481.495671] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.742s)
[481.508055] Starting dynamic subtest: pipe-B-eDP-1
[493.948559] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.447s)
[493.951161] Subtest plane-toggle-modeset-transition: SUCCESS (25.195s)
[494.776929] [104/133] (537s left) kms_cursor_crc (cursor-onscreen-32x32)
[494.921365] Starting subtest: cursor-onscreen-32x32
[494.968582] Subtest cursor-onscreen-32x32: SKIP (0.042s)
[495.265526] [105/133] (537s left) gem_mmap_gtt (fault-concurrent-x)
[495.322947] Subtest fault-concurrent-X: SKIP (0.000s)
[495.383611] [106/133] (537s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[495.496720] Starting subtest: basic-flip-after-cursor-atomic
[496.411115] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.914s)
[497.223632] [107/133] (535s left) kms_pm_rpm (fences)
[499.153734] Starting subtest: fences
[499.158471] Subtest fences: SKIP (0.000s)
[499.559866] [108/133] (533s left) kms_flip (basic-flip-vs-wf_vblank)
[499.658427] Starting subtest: basic-flip-vs-wf_vblank
[499.660760] Starting dynamic subtest: A-eDP1
[501.590122] Dynamic subtest A-eDP1: SUCCESS (1.933s)
[501.601638] Starting dynamic subtest: B-eDP1
[503.521426] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[503.534813] Starting dynamic subtest: C-eDP1
[505.439230] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[505.451220] Starting dynamic subtest: D-eDP1
[507.379120] Dynamic subtest D-eDP1: SUCCESS (1.938s)
[507.381268] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.724s)
[508.618492] [109/133] (524s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[509.003418] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[509.822342] [110/133] (523s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[509.945261] Starting subtest: 2x-long-cursor-vs-flip-atomic
[509.949841] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[510.098887] [111/133] (522s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[510.187639] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[510.189881] Starting dynamic subtest: pipe-A-eDP-1
[510.632139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[510.643720] Starting dynamic subtest: pipe-B-eDP-1
[512.132032] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[512.144337] Starting dynamic subtest: pipe-C-eDP-1
[513.583614] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.450s)
[513.596411] Starting dynamic subtest: pipe-D-eDP-1
[514.986645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[514.988485] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.772s)
[516.173028] [112/133] (516s left) gem_exec_whisper (basic-sync-all)
[516.231624] Starting subtest: basic-sync-all
[522.801940] Subtest basic-sync-all: SUCCESS (6.565s)
[522.990536] [113/133] (510s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[523.097612] Starting subtest: extended-modeset-hang-newfb-with-reset
[523.099531] Starting dynamic subtest: pipe-A
[536.992054] Dynamic subtest pipe-A: SUCCESS (13.889s)
[537.002360] Starting dynamic subtest: pipe-D
[552.861956] Dynamic subtest pipe-D: SUCCESS (15.869s)
[552.864375] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.762s)
[553.678083] [114/133] (479s left) syncobj_timeline (wait-any-snapshot)
[553.731975] Starting subtest: wait-any-snapshot
[553.813612] Subtest wait-any-snapshot: SUCCESS (0.081s)
[553.894627] [115/133] (479s left) kms_color (ctm-0-50)
[553.982930] Starting subtest: ctm-0-50
[553.984948] Starting dynamic subtest: pipe-A-eDP-1
[557.479470] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[557.491072] Starting dynamic subtest: pipe-B-eDP-1
[561.782230] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.303s)
[561.793490] Starting dynamic subtest: pipe-C-eDP-1
[565.835213] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.053s)
[565.846510] Starting dynamic subtest: pipe-D-eDP-1
[569.829992] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.991s)
[569.831965] Subtest ctm-0-50: SUCCESS (15.851s)
[570.661846] [116/133] (462s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[570.731361] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[570.810667] [117/133] (462s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[570.916730] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[570.918960] Starting dynamic subtest: pipe-A
[570.936892] Dynamic subtest pipe-A: SKIP (0.017s)
[570.948331] Starting dynamic subtest: pipe-B
[570.968082] Dynamic subtest pipe-B: SKIP (0.030s)
[570.979220] Starting dynamic subtest: pipe-C
[570.999632] Dynamic subtest pipe-C: SKIP (0.030s)
[571.009974] Starting dynamic subtest: pipe-D
[571.029486] Dynamic subtest pipe-D: SKIP (0.030s)
[571.033942] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.110s)
[571.137217] [118/133] (462s left) syncobj_timeline (reset-unsignaled)
[571.198983] Starting subtest: reset-unsignaled
[571.201401] Subtest reset-unsignaled: SUCCESS (0.000s)
[571.315564] [119/133] (462s left) gem_exec_whisper (basic-fds-forked-all)
[571.379514] Starting subtest: basic-fds-forked-all
[592.944850] Subtest basic-fds-forked-all: SUCCESS (21.559s)
[593.144891] [120/133] (440s left) prime_mmap (test_forked)
[593.192194] Starting subtest: test_forked
[593.194425] Starting dynamic subtest: test_forked-smem
[593.230001] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[593.232385] Subtest test_forked: SUCCESS (0.042s)
[593.339646] [121/133] (440s left) kms_psr (psr-cursor-render)
[593.432729] Starting subtest: psr-cursor-render
[593.435008] Starting dynamic subtest: eDP-1
[595.164135] Dynamic subtest eDP-1: SUCCESS (1.732s)
[595.166526] Subtest psr-cursor-render: SUCCESS (1.733s)
[596.030376] [122/133] (437s left) gem_ctx_param (set-priority-range)
[596.079211] Starting subtest: set-priority-range
[596.092925] Subtest set-priority-range: SUCCESS (0.014s)
[596.194047] [123/133] (437s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[596.303349] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[597.394987] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.093s)
[597.532300] [124/133] (436s left) syncobj_wait (wait-for-submit-delayed-submit)
[597.586146] Starting subtest: wait-for-submit-delayed-submit
[597.690060] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[597.772179] [125/133] (435s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[597.887278] Starting subtest: flip-vs-cursor-toggle
[606.856608] Subtest flip-vs-cursor-toggle: SUCCESS (8.966s)
[607.667682] [126/133] (425s left) gem_ctx_param (invalid-size-set)
[607.730373] Starting subtest: invalid-size-set
[607.732758] Subtest invalid-size-set: SUCCESS (0.001s)
[607.830172] [127/133] (425s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[607.921627] Starting subtest: plane-all-modeset-transition-internal-panels
[607.923679] Starting dynamic subtest: pipe-A-eDP-1
[609.214442] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.293s)
[609.495089] Starting dynamic subtest: pipe-B-eDP-1
[610.544002] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.061s)
[610.823311] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.900s)
[611.672108] [128/133] (422s left) gem_softpin (evict-single-offset)
[611.724944] Starting subtest: evict-single-offset
[638.032337] Subtest evict-single-offset: SUCCESS (26.297s)
[638.120794] [129/133] (395s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[638.259321] Starting subtest: flip-vs-dpms-on-nop-interruptible
[638.261274] Starting dynamic subtest: A-eDP1
[640.160065] Dynamic subtest A-eDP1: SUCCESS (1.898s)
[640.177067] Starting dynamic subtest: B-eDP1
[641.990726] Dynamic subtest B-eDP1: SUCCESS (1.828s)
[642.005044] Starting dynamic subtest: C-eDP1
[643.811049] Dynamic subtest C-eDP1: SUCCESS (1.817s)
[643.822255] Starting dynamic subtest: D-eDP1
[645.642487] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[645.647802] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.385s)
[646.830370] [130/133] (387s left) kms_rmfb (close-fd)
[646.925503] Starting subtest: close-fd
[646.927391] Starting dynamic subtest: pipe-A-eDP-1
[647.032839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[647.045103] Starting dynamic subtest: pipe-B-eDP-1
[648.198204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[648.211073] Starting dynamic subtest: pipe-C-eDP-1
[649.333234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[649.346325] Starting dynamic subtest: pipe-D-eDP-1
[650.462466] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[650.464690] Subtest close-fd: SUCCESS (3.538s)
[651.586764] [131/133] (382s left) kms_atomic_interruptible (legacy-dpms)
[651.689639] Starting subtest: legacy-dpms
[651.691874] Starting dynamic subtest: pipe-A-eDP-1
[659.121481] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.427s)
[659.124084] Subtest legacy-dpms: SUCCESS (7.429s)
[659.961144] [132/133] (373s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[660.058022] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[666.617668] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.562s)
[666.746369] [133/133] (367s left) i915_pm_rps (thresholds-idle)
[666.818249] Starting subtest: thresholds-idle
[666.822607] Subtest thresholds-idle: SKIP (0.001s)
[666.930369] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: gem_exec_alignment
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: core_hotunplug
results: parsing output: 9/ for test: kms_selftest
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_cursor_edge_walk
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_ctx_param
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_vm_create
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: gem_busy
results: parsing output: 40/ for test: kms_draw_crc
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_dp_link_training
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_legacy_colorkey
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: i915_hangman
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_create
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_panel_fitting
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_sseu
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: vgem_basic
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: gem_fenced_exec_thrash
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_rmfb
results: parsing output: 130/ for test: kms_atomic_interruptible
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: i915_pm_rps
Done.