[56.287590] Initializing watchdogs
[56.287636]   /dev/watchdog0
[56.302954] [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]
[56.307563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.309808] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.313094] [001/133] (960s left) gem_softpin (softpin)
[56.395591] Starting subtest: softpin
[88.837429] Subtest softpin: SUCCESS (32.315s)
[88.989954] [002/133] (927s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[93.973652] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[93.978562] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[94.855914] [003/133] (922s left) syncobj_wait (single-wait-submitted)
[94.915173] Starting subtest: single-wait-submitted
[95.024951] Subtest single-wait-submitted: SUCCESS (0.109s)
[95.104547] [004/133] (921s left) perf (invalid-oa-metric-set-id)
[95.228202] Starting subtest: invalid-oa-metric-set-id
[95.238922] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[95.280302] [005/133] (921s left) gem_lmem_swapping (massive)
[95.323674] Subtest massive: SKIP (0.000s)
[95.362441] [006/133] (921s left) gem_mmap_gtt (basic-write-read)
[95.418971] Subtest basic-write-read: SKIP (0.000s)
[95.483126] [007/133] (921s left) gem_exec_schedule (pi-ringfull)
[95.672144] Starting subtest: pi-ringfull
[95.674254] Starting dynamic subtest: rcs0
[95.747805] Dynamic subtest rcs0: SUCCESS (0.078s)
[95.758420] Starting dynamic subtest: bcs0
[95.774359] Dynamic subtest bcs0: SUCCESS (0.026s)
[95.784613] Starting dynamic subtest: vcs0
[95.801051] Dynamic subtest vcs0: SUCCESS (0.026s)
[95.812433] Starting dynamic subtest: vcs1
[95.827742] Dynamic subtest vcs1: SUCCESS (0.026s)
[95.838430] Starting dynamic subtest: vecs0
[95.855314] Dynamic subtest vecs0: SUCCESS (0.027s)
[95.865694] Starting dynamic subtest: ccs0
[95.882037] Dynamic subtest ccs0: SUCCESS (0.026s)
[95.884284] Subtest pi-ringfull: SUCCESS (0.213s)
[96.141489] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[96.144450] [008/133] (920s left) kms_feature_discovery (display)
[96.237336] Starting subtest: display
[96.239475] Subtest display: SUCCESS (0.000s)
[96.320705] [009/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[96.421503] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[96.425708] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[96.559540] [010/133] (920s left) kms_getfb (getfb-handle-closed)
[96.655971] Starting subtest: getfb-handle-closed
[96.658360] Subtest getfb-handle-closed: SUCCESS (0.000s)
[96.784196] [011/133] (920s left) perf (invalid-oa-exponent)
[96.883740] Starting subtest: invalid-oa-exponent
[96.896149] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[96.939393] [012/133] (920s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[96.988072] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[97.097035] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[97.185849] [013/133] (920s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[97.290455] Starting subtest: 4-tiled-32bpp-rotate-0
[98.635343] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.344s)
[98.815052] [014/133] (918s left) i915_suspend (fence-restore-tiled2untiled)
[98.869024] Starting subtest: fence-restore-tiled2untiled
[98.872389] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[98.978456] [015/133] (918s left) api_intel_allocator (execbuf-with-allocator)
[99.031024] Starting subtest: execbuf-with-allocator
[99.033599] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[99.189737] [016/133] (918s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[99.267997] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[99.270081] Starting dynamic subtest: pipe-A
[100.318401] Dynamic subtest pipe-A: SUCCESS (1.050s)
[100.327135] Starting dynamic subtest: pipe-B
[102.446193] Dynamic subtest pipe-B: SUCCESS (2.127s)
[102.454881] Starting dynamic subtest: pipe-C
[103.649091] Dynamic subtest pipe-C: SUCCESS (1.202s)
[103.658639] Starting dynamic subtest: pipe-D
[104.884502] Dynamic subtest pipe-D: SUCCESS (1.235s)
[104.886877] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.615s)
[106.094215] [017/133] (911s left) kms_psr (psr2-sprite-mmap-gtt)
[106.190522] Starting subtest: psr2-sprite-mmap-gtt
[106.192749] Starting dynamic subtest: eDP-1
[107.600313] Dynamic subtest eDP-1: SKIP (1.407s)
[107.605337] Subtest psr2-sprite-mmap-gtt: SKIP (1.408s)
[107.787811] [018/133] (909s left) gem_exec_whisper (basic-contexts-forked)
[107.853617] Starting subtest: basic-contexts-forked
[131.378932] Subtest basic-contexts-forked: SUCCESS (23.518s)
[131.570898] [019/133] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[131.667203] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[131.669600] Starting dynamic subtest: pipe-A-default-mode
[131.963957] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[131.968554] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.295s)
[132.770820] [020/133] (884s left) gem_wait (write-wait)
[132.835467] Starting subtest: write-wait
[132.837885] Starting dynamic subtest: all-engines
[134.003605] Dynamic subtest all-engines: SUCCESS (1.168s)
[134.014826] Starting dynamic subtest: rcs0
[135.070502] Dynamic subtest rcs0: SUCCESS (1.066s)
[135.087576] Starting dynamic subtest: bcs0
[136.132079] Dynamic subtest bcs0: SUCCESS (1.060s)
[136.147361] Starting dynamic subtest: vcs0
[137.190649] Dynamic subtest vcs0: SUCCESS (1.056s)
[137.206042] Starting dynamic subtest: vcs1
[138.245618] Dynamic subtest vcs1: SUCCESS (1.054s)
[138.261906] Starting dynamic subtest: vecs0
[139.297320] Dynamic subtest vecs0: SUCCESS (1.050s)
[139.312342] Starting dynamic subtest: ccs0
[140.353146] Dynamic subtest ccs0: SUCCESS (1.054s)
[140.355598] Subtest write-wait: SUCCESS (7.519s)
[140.575967] [021/133] (877s left) perf_pmu (semaphore-wait)
[140.612815] Starting subtest: semaphore-wait
[140.614873] Starting dynamic subtest: rcs0
[141.128052] Dynamic subtest rcs0: SUCCESS (0.515s)
[141.139322] Starting dynamic subtest: bcs0
[141.642828] Dynamic subtest bcs0: SUCCESS (0.512s)
[141.653723] Starting dynamic subtest: vcs0
[142.157388] Dynamic subtest vcs0: SUCCESS (0.513s)
[142.168319] Starting dynamic subtest: vcs1
[142.672029] Dynamic subtest vcs1: SUCCESS (0.513s)
[142.682041] Starting dynamic subtest: vecs0
[143.186733] Dynamic subtest vecs0: SUCCESS (0.513s)
[143.197568] Starting dynamic subtest: ccs0
[143.702918] Dynamic subtest ccs0: SUCCESS (0.514s)
[143.706271] Subtest semaphore-wait: SUCCESS (3.091s)
[144.929184] [022/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[145.028181] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[145.032181] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[145.154402] [023/133] (872s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[145.238401] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[145.240785] Starting dynamic subtest: pipe-A-eDP-1
[145.264166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.273497] Starting dynamic subtest: pipe-B-eDP-1
[145.295189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.303737] Starting dynamic subtest: pipe-C-eDP-1
[145.325439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.334268] Starting dynamic subtest: pipe-D-eDP-1
[145.357610] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.361787] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[147.538399] [024/133] (870s left) gem_eio (wait-immediate)
[147.721110] Starting subtest: wait-immediate
[148.006296] Subtest wait-immediate: SUCCESS (0.286s)
[148.185260] [025/133] (869s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[148.284108] Starting subtest: primary-y-tiled-reflect-x-0
[148.344554] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[148.461051] [026/133] (869s left) drm_read (fault-buffer)
[148.602714] Starting subtest: fault-buffer
[148.604723] Subtest fault-buffer: SUCCESS (0.001s)
[148.793442] [027/133] (869s left) gem_unref_active_buffers
[149.012365] [028/133] (868s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[154.002411] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[154.004751] Starting dynamic subtest: pipe-A-eDP-1
[160.557898] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.555s)
[160.567476] Starting dynamic subtest: pipe-B-eDP-1
[167.199095] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[167.201432] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.196s)
[168.105757] [029/133] (849s left) kms_addfb_basic (addfb25-modifier-no-flag)
[168.200985] Starting subtest: addfb25-modifier-no-flag
[168.203219] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[168.333966] [030/133] (849s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[168.428502] Starting subtest: fbc-psr2-primary-mmap-cpu
[168.430481] Starting dynamic subtest: eDP-1
[168.434592] Dynamic subtest eDP-1: SKIP (0.000s)
[168.438659] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[168.511459] [031/133] (849s left) perf_pmu (interrupts-sync)
[168.552409] Starting subtest: interrupts-sync
[169.647776] Subtest interrupts-sync: SUCCESS (1.096s)
[169.782160] [032/133] (848s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[169.883606] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[176.688879] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.808s)
[176.869357] [033/133] (841s left) kms_atomic (plane-invalid-params)
[176.963095] Starting subtest: plane-invalid-params
[176.965411] Starting dynamic subtest: pipe-A-eDP-1
[177.360235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[177.362497] Subtest plane-invalid-params: SUCCESS (0.398s)
[178.253299] [034/133] (839s left) kms_cursor_crc (cursor-onscreen-128x128)
[178.468281] Starting subtest: cursor-onscreen-128x128
[178.473202] Starting dynamic subtest: pipe-A-eDP-1
[180.571546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[180.597690] Starting dynamic subtest: pipe-D-eDP-1
[183.302174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[183.304056] Subtest cursor-onscreen-128x128: SUCCESS (4.831s)
[184.128308] [035/133] (834s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[184.265197] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[184.357624] [036/133] (833s left) kms_selftest (drm_plane_helper)
[184.393826] Starting subtest: drm_plane_helper
[184.414198] Starting dynamic subtest: drm_test_check_plane_state
[184.547222] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.132s)
[184.555778] Starting dynamic subtest: drm_test_check_invalid_plane_state
[184.696562] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.147s)
[184.698759] Subtest drm_plane_helper: SUCCESS (0.300s)
[184.883365] [037/133] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[184.989803] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[191.901384] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.913s)
[192.072126] [038/133] (826s left) kms_psr (psr-primary-render)
[192.174928] Starting subtest: psr-primary-render
[192.177179] Starting dynamic subtest: eDP-1
[193.943395] Dynamic subtest eDP-1: SUCCESS (1.769s)
[193.945733] Subtest psr-primary-render: SUCCESS (1.770s)
[194.834710] [039/133] (823s left) kms_flip (absolute-wf_vblank-interruptible)
[194.928958] Starting subtest: absolute-wf_vblank-interruptible
[194.931303] Starting dynamic subtest: A-eDP1
[203.658607] Dynamic subtest A-eDP1: SUCCESS (8.728s)
[203.669157] Starting dynamic subtest: B-eDP1
[212.396378] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[212.406249] Starting dynamic subtest: C-eDP1
[221.106382] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[221.115222] Starting dynamic subtest: D-eDP1
[229.828608] Dynamic subtest D-eDP1: SUCCESS (8.719s)
[229.833574] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.903s)
[231.054133] [040/133] (787s left) kms_content_protection (dp-mst-lic-type-0)
[231.199171] Starting subtest: dp-mst-lic-type-0
[231.204210] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[231.349953] [041/133] (787s left) kms_lease (lessee-list)
[231.434817] Starting subtest: lessee-list
[231.437196] Starting dynamic subtest: pipe-A-eDP-1
[231.439532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[231.449081] Starting dynamic subtest: pipe-B-eDP-1
[231.451067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.459427] Starting dynamic subtest: pipe-C-eDP-1
[231.461328] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[231.469335] Starting dynamic subtest: pipe-D-eDP-1
[231.471168] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[231.473028] Subtest lessee-list: SUCCESS (0.008s)
[231.570065] [042/133] (786s left) gem_exec_reloc (basic-wc-noreloc)
[231.624747] Subtest basic-wc-noreloc: SKIP (0.000s)
[231.704237] [043/133] (786s left) gem_exec_params (dr1-dirt)
[231.775985] Starting subtest: DR1-dirt
[231.777917] Subtest DR1-dirt: SUCCESS (0.000s)
[231.906783] [044/133] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[232.007264] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[238.611433] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.605s)
[238.749517] [045/133] (779s left) gem_eio (in-flight-contexts-immediate)
[238.967868] Starting subtest: in-flight-contexts-immediate
[252.906719] Subtest in-flight-contexts-immediate: SUCCESS (13.938s)
[253.084479] [046/133] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[253.197464] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[260.656419] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.458s)
[260.825104] [047/133] (757s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[260.876744] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[260.941073] [048/133] (757s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[261.060560] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[272.220785] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.159s)
[273.048019] [049/133] (745s left) syncobj_timeline (multi-wait-all-available-submitted)
[273.105481] Starting subtest: multi-wait-all-available-submitted
[273.107457] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[273.224860] [050/133] (745s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[273.323704] Starting subtest: extended-modeset-hang-newfb-with-reset
[273.326058] Starting dynamic subtest: pipe-A
[287.170566] Dynamic subtest pipe-A: SUCCESS (13.845s)
[287.180282] Starting dynamic subtest: pipe-D
[302.857491] Dynamic subtest pipe-D: SUCCESS (15.681s)
[302.859404] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.530s)
[303.674684] [051/133] (715s left) gem_fence_thrash (bo-copy)
[303.715657] Starting subtest: bo-copy
[303.743611] Subtest bo-copy: SKIP (0.026s)
[303.809192] [052/133] (715s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[304.196951] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[304.964402] [053/133] (713s left) gem_reg_read (timestamp-monotonic)
[305.007219] Starting subtest: timestamp-monotonic
[309.230982] Subtest timestamp-monotonic: SUCCESS (4.204s)
[309.295883] [054/133] (709s left) kms_dirtyfb (default-dirtyfb-ioctl)
[309.392354] Starting subtest: default-dirtyfb-ioctl
[309.394576] Starting dynamic subtest: A-eDP-1
[310.967718] Dynamic subtest A-eDP-1: SUCCESS (1.577s)
[310.970168] Subtest default-dirtyfb-ioctl: SUCCESS (1.578s)
[311.833382] [055/133] (707s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[311.931767] Starting subtest: y-tiled-16bpp-rotate-180
[311.936199] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[312.052760] [056/133] (706s left) kms_getfb (getfb2-handle-closed)
[312.150461] Starting subtest: getfb2-handle-closed
[312.152795] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[312.273911] [057/133] (706s left) gem_userptr_blits (sync-unmap-cycles)
[312.340414] Starting subtest: sync-unmap-cycles
[317.718759] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[317.891955] [058/133] (701s left) gem_exec_balancer (sequential)
[317.956445] Starting subtest: sequential
[321.022794] Subtest sequential: SUCCESS (3.066s)
[321.374443] [059/133] (697s left) gem_softpin (allocator-nopin)
[321.433213] Starting subtest: allocator-nopin
[321.522733] Subtest allocator-nopin: SUCCESS (0.089s)
[321.669947] [060/133] (697s left) kms_cursor_edge_walk (256x256-top-edge)
[321.767949] Starting subtest: 256x256-top-edge
[321.770237] Starting dynamic subtest: pipe-A-eDP-1
[325.189079] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[325.199043] Starting dynamic subtest: pipe-D-eDP-1
[328.296855] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[328.299071] Subtest 256x256-top-edge: SUCCESS (6.529s)
[329.142446] [061/133] (690s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[329.240216] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[329.242496] Starting dynamic subtest: pipe-A-eDP-1
[329.264644] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.275061] Starting dynamic subtest: pipe-B-eDP-1
[329.295740] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.304602] Starting dynamic subtest: pipe-C-eDP-1
[329.325614] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.335510] Starting dynamic subtest: pipe-D-eDP-1
[329.357060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.361416] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[331.477471] [062/133] (687s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[331.575445] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[331.577661] Starting dynamic subtest: pipe-A-eDP-1
[332.301724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[332.312277] Starting dynamic subtest: pipe-B-eDP-1
[334.098349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[334.109032] Starting dynamic subtest: pipe-C-eDP-1
[335.932758] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[335.943036] Starting dynamic subtest: pipe-D-eDP-1
[337.752181] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.818s)
[337.754349] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.171s)
[338.926436] [063/133] (680s left) gem_busy (extended)
[339.115859] Starting subtest: extended
[339.118183] Starting dynamic subtest: rcs0
[339.190046] Dynamic subtest rcs0: SUCCESS (0.077s)
[339.201810] Starting dynamic subtest: bcs0
[339.229424] Dynamic subtest bcs0: SUCCESS (0.038s)
[339.239241] Starting dynamic subtest: vcs0
[340.885406] Dynamic subtest vcs0: SUCCESS (1.653s)
[340.896577] Starting dynamic subtest: vcs1
[342.933596] Dynamic subtest vcs1: SUCCESS (2.044s)
[342.950556] Starting dynamic subtest: vecs0
[344.916295] Dynamic subtest vecs0: SUCCESS (1.980s)
[344.928675] Starting dynamic subtest: ccs0
[344.962986] Dynamic subtest ccs0: SUCCESS (0.046s)
[344.965681] Subtest extended: SUCCESS (5.851s)
[345.233035] [064/133] (674s left) gem_eio (create-ext)
[345.469394] Starting subtest: create-ext
[345.825476] Subtest create-ext: SUCCESS (0.356s)
[346.004833] [065/133] (673s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[346.059726] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[346.063956] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[346.251398] [066/133] (673s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[346.350134] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[346.352346] Starting dynamic subtest: pipe-A
[347.477350] Dynamic subtest pipe-A: SUCCESS (1.129s)
[347.485653] Starting dynamic subtest: pipe-B
[349.659354] Dynamic subtest pipe-B: SUCCESS (2.181s)
[349.669717] Starting dynamic subtest: pipe-C
[350.818186] Dynamic subtest pipe-C: SUCCESS (1.156s)
[350.827612] Starting dynamic subtest: pipe-D
[351.957585] Dynamic subtest pipe-D: SUCCESS (1.138s)
[351.959941] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.611s)
[353.150156] [067/133] (666s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[353.248037] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[353.250285] Starting dynamic subtest: pipe-A-default-mode
[353.535483] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[353.539808] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.287s)
[354.378913] [068/133] (665s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[354.761166] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[355.597594] [069/133] (663s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[355.689047] Starting subtest: psr-rgb101010-draw-mmap-cpu
[362.768470] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.082s)
[362.886144] [070/133] (656s left) gem_exec_balancer (noheartbeat)
[363.143224] Starting subtest: noheartbeat
[363.148086] Subtest noheartbeat: SKIP (0.000s)
[363.257499] [071/133] (656s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[363.357032] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[363.359221] Starting dynamic subtest: pipe-A-eDP-1
[364.220082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s)
[364.230904] Starting dynamic subtest: pipe-B-eDP-1
[365.743320] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.521s)
[365.753055] Starting dynamic subtest: pipe-C-eDP-1
[367.256440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[367.266463] Starting dynamic subtest: pipe-D-eDP-1
[368.803794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[368.806100] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.439s)
[370.074085] [072/133] (649s left) gem_ctx_isolation (nonpriv)
[370.131199] Starting subtest: nonpriv
[370.133505] Starting dynamic subtest: rcs0
[370.367116] Dynamic subtest rcs0: SUCCESS (0.236s)
[370.378765] Starting dynamic subtest: bcs0
[370.630481] Dynamic subtest bcs0: SUCCESS (0.263s)
[370.642080] Starting dynamic subtest: vcs0
[370.910601] Dynamic subtest vcs0: SUCCESS (0.279s)
[370.919723] Starting dynamic subtest: vcs1
[372.159110] Dynamic subtest vcs1: SUCCESS (1.247s)
[372.169983] Starting dynamic subtest: vecs0
[374.148520] Dynamic subtest vecs0: SUCCESS (1.988s)
[374.159990] Starting dynamic subtest: ccs0
[376.176027] Dynamic subtest ccs0: SUCCESS (2.027s)
[376.178384] Subtest nonpriv: SUCCESS (6.045s)
[376.427374] [073/133] (643s left) gem_fence_thrash (bo-write-verify-threaded-none)
[376.459590] Starting subtest: bo-write-verify-threaded-none
[376.475414] Subtest bo-write-verify-threaded-none: SKIP (0.015s)
[376.539203] [074/133] (643s left) kms_cursor_crc (cursor-size-hints)
[376.671300] Starting subtest: cursor-size-hints
[376.673298] Starting dynamic subtest: pipe-A-eDP-1
[377.277430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[377.286189] Starting dynamic subtest: pipe-D-eDP-1
[378.512611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[378.514896] Subtest cursor-size-hints: SUCCESS (1.842s)
[379.324431] [075/133] (640s left) gem_exec_parallel (fds)
[379.386667] Starting subtest: fds
[379.388965] Starting dynamic subtest: rcs0
[382.269926] Dynamic subtest rcs0: SUCCESS (2.881s)
[382.281791] Starting dynamic subtest: bcs0
[386.727269] Dynamic subtest bcs0: SUCCESS (4.454s)
[386.738611] Starting dynamic subtest: vcs0
[391.092938] Dynamic subtest vcs0: SUCCESS (4.364s)
[391.105300] Starting dynamic subtest: vcs1
[395.173436] Dynamic subtest vcs1: SUCCESS (4.077s)
[395.185683] Starting dynamic subtest: vecs0
[399.179078] Dynamic subtest vecs0: SUCCESS (4.005s)
[399.191275] Starting dynamic subtest: ccs0
[403.091249] Dynamic subtest ccs0: SUCCESS (3.909s)
[403.093960] Subtest fds: SUCCESS (23.701s)
[403.302457] [076/133] (616s left) kms_vrr (flip-basic)
[403.392912] Starting subtest: flip-basic
[403.399159] Subtest flip-basic: SKIP (0.000s)
[403.474819] [077/133] (616s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[403.567777] Starting subtest: yf-tiled-8bpp-rotate-270
[403.572144] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[403.677410] [078/133] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[403.773204] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[403.777158] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[403.895067] [079/133] (616s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[403.947795] Starting subtest: wait-all-for-submit-delayed-submit
[404.051972] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[404.141380] [080/133] (615s left) gem_ccs (ctrl-surf-copy-new-ctx)
[404.200855] Starting subtest: ctrl-surf-copy-new-ctx
[404.205115] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[404.337101] [081/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[404.434673] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[404.438845] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[404.551411] [082/133] (615s left) gem_exec_flush (basic-batch-kernel-default-uc)
[404.617507] Starting subtest: basic-batch-kernel-default-uc
[411.485277] Subtest basic-batch-kernel-default-uc: SUCCESS (6.868s)
[411.683710] [083/133] (608s left) gem_pxp (create-regular-context-1)
[411.811289] Starting subtest: create-regular-context-1
[411.813709] Subtest create-regular-context-1: SUCCESS (0.002s)
[411.948098] [084/133] (608s left) gem_exec_reloc (basic-gtt-cpu)
[412.004812] Subtest basic-gtt-cpu: SKIP (0.000s)
[412.088373] [085/133] (608s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[412.195148] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[418.930395] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.736s)
[419.069955] [086/133] (601s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[419.141189] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[419.228412] [087/133] (601s left) syncobj_wait (wait-all-snapshot)
[419.279278] Starting subtest: wait-all-snapshot
[419.359998] Subtest wait-all-snapshot: SUCCESS (0.081s)
[419.450473] [088/133] (600s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[419.559275] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[420.360670] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[420.591857] [089/133] (599s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[420.686821] Starting subtest: yf-tiled-64bpp-rotate-180
[420.691196] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[420.801708] [090/133] (599s left) gen9_exec_parse (allowed-all)
[420.864132] Subtest allowed-all: SKIP (0.000s)
[420.950132] [091/133] (599s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[420.999492] Starting subtest: protected-encrypted-src-copy-not-readible
[421.112746] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[421.242490] [092/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[421.326522] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[428.622452] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.297s)
[428.780410] [093/133] (591s left) syncobj_timeline (reset-multiple-signaled)
[428.829698] Starting subtest: reset-multiple-signaled
[428.831957] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[428.952123] [094/133] (591s left) kms_colorop (plane-xr24-xr24-3dlut_17_12_rgb)
[429.074183] Subtest plane-XR24-XR24-3dlut_17_12_rgb: SKIP (0.000s)
[429.156193] [095/133] (591s left) gem_mmap_gtt (basic-write-read-distinct)
[429.216124] Subtest basic-write-read-distinct: SKIP (0.000s)
[429.274068] [096/133] (591s left) kms_psr (pr-cursor-blt)
[429.365431] Starting subtest: pr-cursor-blt
[429.369842] Subtest pr-cursor-blt: SKIP (0.000s)
[429.454457] [097/133] (591s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[434.457107] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[434.461582] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[435.322752] [098/133] (585s left) kms_plane_alpha_blend (alpha-transparent-fb)
[435.419153] Starting subtest: alpha-transparent-fb
[435.711958] Starting dynamic subtest: pipe-A-eDP-1
[436.343935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[436.354560] Starting dynamic subtest: pipe-D-eDP-1
[437.633835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[437.636131] Subtest alpha-transparent-fb: SUCCESS (2.215s)
[438.480178] [099/133] (582s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[438.583476] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[442.793088] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.213s)
[443.977659] [100/133] (576s left) kms_colorop (plane-xr30-xr30-pq_eotf-pq_inv_eotf)
[444.108683] Subtest plane-XR30-XR30-pq_eotf-pq_inv_eotf: SKIP (0.000s)
[444.190030] [101/133] (576s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[444.296096] Starting subtest: x-tiled-16bpp-rotate-90
[444.317529] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[444.440568] [102/133] (576s left) gem_mmap_offset (mmap-unmap)
[444.494036] Starting subtest: mmap-unmap
[444.495962] Starting dynamic subtest: smem0
[466.764253] Dynamic subtest smem0: SUCCESS (22.269s)
[466.766777] Subtest mmap-unmap: SUCCESS (22.269s)
[466.917470] [103/133] (554s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[467.491725] Starting subtest: syncobj-timeline-multiple-ext-nodes
[467.496676] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[468.977782] [104/133] (551s left) gem_exec_reloc (basic-write-read-active)
[469.040665] Subtest basic-write-read-active: SKIP (0.000s)
[469.114929] [105/133] (551s left) i915_getparams_basic (basic-subslice-total)
[469.175763] Starting subtest: basic-subslice-total
[469.180354] Subtest basic-subslice-total: SUCCESS (0.000s)
[469.283110] [106/133] (551s left) device_reset (cold-reset-bound)
[469.333087] Starting subtest: cold-reset-bound
[469.337301] Subtest cold-reset-bound: SKIP (0.000s)
[469.420240] [107/133] (551s left) api_intel_bb (full-batch)
[469.471981] Starting subtest: full-batch
[469.482200] Subtest full-batch: SUCCESS (0.011s)
[469.642640] [108/133] (551s left) gem_userptr_blits (sync-unmap-after-close)
[469.704919] Starting subtest: sync-unmap-after-close
[469.716939] Subtest sync-unmap-after-close: SUCCESS (0.014s)
[469.883754] [109/133] (551s left) kms_async_flips (alternate-sync-async-flip-atomic)
[469.977448] Starting subtest: alternate-sync-async-flip-atomic
[470.358190] Starting dynamic subtest: pipe-A-eDP-1
[471.725680] Dynamic subtest pipe-A-eDP-1: FAIL (0.781s)
[471.735627] Starting dynamic subtest: pipe-B-eDP-1
[472.638771] Dynamic subtest pipe-B-eDP-1: FAIL (0.737s)
[472.649984] Starting dynamic subtest: pipe-C-eDP-1
[475.388504] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[475.753674] Starting dynamic subtest: pipe-D-eDP-1
[478.521771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[478.523614] Subtest alternate-sync-async-flip-atomic: FAIL (8.545s)
[479.697308] [110/133] (541s left) gem_ctx_persistence (heartbeat-hang)
[479.759561] Starting subtest: heartbeat-hang
[479.763962] Subtest heartbeat-hang: SKIP (0.000s)
[479.922427] [111/133] (541s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[480.015225] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[480.017537] Starting dynamic subtest: pipe-A
[480.078302] Dynamic subtest pipe-A: SUCCESS (0.066s)
[480.089707] Starting dynamic subtest: pipe-B
[481.208776] Dynamic subtest pipe-B: SUCCESS (1.129s)
[481.220082] Starting dynamic subtest: pipe-C
[482.319726] Dynamic subtest pipe-C: SUCCESS (1.109s)
[482.331300] Starting dynamic subtest: pipe-D
[483.466495] Dynamic subtest pipe-D: SUCCESS (1.145s)
[483.468818] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.454s)
[484.618309] [112/133] (536s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[484.736644] Starting subtest: cursor-vs-flip-atomic-transitions
[514.600905] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.863s)
[515.458346] [113/133] (505s left) gem_exec_schedule (semaphore-user)
[515.528545] Starting subtest: semaphore-user
[515.578491] Subtest semaphore-user: SUCCESS (0.057s)
[516.936323] [114/133] (504s left) syncobj_timeline (host-signal-points)
[516.993195] Starting subtest: host-signal-points
[516.995407] Subtest host-signal-points: SUCCESS (0.004s)
[517.123022] [115/133] (504s left) i915_drm_fdinfo (busy-idle-check-all)
[517.156664] Starting subtest: busy-idle-check-all
[517.158689] Starting dynamic subtest: rcs0
[517.163388] Dynamic subtest rcs0: SKIP (0.004s)
[517.174173] Starting dynamic subtest: bcs0
[517.178468] Dynamic subtest bcs0: SKIP (0.001s)
[517.187187] Starting dynamic subtest: vcs0
[517.191341] Dynamic subtest vcs0: SKIP (0.000s)
[517.200215] Starting dynamic subtest: vcs1
[517.204533] Dynamic subtest vcs1: SKIP (0.000s)
[517.213281] Starting dynamic subtest: vecs0
[517.217635] Dynamic subtest vecs0: SKIP (0.000s)
[517.226886] Starting dynamic subtest: ccs0
[517.231914] Dynamic subtest ccs0: SKIP (0.000s)
[517.236486] Subtest busy-idle-check-all: SKIP (0.011s)
[517.275039] [116/133] (504s left) kms_flip (2x-nonexisting-fb)
[517.426272] Starting subtest: 2x-nonexisting-fb
[517.434258] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[517.522606] [117/133] (503s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[517.610188] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[517.612353] Starting dynamic subtest: pipe-A-eDP-1
[518.026386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[518.038061] Starting dynamic subtest: pipe-B-eDP-1
[518.055836] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[518.065188] Starting dynamic subtest: pipe-C-eDP-1
[518.080284] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[518.088651] Starting dynamic subtest: pipe-D-eDP-1
[518.104992] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[518.106641] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.431s)
[520.307661] [118/133] (501s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[520.410686] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[520.414972] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[520.537519] [119/133] (501s left) perf_pmu (event-wait)
[520.577533] Starting subtest: event-wait
[520.579949] Starting dynamic subtest: rcs0
[520.584491] Dynamic subtest rcs0: SKIP (0.000s)
[520.588826] Subtest event-wait: SKIP (0.001s)
[520.710651] [120/133] (500s left) i915_pm_rc6_residency (media-rc6-accuracy)
[520.754749] Starting subtest: media-rc6-accuracy
[520.758725] Subtest media-rc6-accuracy: SKIP (0.000s)
[520.886214] [121/133] (500s left) gem_exec_parallel (engines)
[520.942694] Starting subtest: engines
[520.944896] Starting dynamic subtest: basic
[522.900267] Dynamic subtest basic: SUCCESS (1.955s)
[522.911950] Starting dynamic subtest: contexts
[527.319876] Dynamic subtest contexts: SUCCESS (4.416s)
[527.329045] Starting dynamic subtest: fds
[531.165431] Dynamic subtest fds: SUCCESS (3.843s)
[531.177844] Starting dynamic subtest: userptr
[532.931533] Dynamic subtest userptr: SUCCESS (1.765s)
[532.934361] Subtest engines: SUCCESS (11.988s)
[533.135336] [122/133] (488s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[533.241092] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[533.245251] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[533.373010] [123/133] (488s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[533.438617] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[533.544467] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[533.647538] [124/133] (488s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[533.743105] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[533.745325] Starting dynamic subtest: A-eDP1
[542.632742] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[542.644900] Starting dynamic subtest: B-eDP1
[551.570795] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[551.580921] Starting dynamic subtest: C-eDP1
[560.488230] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[560.499616] Starting dynamic subtest: D-eDP1
[569.409672] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[569.414551] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.674s)
[570.647965] [125/133] (451s left) gem_lmem_swapping (parallel-random-verify)
[570.689081] Subtest parallel-random-verify: SKIP (0.000s)
[570.733417] [126/133] (451s left) perf (short-reads)
[570.810742] Starting subtest: short-reads
[570.823663] Subtest short-reads: SUCCESS (0.013s)
[570.869911] [127/133] (451s left) syncobj_eventfd (binary-wait)
[570.915081] Starting subtest: binary-wait
[570.923952] Subtest binary-wait: SUCCESS (0.010s)
[571.046770] [128/133] (450s left) kms_joiner (basic-ultra-joiner)
[571.157315] Subtest basic-ultra-joiner: SKIP (0.000s)
[571.240713] [129/133] (450s left) gem_mmap_gtt (basic-small-copy-odd)
[571.294400] Subtest basic-small-copy-odd: SKIP (0.000s)
[571.353553] [130/133] (450s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[571.451556] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[571.456058] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[571.575931] [131/133] (450s left) sysfs_timeslice_duration (invalid)
[571.628235] Starting subtest: invalid
[571.630128] Starting dynamic subtest: vecs0
[571.631971] Dynamic subtest vecs0: SUCCESS (0.000s)
[571.641212] Starting dynamic subtest: ccs0
[571.642908] Dynamic subtest ccs0: SUCCESS (0.000s)
[571.651061] Starting dynamic subtest: vcs0
[571.652797] Dynamic subtest vcs0: SUCCESS (0.000s)
[571.660881] Starting dynamic subtest: bcs0
[571.662635] Dynamic subtest bcs0: SUCCESS (0.000s)
[571.670776] Starting dynamic subtest: rcs0
[571.672547] Dynamic subtest rcs0: SUCCESS (0.000s)
[571.680719] Starting dynamic subtest: vcs1
[571.682478] Dynamic subtest vcs1: SUCCESS (0.000s)
[571.684247] Subtest invalid: SUCCESS (0.005s)
[571.759485] [132/133] (450s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[571.856346] Starting subtest: fbc-pr-sprite-mmap-cpu
[571.859934] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[571.939430] [133/133] (450s left) kms_vblank (query-busy)
[572.037104] Starting subtest: query-busy
[572.038889] Starting dynamic subtest: pipe-A-eDP-1
[573.915561] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[573.931990] Starting dynamic subtest: pipe-D-eDP-1
[576.493859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s)
[576.495737] Subtest query-busy: SUCCESS (4.455s)
[577.315107] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_feature_discovery
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_getfb
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: i915_suspend
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: drm_read
results: parsing output: 26/ for test: gem_unref_active_buffers
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_atomic
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_colorop
results: parsing output: 35/ for test: kms_selftest
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_busy
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: kms_chamelium_edid
results: parsing output: 52/ for test: gem_reg_read
results: parsing output: 53/ for test: kms_dirtyfb
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: kms_cursor_edge_walk
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_busy
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_ctx_isolation
results: parsing output: 72/ for test: gem_fence_thrash
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_exec_parallel
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_flush
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_colorop
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_plane_alpha_blend
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_colorop
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: i915_getparams_basic
results: parsing output: 105/ for test: device_reset
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_async_flips
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: i915_pm_rc6_residency
results: parsing output: 120/ for test: gem_exec_parallel
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: syncobj_eventfd
results: parsing output: 127/ for test: kms_joiner
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: sysfs_timeslice_duration
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_vblank
Done.