[143.724940] Initializing watchdogs
[143.724987]   /dev/watchdog0
[143.741146] [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]
[143.746221] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[143.748772] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[143.750747] [001/156] (960s left) perf_pmu (busy-hang)
[143.793071] Starting subtest: busy-hang
[143.793966] Starting dynamic subtest: rcs0
[144.983363] Dynamic subtest rcs0: SUCCESS (1.191s)
[144.991928] Starting dynamic subtest: bcs0
[146.145526] Dynamic subtest bcs0: SUCCESS (1.161s)
[146.155215] Starting dynamic subtest: vcs0
[147.816312] Dynamic subtest vcs0: SUCCESS (1.670s)
[147.826568] Starting dynamic subtest: vcs1
[149.868789] Dynamic subtest vcs1: SUCCESS (2.052s)
[149.879201] Starting dynamic subtest: vecs0
[151.841714] Dynamic subtest vecs0: SUCCESS (1.971s)
[151.855105] Starting dynamic subtest: ccs0
[153.020305] Dynamic subtest ccs0: SUCCESS (1.178s)
[153.021641] Subtest busy-hang: SUCCESS (9.228s)
[153.124629] [002/156] (951s left) gem_fenced_exec_thrash (no-spare-fences)
[153.172040] Subtest no-spare-fences: SKIP (0.000s)
[153.245122] [003/156] (951s left) gem_close (basic)
[153.293185] Starting subtest: basic
[153.294198] Subtest basic: SUCCESS (0.000s)
[153.389103] [004/156] (950s left) kms_pipe_crc_basic (nonblocking-crc)
[153.482958] Starting subtest: nonblocking-crc
[153.483906] Starting dynamic subtest: pipe-A-eDP-1
[154.257843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[154.269237] Starting dynamic subtest: pipe-B-eDP-1
[155.703203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[155.712606] Starting dynamic subtest: pipe-C-eDP-1
[157.092228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[157.101463] Starting dynamic subtest: pipe-D-eDP-1
[158.521085] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.424s)
[158.522059] Subtest nonblocking-crc: SUCCESS (5.034s)
[159.314903] [005/156] (945s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[159.370150] Starting subtest: basic-batch-kernel-default-cmd
[159.371904] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[159.550365] [006/156] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[159.634493] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[166.373677] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.741s)
[166.501774] [007/156] (937s left) kms_content_protection (legacy-hdcp14)
[166.644061] Starting subtest: legacy-hdcp14
[166.646475] Subtest legacy-hdcp14: SKIP (0.000s)
[166.772261] [008/156] (937s left) kms_flip (basic-plain-flip)
[166.857788] Starting subtest: basic-plain-flip
[166.860173] Starting dynamic subtest: A-eDP1
[168.562378] Dynamic subtest A-eDP1: SUCCESS (1.703s)
[168.571784] Starting dynamic subtest: B-eDP1
[170.285493] Dynamic subtest B-eDP1: SUCCESS (1.721s)
[170.296128] Starting dynamic subtest: C-eDP1
[172.021343] Dynamic subtest C-eDP1: SUCCESS (1.734s)
[172.032670] Starting dynamic subtest: D-eDP1
[173.756763] Dynamic subtest D-eDP1: SUCCESS (1.734s)
[173.760811] Subtest basic-plain-flip: SUCCESS (6.903s)
[174.918324] [009/156] (929s left) gem_exec_reloc (basic-cpu-gtt-active)
[174.967222] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[175.027222] [010/156] (929s left) api_intel_allocator (reloc-allocator)
[175.072919] Starting subtest: reloc-allocator
[175.073779] Starting dynamic subtest: basic
[175.075792] Dynamic subtest basic: SUCCESS (0.004s)
[175.084476] Starting dynamic subtest: parallel-one
[175.085436] Dynamic subtest parallel-one: SUCCESS (0.008s)
[175.092770] Starting dynamic subtest: print
[175.093621] Dynamic subtest print: SUCCESS (0.000s)
[175.101655] Starting dynamic subtest: reuse
[175.102450] Dynamic subtest reuse: SUCCESS (0.000s)
[175.109582] Starting dynamic subtest: fork-reopen-allocator
[175.110445] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[175.111255] Subtest reloc-allocator: SUCCESS (0.023s)
[175.216638] [011/156] (929s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[175.302164] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[175.303863] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[175.388421] [012/156] (929s left) perf_pmu (idle-no-semaphores)
[175.421931] Starting subtest: idle-no-semaphores
[175.422886] Starting dynamic subtest: rcs0
[175.980606] Dynamic subtest rcs0: SUCCESS (0.548s)
[175.990658] Starting dynamic subtest: bcs0
[176.512021] Dynamic subtest bcs0: SUCCESS (0.530s)
[176.522225] Starting dynamic subtest: vcs0
[177.031382] Dynamic subtest vcs0: SUCCESS (0.518s)
[177.039960] Starting dynamic subtest: vcs1
[177.545871] Dynamic subtest vcs1: SUCCESS (0.513s)
[177.554506] Starting dynamic subtest: vecs0
[178.061192] Dynamic subtest vecs0: SUCCESS (0.514s)
[178.071066] Starting dynamic subtest: ccs0
[178.594743] Dynamic subtest ccs0: SUCCESS (0.532s)
[178.595917] Subtest idle-no-semaphores: SUCCESS (3.164s)
[178.699735] [013/156] (925s left) sw_sync (sync_expired_merge)
[178.727045] Starting subtest: sync_expired_merge
[179.810266] Subtest sync_expired_merge: SUCCESS (1.074s)
[179.858765] [014/156] (924s left) kms_force_connector_basic (force-connector-state)
[179.920517] Starting subtest: force-connector-state
[180.539171] Subtest force-connector-state: SUCCESS (0.618s)
[181.464690] [015/156] (923s left) syncobj_wait (wait-all-interrupted)
[181.509687] Starting subtest: wait-all-interrupted
[181.613100] Subtest wait-all-interrupted: SUCCESS (0.102s)
[181.686115] [016/156] (923s left) gem_fence_thrash (bo-write-verify-none)
[181.716077] Starting subtest: bo-write-verify-none
[181.743490] Subtest bo-write-verify-none: SKIP (0.028s)
[181.792742] [017/156] (922s left) gem_pwrite (basic-random)
[181.837459] Subtest basic-random: SKIP (0.000s)
[181.896392] [018/156] (922s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[181.951233] Starting subtest: multi-wait-all-for-submit-submitted
[182.071025] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[182.129188] [019/156] (922s left) gem_exec_balancer (full-pulse)
[182.177256] Starting subtest: full-pulse
[187.236560] Subtest full-pulse: SUCCESS (5.059s)
[187.550338] [020/156] (917s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt)
[187.642845] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt
[187.644538] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[187.727708] [021/156] (917s left) kms_selftest (drm_format_helper)
[187.759229] Starting subtest: drm_format_helper
[187.770197] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[187.854270] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.084s)
[187.866827] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[187.941692] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.088s)
[187.951923] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[188.040518] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.098s)
[188.048091] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[188.146800] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.105s)
[188.154074] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[188.255934] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.109s)
[188.262945] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[188.364599] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.109s)
[188.371903] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[188.457710] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.091s)
[188.473031] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[188.561760] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.104s)
[188.570840] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[188.664169] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.102s)
[188.673630] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[188.783693] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.111s)
[188.795192] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[188.869449] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.093s)
[188.876580] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[188.962990] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.091s)
[188.971500] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[189.065764] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.103s)
[189.073177] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[189.144480] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.077s)
[189.151573] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[189.231537] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.085s)
[189.240815] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[189.329243] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.098s)
[189.336410] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[189.424836] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.095s)
[189.425817] Subtest drm_format_helper: SUCCESS (1.667s)
[189.577185] [022/156] (915s left) perf (buffer-fill)
[189.700205] Starting subtest: buffer-fill
[189.700955] Starting dynamic subtest: 0-rcs0
[192.009993] Dynamic subtest 0-rcs0: SUCCESS (2.300s)
[192.019200] Starting dynamic subtest: 1-vcs0
[196.478485] Dynamic subtest 1-vcs0: SUCCESS (4.478s)
[196.479901] Subtest buffer-fill: SUCCESS (6.779s)
[196.519943] [023/156] (908s left) gem_exec_balancer (persistence)
[196.787202] Starting subtest: persistence
[197.783975] Subtest persistence: SUCCESS (0.994s)
[197.895398] [024/156] (907s left) gem_exec_schedule (pi-shared-iova)
[198.086188] Starting subtest: pi-shared-iova
[198.087109] Starting dynamic subtest: rcs0
[198.240780] Dynamic subtest rcs0: SUCCESS (0.153s)
[198.251623] Starting dynamic subtest: vcs0
[198.318606] Dynamic subtest vcs0: SUCCESS (0.087s)
[198.326150] Starting dynamic subtest: vcs1
[198.399606] Dynamic subtest vcs1: SUCCESS (0.080s)
[198.407250] Starting dynamic subtest: vecs0
[198.478727] Dynamic subtest vecs0: SUCCESS (0.078s)
[198.488419] Starting dynamic subtest: ccs0
[198.591679] Dynamic subtest ccs0: SUCCESS (0.113s)
[198.593239] Subtest pi-shared-iova: SUCCESS (0.514s)
[199.409842] [025/156] (905s left) gem_eio (in-flight-internal-10ms)
[199.630919] Starting subtest: in-flight-internal-10ms
[201.406458] Subtest in-flight-internal-10ms: SUCCESS (1.776s)
[201.523890] [026/156] (903s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[201.611669] Starting subtest: psr-rgb101010-draw-render
[208.947811] Subtest psr-rgb101010-draw-render: SUCCESS (7.337s)
[209.088428] [027/156] (895s left) gem_flink_basic (bad-open)
[209.143633] Starting subtest: bad-open
[209.144900] Subtest bad-open: SUCCESS (0.000s)
[209.239112] [028/156] (895s left) syncobj_basic (bad-flags-handle-to-fd)
[209.281527] Starting subtest: bad-flags-handle-to-fd
[209.282579] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[209.365466] [029/156] (895s left) kms_big_fb (linear-16bpp-rotate-270)
[209.461360] Starting subtest: linear-16bpp-rotate-270
[209.480479] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[209.592282] [030/156] (895s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[209.674205] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[209.675096] Starting dynamic subtest: pipe-A-eDP-1
[209.685443] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.694410] Starting dynamic subtest: pipe-B-eDP-1
[209.702940] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.711108] Starting dynamic subtest: pipe-C-eDP-1
[209.719168] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.726851] Starting dynamic subtest: pipe-D-eDP-1
[209.735399] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.736967] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[211.954646] [031/156] (893s left) kms_plane (plane-position-hole-dpms)
[212.043366] Starting subtest: plane-position-hole-dpms
[212.562089] Starting dynamic subtest: pipe-A-plane-1
[214.881262] Dynamic subtest pipe-A-plane-1: SUCCESS (2.319s)
[214.889510] Starting dynamic subtest: pipe-A-plane-2
[217.319713] Dynamic subtest pipe-A-plane-2: SUCCESS (2.438s)
[217.329390] Starting dynamic subtest: pipe-A-plane-3
[219.695610] Dynamic subtest pipe-A-plane-3: SUCCESS (2.376s)
[219.711748] Starting dynamic subtest: pipe-A-plane-4
[222.089511] Dynamic subtest pipe-A-plane-4: SUCCESS (2.394s)
[222.097429] Starting dynamic subtest: pipe-A-plane-5
[222.114737] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[223.329456] Starting dynamic subtest: pipe-B-plane-1
[225.705446] Dynamic subtest pipe-B-plane-1: SUCCESS (2.383s)
[225.714224] Starting dynamic subtest: pipe-B-plane-2
[228.086910] Dynamic subtest pipe-B-plane-2: SUCCESS (2.381s)
[228.095169] Starting dynamic subtest: pipe-B-plane-3
[230.462900] Dynamic subtest pipe-B-plane-3: SUCCESS (2.375s)
[230.471200] Starting dynamic subtest: pipe-B-plane-4
[232.898192] Dynamic subtest pipe-B-plane-4: SUCCESS (2.434s)
[232.907451] Starting dynamic subtest: pipe-B-plane-5
[232.924830] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[232.925741] Subtest plane-position-hole-dpms: SUCCESS (20.881s)
[233.743523] [032/156] (871s left) syncobj_wait (invalid-wait-bad-flags)
[233.796145] Starting subtest: invalid-wait-bad-flags
[233.797017] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[233.896348] [033/156] (871s left) kms_plane_multiple (2x-tiling-yf)
[233.986044] Starting subtest: 2x-tiling-yf
[233.987726] Subtest 2x-tiling-yf: SKIP (0.000s)
[234.051442] [034/156] (871s left) gem_ctx_shared (exec-single-timeline)
[234.105155] Starting subtest: exec-single-timeline
[234.106099] Starting dynamic subtest: rcs0
[235.145471] Dynamic subtest rcs0: SUCCESS (1.030s)
[235.155901] Starting dynamic subtest: bcs0
[236.229909] Dynamic subtest bcs0: SUCCESS (1.082s)
[236.242568] Starting dynamic subtest: vcs0
[237.323581] Dynamic subtest vcs0: SUCCESS (1.090s)
[237.338670] Starting dynamic subtest: vcs1
[238.406586] Dynamic subtest vcs1: SUCCESS (1.081s)
[238.418074] Starting dynamic subtest: vecs0
[239.494352] Dynamic subtest vecs0: SUCCESS (1.085s)
[239.506767] Starting dynamic subtest: ccs0
[240.582208] Dynamic subtest ccs0: SUCCESS (1.086s)
[240.583443] Subtest exec-single-timeline: SUCCESS (6.468s)
[241.382489] [035/156] (863s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[241.473616] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[241.474657] Starting dynamic subtest: pipe-A-eDP-1
[241.563027] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[241.573109] Starting dynamic subtest: pipe-B-eDP-1
[242.698014] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[242.699879] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.225s)
[243.949452] [036/156] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[244.038931] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[244.040738] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[244.121795] [037/156] (861s left) kms_psr (fbc-psr-primary-blt)
[244.209997] Starting subtest: fbc-psr-primary-blt
[244.210974] Starting dynamic subtest: eDP-1
[244.213145] Dynamic subtest eDP-1: SKIP (0.000s)
[244.215248] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[244.277755] [038/156] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[244.366595] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[244.368428] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[244.473235] [039/156] (861s left) kms_addfb_basic (bad-pitch-128)
[244.517434] Starting subtest: bad-pitch-128
[244.518359] Subtest bad-pitch-128: SUCCESS (0.000s)
[244.634624] [040/156] (860s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[244.719996] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[248.662555] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.942s)
[249.846679] [041/156] (855s left) prime_vgem (shrink)
[249.958746] Starting subtest: shrink
[249.971904] Subtest shrink: SUCCESS (0.012s)
[250.093682] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[250.096038] [042/156] (855s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt)
[250.191272] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt
[250.192839] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[250.285100] [043/156] (855s left) kms_atomic (crtc-invalid-params-fence)
[250.375288] Starting subtest: crtc-invalid-params-fence
[250.376135] Starting dynamic subtest: pipe-A-eDP-1
[250.788452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.412s)
[250.790626] Subtest crtc-invalid-params-fence: SUCCESS (0.414s)
[251.647777] [044/156] (854s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[251.693704] Starting subtest: invalid-smem-bo-on-discrete
[251.695814] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[251.810801] [045/156] (853s left) kms_cursor_crc (cursor-offscreen-128x128)
[252.025358] Starting subtest: cursor-offscreen-128x128
[252.028828] Starting dynamic subtest: pipe-A-eDP-1
[253.983783] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s)
[254.012427] Starting dynamic subtest: pipe-D-eDP-1
[256.638988] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[256.640248] Subtest cursor-offscreen-128x128: SUCCESS (4.614s)
[257.439990] [046/156] (848s left) kms_psr (fbc-pr-cursor-plane-move)
[257.524293] Starting subtest: fbc-pr-cursor-plane-move
[257.526172] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[257.605721] [047/156] (848s left) gem_lmem_swapping (massive-random)
[257.641327] Subtest massive-random: SKIP (0.000s)
[257.677743] [048/156] (848s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[257.725103] Starting subtest: invalid-bsd2-flag-on-vebox
[257.726536] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[257.815868] [049/156] (847s left) gem_exec_fence (syncobj-timeline-unused-fence)
[258.361347] Starting subtest: syncobj-timeline-unused-fence
[258.362524] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[259.411097] [050/156] (846s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[259.509917] Starting subtest: 2x-flip-vs-modeset-vs-hang
[259.513667] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[259.605204] [051/156] (846s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[259.705240] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[260.397529] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[260.531559] [052/156] (845s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[260.635221] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[260.662975] Starting dynamic subtest: pipe-A-plane-0
[260.951661] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[260.960118] Starting dynamic subtest: pipe-A-plane-3
[261.185106] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[261.193717] Starting dynamic subtest: pipe-A-plane-5
[261.195622] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[262.300752] Starting dynamic subtest: pipe-B-plane-0
[262.591972] Dynamic subtest pipe-B-plane-0: SUCCESS (0.299s)
[262.601624] Starting dynamic subtest: pipe-B-plane-3
[262.836622] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s)
[262.844959] Starting dynamic subtest: pipe-B-plane-5
[262.847036] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[263.143999] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.509s)
[263.950865] [053/156] (842s left) gem_mmap_gtt (basic-short)
[264.000952] Subtest basic-short: SKIP (0.000s)
[264.058859] [054/156] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[264.146086] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[270.768606] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.625s)
[270.911286] [055/156] (835s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[271.030487] Starting subtest: basic-flip-after-cursor-atomic
[271.942979] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[272.742551] [056/156] (833s left) intel_hwmon (hwmon-read)
[272.793117] Subtest hwmon-read: SKIP (0.000s)
[272.845978] [057/156] (833s left) vgem_basic (mmap)
[272.882507] Starting subtest: mmap
[272.891941] Subtest mmap: SUCCESS (0.011s)
[272.949755] [058/156] (833s left) sysfs_timeslice_duration (idempotent)
[273.012351] Starting subtest: idempotent
[273.013307] Starting dynamic subtest: vecs0
[273.014177] Dynamic subtest vecs0: SUCCESS (0.000s)
[273.023254] Starting dynamic subtest: ccs0
[273.024228] Dynamic subtest ccs0: SUCCESS (0.000s)
[273.032133] Starting dynamic subtest: vcs0
[273.032964] Dynamic subtest vcs0: SUCCESS (0.000s)
[273.040955] Starting dynamic subtest: bcs0
[273.041898] Dynamic subtest bcs0: SUCCESS (0.000s)
[273.049738] Starting dynamic subtest: rcs0
[273.050587] Dynamic subtest rcs0: SUCCESS (0.000s)
[273.058619] Starting dynamic subtest: vcs1
[273.059624] Dynamic subtest vcs1: SUCCESS (0.000s)
[273.060415] Subtest idempotent: SUCCESS (0.006s)
[273.119079] [059/156] (833s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt)
[273.214213] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt
[273.216160] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[273.315999] [060/156] (832s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[273.411880] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[273.413774] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[273.515711] [061/156] (832s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[273.612692] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[273.614481] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[273.704898] [062/156] (832s left) kms_frontbuffer_tracking (fbc-1p-rte)
[273.795736] Starting subtest: fbc-1p-rte
[279.246956] Subtest fbc-1p-rte: SUCCESS (5.453s)
[280.447588] [063/156] (825s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[280.539720] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[287.227663] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.689s)
[287.355358] [064/156] (818s left) kms_big_fb (yf-tiled-addfb)
[287.454411] Starting subtest: yf-tiled-addfb
[287.456382] Subtest yf-tiled-addfb: SKIP (0.000s)
[287.550371] [065/156] (818s left) kms_vblank (ts-continuation-modeset)
[287.652611] Starting subtest: ts-continuation-modeset
[287.653725] Starting dynamic subtest: pipe-A-eDP-1
[289.187943] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.543s)
[289.198021] Starting dynamic subtest: pipe-D-eDP-1
[291.376352] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.186s)
[291.377183] Subtest ts-continuation-modeset: SUCCESS (3.732s)
[292.246955] [066/156] (814s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render)
[292.341783] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render
[292.343455] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[292.439106] [067/156] (814s left) i915_hangman (hangcheck-unterminated)
[292.493339] Starting subtest: hangcheck-unterminated
[303.304105] Subtest hangcheck-unterminated: SUCCESS (10.801s)
[303.440405] [068/156] (803s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[303.758333] Starting subtest: cursor-rapid-movement-max-size
[303.760918] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[303.884395] [069/156] (802s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[304.261800] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[305.120988] [070/156] (801s left) kms_getfb (getfb2-handle-not-fb)
[305.213514] Starting subtest: getfb2-handle-not-fb
[305.214438] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[305.299300] [071/156] (801s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[305.382520] Starting subtest: primary-4-tiled-reflect-x-180
[312.467418] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.085s)
[313.635422] [072/156] (792s left) kms_pm_dc (dc6-psr)
[314.728331] Starting subtest: dc6-psr
[317.712520] Subtest dc6-psr: SUCCESS (2.984s)
[318.543583] [073/156] (788s left) gem_render_copy_redux (flink)
[318.604762] Starting subtest: flink
[319.409498] Subtest flink: SUCCESS (0.805s)
[319.538573] [074/156] (787s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[319.624196] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[319.626106] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[319.713954] [075/156] (787s left) kms_fence_pin_leak
[319.874427] [076/156] (786s left) kms_lease (lease-unleased-crtc)
[319.957820] Starting subtest: lease-unleased-crtc
[319.958890] Starting dynamic subtest: pipe-A-eDP-1
[320.247804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[320.261948] Starting dynamic subtest: pipe-B-eDP-1
[320.970847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.714s)
[320.980204] Starting dynamic subtest: pipe-C-eDP-1
[320.981031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[320.988928] Starting dynamic subtest: pipe-D-eDP-1
[320.989762] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[320.990560] Subtest lease-unleased-crtc: SUCCESS (1.019s)
[321.344616] [077/156] (785s left) kms_psr (fbc-pr-suspend)
[321.437399] Starting subtest: fbc-pr-suspend
[321.439249] Subtest fbc-pr-suspend: SKIP (0.000s)
[321.520247] [078/156] (785s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[321.610841] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[321.612736] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[322.742945] [079/156] (784s left) gem_partial_pwrite_pread (reads-snoop)
[322.806520] Subtest reads-snoop: SKIP (0.000s)
[322.871562] [080/156] (784s left) kms_color (ctm-blue-to-red)
[322.960116] Starting subtest: ctm-blue-to-red
[322.960888] Starting dynamic subtest: pipe-A-eDP-1
[323.680778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[323.689503] Starting dynamic subtest: pipe-B-eDP-1
[325.135917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s)
[325.144854] Starting dynamic subtest: pipe-C-eDP-1
[326.456839] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.320s)
[326.465079] Starting dynamic subtest: pipe-D-eDP-1
[327.885175] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[327.886257] Subtest ctm-blue-to-red: SUCCESS (4.925s)
[328.737887] [081/156] (778s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[328.823360] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[328.824980] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[328.914765] [082/156] (778s left) kms_cursor_crc (cursor-sliding-max-size)
[329.220616] Starting subtest: cursor-sliding-max-size
[329.223426] Subtest cursor-sliding-max-size: SKIP (0.000s)
[329.352711] [083/156] (777s left) i915_drm_fdinfo (virtual-busy-hang)
[329.385289] Starting subtest: virtual-busy-hang
[329.387174] Subtest virtual-busy-hang: SKIP (0.000s)
[329.457836] [084/156] (777s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[329.557419] Starting subtest: psr-1p-primscrn-spr-indfb-move
[336.839205] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.283s)
[336.939064] [085/156] (770s left) kms_lease (implicit-plane-lease)
[337.028737] Starting subtest: implicit-plane-lease
[337.029584] Subtest implicit-plane-lease: SUCCESS (0.002s)
[337.127250] [086/156] (769s left) kms_pm_rpm (system-suspend-idle)
[338.644824] Starting subtest: system-suspend-idle
[358.905391] Subtest system-suspend-idle: SUCCESS (4.869s)
[364.346882] [087/156] (747s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[364.393648] Starting subtest: single-wait-all-for-submit-signaled
[364.394611] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[364.486637] [088/156] (747s left) gem_exec_whisper (basic-contexts-forked)
[364.539525] Starting subtest: basic-contexts-forked
[389.216933] Subtest basic-contexts-forked: SUCCESS (24.690s)
[389.358020] [089/156] (722s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[389.454021] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[389.455716] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[389.540666] [090/156] (722s left) gem_readwrite (beyond-eob)
[389.603870] Subtest beyond-EOB: SKIP (0.000s)
[389.661344] [091/156] (722s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[389.756551] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[389.758298] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[389.850331] [092/156] (722s left) gem_exec_fence (syncobj-invalid-wait)
[390.321660] Starting subtest: syncobj-invalid-wait
[390.322775] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[391.822168] [093/156] (720s left) kms_debugfs (display-on-read-all)
[391.909663] Starting subtest: display-on-read-all
[392.077102] Subtest display-on-read-all: SUCCESS (0.169s)
[392.197995] [094/156] (720s left) gem_ctx_param (vm)
[392.248794] Starting subtest: vm
[392.297332] Subtest vm: SUCCESS (0.048s)
[392.422478] [095/156] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[392.525057] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[392.526985] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[392.608677] [096/156] (719s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[392.690283] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[392.692022] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[392.772006] [097/156] (719s left) gem_mmap (basic-small-bo)
[392.822001] Subtest basic-small-bo: SKIP (0.000s)
[392.877135] [098/156] (719s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[392.971158] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[394.039122] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.069s)
[394.157537] [099/156] (718s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[394.242363] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[394.243317] Starting dynamic subtest: pipe-A-default-mode
[395.447940] Dynamic subtest pipe-A-default-mode: SKIP (1.205s)
[395.449977] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.207s)
[395.592405] [100/156] (717s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[395.645955] Starting subtest: multi-wait-all-for-submit-signaled
[395.646916] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[395.747910] [101/156] (716s left) gem_exec_suspend (basic-s4-devices)
[395.803550] Starting subtest: basic-S4-devices
[395.804558] Starting dynamic subtest: smem
[407.753448] Dynamic subtest smem: SUCCESS (11.946s)
[407.755162] Subtest basic-S4-devices: SUCCESS (11.948s)
[413.947380] [102/156] (704s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[414.055942] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[414.057625] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[414.194602] [103/156] (704s left) gen9_exec_parse (bb-large)
[414.256270] Subtest bb-large: SKIP (0.000s)
[414.326250] [104/156] (704s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[414.430050] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[414.431634] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[414.526255] [105/156] (704s left) kms_dsc (dsc-with-bpc)
[414.605712] Starting subtest: dsc-with-bpc
[414.616933] Subtest dsc-with-bpc: SKIP (0.001s)
[414.692543] [106/156] (704s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[414.783841] Starting subtest: primary-y-tiled-reflect-x-90
[414.785573] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[414.854985] [107/156] (704s left) kms_chamelium_color (ctm-green-to-red)
[414.934035] Subtest ctm-green-to-red: SKIP (0.000s)
[414.977883] [108/156] (704s left) kms_psr (pr-primary-mmap-cpu)
[415.062299] Starting subtest: pr-primary-mmap-cpu
[415.064014] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[415.131394] [109/156] (703s left) perf (invalid-open-flags)
[415.218129] Starting subtest: invalid-open-flags
[415.219050] Subtest invalid-open-flags: SUCCESS (0.000s)
[415.254198] [110/156] (703s left) i915_pm_rps (engine-order)
[415.299973] Starting subtest: engine-order
[421.869074] Subtest engine-order: SUCCESS (6.563s)
[421.981165] [111/156] (697s left) kms_busy (basic-hang)
[422.078342] Starting subtest: basic-hang
[422.079201] Starting dynamic subtest: flip-pipe-A
[422.670385] Dynamic subtest flip-pipe-A: SUCCESS (0.590s)
[422.684283] Starting dynamic subtest: modeset-pipe-A
[426.049877] Dynamic subtest modeset-pipe-A: SUCCESS (3.379s)
[426.063806] Starting dynamic subtest: flip-pipe-D
[427.303551] Dynamic subtest flip-pipe-D: SUCCESS (1.251s)
[427.315874] Starting dynamic subtest: modeset-pipe-D
[430.639623] Dynamic subtest modeset-pipe-D: SUCCESS (3.336s)
[430.640590] Subtest basic-hang: SUCCESS (8.562s)
[431.500918] [112/156] (687s left) gem_lmem_swapping (random-engines)
[431.540839] Subtest random-engines: SKIP (0.000s)
[431.585906] [113/156] (687s left) gem_mmap_offset (basic-uaf)
[431.635767] Starting subtest: basic-uaf
[431.637051] Subtest basic-uaf: SUCCESS (0.001s)
[431.725296] [114/156] (687s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[431.815057] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[431.816880] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[431.930882] [115/156] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[432.014408] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[432.016004] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[432.129142] [116/156] (687s left) syncobj_eventfd (timeline-wait-before-signal)
[432.178820] Starting subtest: timeline-wait-before-signal
[432.209731] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[432.295133] [117/156] (687s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[432.382509] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[432.383973] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[432.473521] [118/156] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[432.568863] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[432.570767] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[432.650698] [119/156] (686s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[432.693843] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[432.694770] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[432.810446] [120/156] (686s left) gem_softpin (allocator-basic-reserve)
[432.860178] Starting subtest: allocator-basic-reserve
[432.927380] Subtest allocator-basic-reserve: SUCCESS (0.067s)
[433.051907] [121/156] (686s left) gem_pxp (regular-baseline-src-copy-readible)
[433.164507] Starting subtest: regular-baseline-src-copy-readible
[433.222546] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[433.347578] [122/156] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[433.441440] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[433.443144] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[433.534405] [123/156] (686s left) core_hotunplug (unbind-rebind)
[433.599069] Starting subtest: unbind-rebind
[439.573810] Subtest unbind-rebind: SUCCESS (5.977s)
[439.611243] [124/156] (679s left) kms_flip (flip-vs-absolute-wf_vblank)
[440.717238] Starting subtest: flip-vs-absolute-wf_vblank
[440.727168] Starting dynamic subtest: A-eDP1
[449.614951] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[449.626890] Starting dynamic subtest: B-eDP1
[458.546051] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[458.560954] Starting dynamic subtest: C-eDP1
[467.504955] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[467.518123] Starting dynamic subtest: D-eDP1
[476.404270] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[476.406687] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.699s)
[477.631030] [125/156] (641s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[477.721171] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[477.723119] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.827510] [126/156] (641s left) fbdev (read)
[477.866397] Starting subtest: read
[478.409290] Subtest read: SUCCESS (0.533s)
[478.462229] [127/156] (641s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[478.551461] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[478.552254] Starting dynamic subtest: pipe-A-default-mode
[481.279409] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[481.280543] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.729s)
[482.110774] [128/156] (637s left) gem_exec_schedule (preempt-self)
[482.168354] Starting subtest: preempt-self
[482.169217] Starting dynamic subtest: rcs0
[482.188477] Dynamic subtest rcs0: SUCCESS (0.020s)
[482.201307] Starting dynamic subtest: bcs0
[482.206134] Dynamic subtest bcs0: SUCCESS (0.017s)
[482.217508] Starting dynamic subtest: vcs0
[482.223744] Dynamic subtest vcs0: SUCCESS (0.017s)
[482.234177] Starting dynamic subtest: vcs1
[482.243288] Dynamic subtest vcs1: SUCCESS (0.019s)
[482.260445] Starting dynamic subtest: vecs0
[482.261304] Dynamic subtest vecs0: SUCCESS (0.014s)
[482.271439] Starting dynamic subtest: ccs0
[482.281456] Dynamic subtest ccs0: SUCCESS (0.021s)
[482.282288] Subtest preempt-self: SUCCESS (0.114s)
[483.803595] [129/156] (635s left) gem_ctx_persistence (processes)
[483.866824] Starting subtest: processes
[485.713223] Subtest processes: SUCCESS (1.847s)
[485.791115] [130/156] (634s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[485.876355] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[485.877280] Starting dynamic subtest: pipe-A-eDP-1
[519.961081] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.657s)
[519.974992] Starting dynamic subtest: pipe-B-eDP-1
[554.879080] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.459s)
[554.893428] Starting dynamic subtest: pipe-C-eDP-1
[589.855388] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.490s)
[589.866039] Starting dynamic subtest: pipe-D-eDP-1
[624.858936] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.437s)
[624.859921] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.048s)
[632.102003] [131/156] (493s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[632.158697] Starting subtest: yf-tiled-to-vebox-yf-tiled
[632.160520] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[632.340294] [132/156] (493s left) kms_pm_backlight (fade-with-dpms)
[632.423571] Starting subtest: fade-with-dpms
[634.550371] Starting dynamic subtest: eDP-1
[637.543362] Dynamic subtest eDP-1: SUCCESS (3.004s)
[637.544502] Subtest fade-with-dpms: SUCCESS (5.141s)
[638.419299] [133/156] (487s left) kms_setmode (basic-clone-single-crtc)
[638.461468] Starting subtest: basic-clone-single-crtc
[638.464048] Subtest basic-clone-single-crtc: SKIP (0.000s)
[638.576833] [134/156] (487s left) gem_exec_flush (basic-batch-kernel-default-uc)
[638.635105] Starting subtest: basic-batch-kernel-default-uc
[645.878680] Subtest basic-batch-kernel-default-uc: SUCCESS (7.258s)
[646.090464] [135/156] (479s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[646.179865] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[646.180701] Starting dynamic subtest: pipe-A-eDP-1
[646.188887] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.200225] Starting dynamic subtest: pipe-B-eDP-1
[646.208729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.220036] Starting dynamic subtest: pipe-C-eDP-1
[646.227476] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.238070] Starting dynamic subtest: pipe-D-eDP-1
[646.246352] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.248082] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[648.454299] [136/156] (477s left) api_intel_bb (full-batch)
[648.503499] Starting subtest: full-batch
[648.508327] Subtest full-batch: SUCCESS (0.006s)
[648.619434] [137/156] (477s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[648.705497] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[648.707179] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[648.792351] [138/156] (477s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[648.890629] Starting subtest: x-tiled-32bpp-rotate-180
[650.360695] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.472s)
[650.494404] [139/156] (475s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[650.588767] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[650.590548] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[650.689626] [140/156] (475s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render)
[650.786058] Starting subtest: fbchdr-rgb565-draw-render
[650.787799] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s)
[650.888900] [141/156] (475s left) prime_mmap (test_map_unmap)
[650.938008] Starting subtest: test_map_unmap
[650.939103] Starting dynamic subtest: test_map_unmap-smem
[650.971583] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[650.972800] Subtest test_map_unmap: SUCCESS (0.034s)
[651.095093] [142/156] (475s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[651.190696] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[651.192296] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[651.280455] [143/156] (475s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[651.378658] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[651.380565] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[651.476077] [144/156] (474s left) gem_flink_basic (flink-lifetime)
[651.519954] Starting subtest: flink-lifetime
[651.523284] Subtest flink-lifetime: SUCCESS (0.002s)
[651.614895] [145/156] (474s left) kms_chamelium_edid (dp-edid-resolution-list)
[651.983512] Subtest dp-edid-resolution-list: SKIP (0.000s)
[652.761384] [146/156] (473s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[652.864395] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[652.866315] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[652.979983] [147/156] (473s left) kms_psr (psr-cursor-plane-move)
[653.065820] Starting subtest: psr-cursor-plane-move
[653.066716] Starting dynamic subtest: eDP-1
[654.777417] Dynamic subtest eDP-1: SUCCESS (1.713s)
[654.779507] Subtest psr-cursor-plane-move: SUCCESS (1.715s)
[655.633398] [148/156] (470s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[655.691281] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[655.692496] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[655.784644] [149/156] (470s left) gem_exec_params (no-vebox)
[655.834600] Starting subtest: no-vebox
[655.837293] Subtest no-vebox: SUCCESS (0.002s)
[657.732022] [150/156] (468s left) gem_userptr_blits (userfault)
[657.787204] Starting subtest: userfault
[657.790421] Subtest userfault: SUCCESS (0.005s)
[657.945043] [151/156] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[658.036928] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[665.248409] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.214s)
[665.370208] [152/156] (461s left) syncobj_wait (single-wait-for-submit-submitted)
[665.423552] Starting subtest: single-wait-for-submit-submitted
[665.530348] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[665.605768] [153/156] (461s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[665.694152] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[665.695914] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[665.801848] [154/156] (460s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[665.887926] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[665.889677] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[665.984105] [155/156] (460s left) gem_close_race (multigpu-basic-process)
[666.040539] Starting subtest: multigpu-basic-process
[666.042522] Subtest multigpu-basic-process: SKIP (0.000s)
[666.272273] [156/156] (460s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[666.372631] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[666.374195] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[666.478020] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_fenced_exec_thrash
results: parsing output: 2/ for test: gem_close
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: gem_exec_flush
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_force_connector_basic
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: gem_pwrite
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_selftest
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_flink_basic
results: parsing output: 27/ for test: syncobj_basic
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: gem_ctx_shared
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: intel_hwmon
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: sysfs_timeslice_duration
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_hangman
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_getfb
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: gem_render_copy_redux
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_fence_pin_leak
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_partial_pwrite_pread
results: parsing output: 79/ for test: kms_color
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_whisper
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_readwrite
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_debugfs
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_mmap
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_exec_suspend
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_dsc
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_chamelium_color
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: i915_pm_rps
results: parsing output: 110/ for test: kms_busy
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: core_hotunplug
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: fbdev
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_pm_backlight
results: parsing output: 132/ for test: kms_setmode
results: parsing output: 133/ for test: gem_exec_flush
results: parsing output: 134/ for test: kms_ccs
results: parsing output: 135/ for test: api_intel_bb
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_big_fb
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: prime_mmap
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: gem_flink_basic
results: parsing output: 144/ for test: kms_chamelium_edid
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: syncobj_timeline
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: gem_userptr_blits
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: syncobj_wait
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_close_race
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.