[59.433582] Initializing watchdogs
[59.433630]   /dev/watchdog0
[59.448846] [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]
[59.453562] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.456027] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.458087] [001/155] (960s left) gem_exec_schedule (u-submit-early-slice)
[59.526728] Starting subtest: u-submit-early-slice
[59.527844] Starting dynamic subtest: rcs0
[59.593625] Dynamic subtest rcs0: SUCCESS (0.066s)
[59.603319] Starting dynamic subtest: bcs0
[59.656887] Dynamic subtest bcs0: SUCCESS (0.062s)
[59.665348] Starting dynamic subtest: vcs0
[59.717601] Dynamic subtest vcs0: SUCCESS (0.058s)
[59.727412] Starting dynamic subtest: vcs1
[59.772532] Dynamic subtest vcs1: SUCCESS (0.054s)
[59.782330] Starting dynamic subtest: vecs0
[59.819989] Dynamic subtest vecs0: SUCCESS (0.045s)
[59.828748] Starting dynamic subtest: ccs0
[59.870268] Dynamic subtest ccs0: SUCCESS (0.050s)
[59.871404] Subtest u-submit-early-slice: SUCCESS (0.338s)
[61.448559] [002/155] (958s left) kms_psr2_su (page_flip-xrgb8888)
[61.496490] Subtest page_flip-XRGB8888: SKIP (0.000s)
[61.555978] [003/155] (958s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[61.644134] Starting subtest: multiplane-rotation-cropping-bottom
[79.237101] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.504s)
[79.356027] [004/155] (940s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[79.457346] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[79.458312] Starting dynamic subtest: pipe-A-default-mode
[82.206313] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[82.207451] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.746s)
[83.054249] [005/155] (937s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[83.140015] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[83.141794] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[83.225551] [006/155] (936s left) gem_exec_flush (basic-wb-set-default)
[83.283345] Starting subtest: basic-wb-set-default
[88.746550] Subtest basic-wb-set-default: SUCCESS (5.457s)
[88.947444] [007/155] (931s left) kms_invalid_mode (bad-vsync-end)
[89.034094] Starting subtest: bad-vsync-end
[89.035146] Starting dynamic subtest: pipe-A-eDP-1
[89.335397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[89.343287] Starting dynamic subtest: pipe-B-eDP-1
[89.344194] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[89.350369] Starting dynamic subtest: pipe-C-eDP-1
[89.351332] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[89.357639] Starting dynamic subtest: pipe-D-eDP-1
[89.358890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.359759] Subtest bad-vsync-end: SUCCESS (0.306s)
[90.184427] [008/155] (930s left) sw_sync (sync_merge_invalid)
[90.216945] Starting subtest: sync_merge_invalid
[90.243419] Subtest sync_merge_invalid: SUCCESS (0.026s)
[90.314123] [009/155] (929s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[90.402213] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[90.404037] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[90.499322] [010/155] (929s left) kms_plane_scaling (planes-downscale-factor-0-75)
[90.586261] Starting subtest: planes-downscale-factor-0-75
[90.587202] Starting dynamic subtest: pipe-A
[90.606101] Dynamic subtest pipe-A: SKIP (0.019s)
[90.613119] Starting dynamic subtest: pipe-B
[90.644507] Dynamic subtest pipe-B: SKIP (0.039s)
[90.654024] Starting dynamic subtest: pipe-C
[90.684804] Dynamic subtest pipe-C: SKIP (0.038s)
[90.691607] Starting dynamic subtest: pipe-D
[90.723327] Dynamic subtest pipe-D: SKIP (0.039s)
[90.724862] Subtest planes-downscale-factor-0-75: SKIP (0.137s)
[90.821743] [011/155] (929s left) kms_flip (flip-vs-panning-vs-hang)
[90.917555] Starting subtest: flip-vs-panning-vs-hang
[90.919575] Starting dynamic subtest: A-eDP1
[141.837585] Dynamic subtest A-eDP1: SUCCESS (50.901s)
[141.846411] Starting dynamic subtest: D-eDP1
[190.864298] Dynamic subtest D-eDP1: SUCCESS (49.024s)
[190.867852] Subtest flip-vs-panning-vs-hang: SUCCESS (99.928s)
[192.007934] [012/155] (828s left) kms_addfb_basic (invalid-get-prop-any)
[192.065235] Starting subtest: invalid-get-prop-any
[192.066141] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[192.196854] [013/155] (828s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[192.253891] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[192.255083] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[192.343734] [014/155] (828s left) gem_exec_balancer (bonded-semaphore)
[192.414506] Starting subtest: bonded-semaphore
[192.416483] Subtest bonded-semaphore: SKIP (0.000s)
[192.715128] [015/155] (827s left) kms_flip (flip-vs-rmfb)
[192.798433] Starting subtest: flip-vs-rmfb
[192.800776] Starting dynamic subtest: A-eDP1
[201.507803] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[201.516904] Starting dynamic subtest: B-eDP1
[210.148550] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[210.157387] Starting dynamic subtest: C-eDP1
[218.802993] Dynamic subtest C-eDP1: SUCCESS (8.651s)
[218.813205] Starting dynamic subtest: D-eDP1
[227.506223] Dynamic subtest D-eDP1: SUCCESS (8.702s)
[227.509267] Subtest flip-vs-rmfb: SUCCESS (34.708s)
[228.672117] [016/155] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[228.764656] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[228.766372] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.855393] [017/155] (791s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[228.950730] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[233.235016] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.285s)
[234.401173] [018/155] (786s left) gem_wait (write-busy)
[234.463080] Starting subtest: write-busy
[234.464039] Starting dynamic subtest: all-engines
[235.074061] Dynamic subtest all-engines: SUCCESS (0.612s)
[235.089612] Starting dynamic subtest: rcs0
[235.631469] Dynamic subtest rcs0: SUCCESS (0.556s)
[235.649477] Starting dynamic subtest: bcs0
[236.181591] Dynamic subtest bcs0: SUCCESS (0.548s)
[236.195790] Starting dynamic subtest: vcs0
[237.360359] Dynamic subtest vcs0: SUCCESS (1.165s)
[237.367820] Starting dynamic subtest: vcs1
[239.343545] Dynamic subtest vcs1: SUCCESS (1.979s)
[239.350496] Starting dynamic subtest: vecs0
[241.327748] Dynamic subtest vecs0: SUCCESS (1.981s)
[241.335638] Starting dynamic subtest: ccs0
[241.867183] Dynamic subtest ccs0: SUCCESS (0.550s)
[241.868526] Subtest write-busy: SUCCESS (7.406s)
[242.059457] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[242.061315] [019/155] (778s left) api_intel_bb (render)
[242.110933] Starting subtest: render
[242.111956] Starting dynamic subtest: render-none-512
[242.220901] Dynamic subtest render-none-512: SUCCESS (0.110s)
[242.231039] Starting dynamic subtest: render-none-1024
[242.624424] Dynamic subtest render-none-1024: SUCCESS (0.393s)
[242.632714] Starting dynamic subtest: render-x-512
[242.704699] Dynamic subtest render-x-512: SUCCESS (0.088s)
[242.714630] Starting dynamic subtest: render-x-1024
[243.067878] Dynamic subtest render-x-1024: SUCCESS (0.353s)
[243.077434] Starting dynamic subtest: render-y-512
[243.147836] Dynamic subtest render-y-512: SUCCESS (0.088s)
[243.157809] Starting dynamic subtest: render-y-1024
[243.509904] Dynamic subtest render-y-1024: SUCCESS (0.351s)
[243.511571] Subtest render: SUCCESS (1.390s)
[243.617426] [020/155] (776s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[243.709675] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[243.711348] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[243.796280] [021/155] (776s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[243.879448] Starting subtest: fbc-pr-cursor-plane-update-sf
[243.881229] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[243.978866] [022/155] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[244.071351] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[244.072866] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[244.184959] [023/155] (776s left) kms_content_protection (legacy)
[244.313404] Starting subtest: legacy
[244.315463] Subtest legacy: SKIP (0.000s)
[244.423735] [024/155] (776s left) gem_exec_schedule (preempt-contexts)
[244.487203] Starting subtest: preempt-contexts
[244.488275] Starting dynamic subtest: rcs0
[244.541837] Dynamic subtest rcs0: SUCCESS (0.054s)
[244.548890] Starting dynamic subtest: bcs0
[244.595950] Dynamic subtest bcs0: SUCCESS (0.053s)
[244.603056] Starting dynamic subtest: vcs0
[244.651124] Dynamic subtest vcs0: SUCCESS (0.054s)
[244.658249] Starting dynamic subtest: vcs1
[244.697015] Dynamic subtest vcs1: SUCCESS (0.045s)
[244.704222] Starting dynamic subtest: vecs0
[244.750331] Dynamic subtest vecs0: SUCCESS (0.052s)
[244.757765] Starting dynamic subtest: ccs0
[244.804059] Dynamic subtest ccs0: SUCCESS (0.053s)
[244.804948] Subtest preempt-contexts: SUCCESS (0.317s)
[246.417097] [025/155] (774s left) kms_hdr (brightness-with-hdr)
[246.513253] Starting subtest: brightness-with-hdr
[246.514060] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[246.515691] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[246.522724] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[246.524416] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[246.526159] Subtest brightness-with-hdr: SKIP (0.003s)
[246.582668] [026/155] (774s left) syncobj_timeline (multi-wait-signaled)
[246.631393] Starting subtest: multi-wait-signaled
[246.632327] Subtest multi-wait-signaled: SUCCESS (0.001s)
[246.714074] [027/155] (774s left) perf (non-sampling-read-error)
[246.839791] Starting subtest: non-sampling-read-error
[246.849428] Subtest non-sampling-read-error: SUCCESS (0.010s)
[246.901760] [028/155] (773s left) gem_exec_whisper (basic-fds-priority)
[246.964841] Starting subtest: basic-fds-priority
[271.297883] Subtest basic-fds-priority: SUCCESS (24.330s)
[271.486412] [029/155] (749s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[271.601525] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[271.603234] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[271.711940] [030/155] (749s left) gem_mmap_gtt (cpuset-medium-copy)
[271.762731] Subtest cpuset-medium-copy: SKIP (0.000s)
[271.817786] [031/155] (749s left) fbdev (info)
[271.850082] Starting subtest: info
[271.851220] Subtest info: SUCCESS (0.000s)
[271.931027] [032/155] (749s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[272.017529] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[272.019296] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[272.110173] [033/155] (748s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[272.197811] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[272.199619] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.289830] [034/155] (748s left) kms_plane_multiple (tiling-yf)
[272.384406] Starting subtest: tiling-yf
[272.386023] Subtest tiling-yf: SKIP (0.000s)
[272.458173] [035/155] (748s left) gem_pwrite (basic-self)
[272.512231] Subtest basic-self: SKIP (0.000s)
[272.561629] [036/155] (748s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[272.661949] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[273.527560] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.633s)
[273.560307] [037/155] (747s left) kms_psr (fbc-psr2-cursor-plane-move)
[273.641479] Starting subtest: fbc-psr2-cursor-plane-move
[273.642351] Starting dynamic subtest: eDP-1
[273.643927] Dynamic subtest eDP-1: SKIP (0.000s)
[273.645573] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[273.717960] [038/155] (747s left) kms_chamelium_frames (hdmi-aspect-ratio)
[274.091972] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[274.902527] [039/155] (746s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[274.991712] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[274.992616] Starting dynamic subtest: pipe-A-eDP-1
[275.014200] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[275.025848] Starting dynamic subtest: pipe-B-eDP-1
[275.047438] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[275.054887] Starting dynamic subtest: pipe-C-eDP-1
[275.075285] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[275.082467] Starting dynamic subtest: pipe-D-eDP-1
[275.102903] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[275.104453] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[277.281693] [040/155] (743s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[277.378541] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[277.379550] Starting dynamic subtest: pipe-A-eDP-1
[278.325862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.944s)
[278.333514] Starting dynamic subtest: pipe-B-eDP-1
[280.072856] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.745s)
[280.080584] Starting dynamic subtest: pipe-C-eDP-1
[281.655490] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.579s)
[281.664542] Starting dynamic subtest: pipe-D-eDP-1
[283.202576] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.548s)
[283.203815] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.822s)
[284.423277] [041/155] (736s left) kms_properties (get_properties-sanity-atomic)
[284.518402] Starting subtest: get_properties-sanity-atomic
[284.519376] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[284.601170] [042/155] (736s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[284.694943] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[284.696896] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[284.795945] [043/155] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[284.893582] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[284.895177] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[284.998491] [044/155] (736s left) perf (gen12-oa-tlb-invalidate)
[285.073405] Starting subtest: gen12-oa-tlb-invalidate
[285.074496] Starting dynamic subtest: 0-rcs0
[295.170750] Dynamic subtest 0-rcs0: SUCCESS (10.052s)
[295.180127] Starting dynamic subtest: 1-vcs0
[305.216100] Dynamic subtest 1-vcs0: SUCCESS (10.044s)
[305.217505] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.099s)
[305.249132] [045/155] (716s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[305.352992] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[305.365426] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s)
[305.450780] [046/155] (716s left) kms_psr (psr-primary-mmap-cpu)
[305.538192] Starting subtest: psr-primary-mmap-cpu
[305.538993] Starting dynamic subtest: eDP-1
[307.315618] Dynamic subtest eDP-1: SUCCESS (1.775s)
[307.316668] Subtest psr-primary-mmap-cpu: SUCCESS (1.776s)
[308.172982] [047/155] (713s left) kms_sequence (get-busy)
[308.257243] Starting subtest: get-busy
[308.258113] Starting dynamic subtest: pipe-A-eDP-1
[310.186279] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[310.193588] Starting dynamic subtest: pipe-B-eDP-1
[312.785064] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.598s)
[312.792831] Starting dynamic subtest: pipe-C-eDP-1
[315.387908] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[315.395541] Starting dynamic subtest: pipe-D-eDP-1
[318.004574] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[318.005491] Subtest get-busy: SUCCESS (9.748s)
[318.878265] [048/155] (702s left) kms_frontbuffer_tracking (basic)
[318.974940] Starting subtest: basic
[322.475056] Subtest basic: SUCCESS (3.502s)
[322.599096] [049/155] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[322.687286] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[327.353338] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.667s)
[328.491142] [050/155] (693s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[328.597651] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[328.599456] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[328.688554] [051/155] (692s left) gem_softpin (allocator-nopin-reserve)
[328.739636] Starting subtest: allocator-nopin-reserve
[328.835990] Subtest allocator-nopin-reserve: SUCCESS (0.096s)
[328.955623] [052/155] (692s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[329.004750] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[329.006447] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[329.194393] [053/155] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[329.282869] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[329.284592] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[329.375856] [054/155] (692s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[329.423963] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[329.526423] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[329.598062] [055/155] (692s left) kms_fb_coherency (memset-crc)
[329.691445] Starting subtest: memset-crc
[329.692434] Starting dynamic subtest: mmap-offset-wc
[330.078504] Dynamic subtest mmap-offset-wc: SUCCESS (0.387s)
[330.368348] Starting dynamic subtest: mmap-offset-uc
[336.498586] Dynamic subtest mmap-offset-uc: SUCCESS (6.137s)
[336.789336] Subtest memset-crc: SUCCESS (7.098s)
[337.657580] [056/155] (684s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[337.756667] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[337.758427] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[337.839096] [057/155] (684s left) vgem_basic (dmabuf-fence)
[337.875275] Starting subtest: dmabuf-fence
[337.876289] Subtest dmabuf-fence: SUCCESS (0.001s)
[337.925951] [058/155] (683s left) gem_exec_params (rs-invalid)
[337.984630] Starting subtest: rs-invalid
[337.987389] Subtest rs-invalid: SUCCESS (0.002s)
[338.101902] [059/155] (683s left) kms_cursor_crc (cursor-random-64x21)
[338.298214] Starting subtest: cursor-random-64x21
[338.346733] Subtest cursor-random-64x21: SKIP (0.046s)
[338.572572] [060/155] (683s left) gem_pxp (reject-modify-context-protection-on)
[338.679680] Starting subtest: reject-modify-context-protection-on
[338.680933] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[338.798163] [061/155] (683s left) gem_userptr_blits (dmabuf-unsync)
[338.847394] Subtest dmabuf-unsync: SKIP (0.000s)
[338.978598] [062/155] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[339.066229] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[343.486934] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.421s)
[344.657262] [063/155] (677s left) kms_cursor_legacy (forked-bo)
[344.763805] Starting subtest: forked-bo
[344.764811] Starting dynamic subtest: pipe-A
[350.303438] Dynamic subtest pipe-A: SUCCESS (5.492s)
[350.316817] Starting dynamic subtest: pipe-B
[355.799489] Dynamic subtest pipe-B: SUCCESS (5.493s)
[355.809318] Starting dynamic subtest: pipe-C
[361.280627] Dynamic subtest pipe-C: SUCCESS (5.478s)
[361.291930] Starting dynamic subtest: pipe-D
[366.761674] Dynamic subtest pipe-D: SUCCESS (5.479s)
[366.776429] Starting dynamic subtest: all-pipes
[372.273913] Dynamic subtest all-pipes: SUCCESS (5.509s)
[372.275236] Subtest forked-bo: SUCCESS (27.462s)
[372.368841] [064/155] (649s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[372.461354] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[372.462178] Starting dynamic subtest: pipe-A-eDP-1
[372.473455] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[372.481478] Starting dynamic subtest: pipe-B-eDP-1
[372.490527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[372.498286] Starting dynamic subtest: pipe-C-eDP-1
[372.506146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[372.513262] Starting dynamic subtest: pipe-D-eDP-1
[372.521845] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[372.523525] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[374.710991] [065/155] (647s left) core_setmaster (master-drop-set-user)
[374.802420] Starting subtest: master-drop-set-user
[374.813200] Subtest master-drop-set-user: SUCCESS (0.012s)
[374.847170] [066/155] (647s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[374.945917] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[374.947811] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.032633] [067/155] (647s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[375.126718] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[375.128607] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[375.198699] [068/155] (647s left) kms_frontbuffer_tracking (fbc-stridechange)
[375.285428] Starting subtest: fbc-stridechange
[378.572870] Subtest fbc-stridechange: SUCCESS (3.287s)
[379.731128] [069/155] (642s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[379.838150] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[379.839950] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[379.942387] [070/155] (642s left) perf (unprivileged-single-ctx-counters)
[380.030578] Starting subtest: unprivileged-single-ctx-counters
[380.032711] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[380.072869] [071/155] (642s left) syncobj_timeline (wait-all-delayed-signal)
[380.122571] Starting subtest: wait-all-delayed-signal
[380.225809] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[380.300872] [072/155] (642s left) gem_exec_params (dr1-dirt)
[380.358344] Starting subtest: DR1-dirt
[380.359210] Subtest DR1-dirt: SUCCESS (0.000s)
[380.448168] [073/155] (641s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[380.535477] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[380.537519] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[380.634407] [074/155] (641s left) gem_flink_basic (bad-open)
[380.699084] Starting subtest: bad-open
[380.700510] Subtest bad-open: SUCCESS (0.000s)
[380.802806] [075/155] (641s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[380.898462] Starting subtest: extended-pageflip-modeset-hang-oldfb
[380.899396] Starting dynamic subtest: pipe-A
[388.795217] Dynamic subtest pipe-A: SUCCESS (7.895s)
[388.802985] Starting dynamic subtest: pipe-D
[397.448758] Dynamic subtest pipe-D: SUCCESS (8.650s)
[397.449704] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.551s)
[398.285918] [076/155] (624s left) kms_psr (pr-sprite-plane-move)
[398.372095] Starting subtest: pr-sprite-plane-move
[398.373745] Subtest pr-sprite-plane-move: SKIP (0.000s)
[398.441230] [077/155] (624s left) prime_mmap (test_reprime)
[398.489297] Starting subtest: test_reprime
[398.490132] Starting dynamic subtest: test_reprime-smem
[398.522477] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[398.523539] Subtest test_reprime: SUCCESS (0.034s)
[398.616893] [078/155] (623s left) kms_dp_link_training (non-uhbr-sst)
[398.711429] Starting subtest: non-uhbr-sst
[398.714945] Subtest non-uhbr-sst: SKIP (0.000s)
[398.777772] [079/155] (623s left) i915_query (query-topology-garbage-items)
[398.827105] Starting subtest: query-topology-garbage-items
[398.828106] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[398.928875] [080/155] (623s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[399.025729] Starting subtest: psrhdr-2p-rte
[399.027633] Subtest psrhdr-2p-rte: SKIP (0.000s)
[399.115703] [081/155] (623s left) kms_3d (basic)
[399.159985] Starting subtest: basic
[401.504769] Subtest basic: SUCCESS (2.346s)
[402.009022] [082/155] (620s left) api_intel_bb (blit-reloc-keep-cache)
[402.058431] Starting subtest: blit-reloc-keep-cache
[402.060337] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[402.161972] [083/155] (620s left) perf (enable-disable)
[402.274641] Starting subtest: enable-disable
[402.275727] Starting dynamic subtest: 0-rcs0
[404.543508] Dynamic subtest 0-rcs0: SUCCESS (2.267s)
[404.551824] Starting dynamic subtest: 1-vcs1
[409.040345] Dynamic subtest 1-vcs1: SUCCESS (4.487s)
[409.041227] Subtest enable-disable: SUCCESS (6.757s)
[409.078771] [084/155] (613s left) i915_pm_rpm (sysfs-read)
[410.613070] Starting subtest: sysfs-read
[411.780830] Subtest sysfs-read: SUCCESS (1.169s)
[412.162799] [085/155] (610s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[412.212811] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[412.213762] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[412.309544] [086/155] (610s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[412.401274] Starting subtest: compare-crc-sanitycheck-xr24
[412.402116] Starting dynamic subtest: pipe-A-eDP-1
[413.050061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.648s)
[413.058257] Starting dynamic subtest: pipe-B-eDP-1
[414.375401] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[414.383103] Starting dynamic subtest: pipe-C-eDP-1
[415.601021] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s)
[415.610244] Starting dynamic subtest: pipe-D-eDP-1
[416.837658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[416.838603] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.438s)
[417.700952] [087/155] (605s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[417.803721] Starting subtest: fbchdr-modesetfrombusy
[417.805499] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[417.887750] [088/155] (605s left) kms_flip (blocking-absolute-wf_vblank)
[417.988499] Starting subtest: blocking-absolute-wf_vblank
[417.989501] Starting dynamic subtest: A-eDP1
[426.762298] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[426.772367] Starting dynamic subtest: B-eDP1
[435.473600] Dynamic subtest B-eDP1: SUCCESS (8.707s)
[435.484189] Starting dynamic subtest: C-eDP1
[444.167253] Dynamic subtest C-eDP1: SUCCESS (8.679s)
[444.177312] Starting dynamic subtest: D-eDP1
[452.863979] Dynamic subtest D-eDP1: SUCCESS (8.695s)
[452.864841] Subtest blocking-absolute-wf_vblank: SUCCESS (34.839s)
[454.003946] [089/155] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[454.101843] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[461.599869] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.500s)
[461.709073] [090/155] (561s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[461.760940] Starting subtest: multi-wait-all-for-submit-available-submitted
[461.761817] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[461.863531] [091/155] (561s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[461.952722] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[461.954489] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[462.072223] [092/155] (560s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[462.158738] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[462.160487] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[462.250824] [093/155] (560s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[462.335902] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[462.337547] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[462.426517] [094/155] (560s left) gem_lmem_swapping (heavy-verify-random-ccs)
[462.461452] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[462.499556] [095/155] (560s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[462.551510] Starting subtest: y-tiled-ccs-to-y-tiled
[462.553251] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[462.729938] [096/155] (560s left) i915_hangman (gt-engine-hang)
[462.778933] Starting subtest: gt-engine-hang
[462.779977] Starting dynamic subtest: rcs0
[464.331841] Dynamic subtest rcs0: SUCCESS (1.543s)
[464.341800] Starting dynamic subtest: bcs0
[466.314262] Dynamic subtest bcs0: SUCCESS (1.979s)
[466.324435] Starting dynamic subtest: vcs0
[468.297701] Dynamic subtest vcs0: SUCCESS (1.980s)
[468.307986] Starting dynamic subtest: vcs1
[470.282342] Dynamic subtest vcs1: SUCCESS (1.982s)
[470.294572] Starting dynamic subtest: vecs0
[472.330248] Dynamic subtest vecs0: SUCCESS (2.045s)
[472.340668] Starting dynamic subtest: ccs0
[474.313577] Dynamic subtest ccs0: SUCCESS (1.981s)
[474.314766] Subtest gt-engine-hang: SUCCESS (11.526s)
[474.442847] [097/155] (548s left) perf_pmu (semaphore-wait)
[474.477396] Starting subtest: semaphore-wait
[474.478373] Starting dynamic subtest: rcs0
[475.002441] Dynamic subtest rcs0: SUCCESS (0.514s)
[475.013241] Starting dynamic subtest: bcs0
[475.517815] Dynamic subtest bcs0: SUCCESS (0.512s)
[475.526936] Starting dynamic subtest: vcs0
[476.033408] Dynamic subtest vcs0: SUCCESS (0.513s)
[476.042629] Starting dynamic subtest: vcs1
[476.547788] Dynamic subtest vcs1: SUCCESS (0.511s)
[476.558664] Starting dynamic subtest: vecs0
[477.062957] Dynamic subtest vecs0: SUCCESS (0.512s)
[477.073628] Starting dynamic subtest: ccs0
[477.578045] Dynamic subtest ccs0: SUCCESS (0.512s)
[477.579514] Subtest semaphore-wait: SUCCESS (3.093s)
[477.695761] [098/155] (545s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[477.790987] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[477.792712] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[477.875945] [099/155] (545s left) gem_ctx_persistence (many-contexts)
[477.926307] Starting subtest: many-contexts
[523.130681] Subtest many-contexts: SUCCESS (45.197s)
[523.207405] [100/155] (500s left) syncobj_eventfd (invalid-bad-pad)
[523.265940] Starting subtest: invalid-bad-pad
[523.267052] Subtest invalid-bad-pad: SUCCESS (0.000s)
[523.368823] [101/155] (500s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[523.467204] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[527.027664] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.561s)
[528.210133] [102/155] (495s left) syncobj_wait (invalid-signal-zero-handles)
[528.254962] Starting subtest: invalid-signal-zero-handles
[528.255983] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[528.359889] [103/155] (495s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[528.459568] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[528.461473] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[528.558371] [104/155] (494s left) i915_drm_fdinfo (memory-info-active)
[528.594442] Starting subtest: memory-info-active
[528.595655] Starting dynamic subtest: smem0
[531.367774] Dynamic subtest smem0: SUCCESS (2.772s)
[531.369324] Subtest memory-info-active: SUCCESS (2.773s)
[531.451314] [105/155] (492s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[531.554601] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[531.556321] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[531.642734] [106/155] (491s left) kms_color (ctm-0-75)
[531.733210] Starting subtest: ctm-0-75
[531.734325] Starting dynamic subtest: pipe-A-eDP-1
[536.676783] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.942s)
[536.685431] Starting dynamic subtest: pipe-B-eDP-1
[542.253969] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.576s)
[542.262482] Starting dynamic subtest: pipe-C-eDP-1
[547.717474] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.464s)
[547.727907] Starting dynamic subtest: pipe-D-eDP-1
[553.207308] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.485s)
[553.208336] Subtest ctm-0-75: SUCCESS (21.472s)
[554.014957] [107/155] (469s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[554.110679] Starting subtest: yf-tiled-32bpp-rotate-180
[554.112591] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[554.203707] [108/155] (469s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[554.306293] Starting subtest: random-ccs-data-y-tiled-ccs
[554.307065] Starting dynamic subtest: pipe-A-eDP-1
[554.315556] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[554.323716] Starting dynamic subtest: pipe-B-eDP-1
[554.333436] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[554.343332] Starting dynamic subtest: pipe-C-eDP-1
[554.351849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[554.359864] Starting dynamic subtest: pipe-D-eDP-1
[554.368906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[554.370538] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[556.600508] [109/155] (467s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[556.695173] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[556.697028] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[556.798597] [110/155] (466s left) gem_tiled_partial_pwrite_pread (writes)
[556.858680] Subtest writes: SKIP (0.000s)
[556.924606] [111/155] (466s left) gem_eio (in-flight-internal-10ms)
[557.154706] Starting subtest: in-flight-internal-10ms
[558.376199] Subtest in-flight-internal-10ms: SUCCESS (1.225s)
[558.516246] [112/155] (465s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[558.565179] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[558.670621] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[558.742498] [113/155] (465s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[558.831862] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[558.833498] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[558.942048] [114/155] (464s left) kms_pm_rpm (fences)
[560.459060] Starting subtest: fences
[560.461143] Subtest fences: SKIP (0.000s)
[561.220922] [115/155] (462s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[561.314751] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[561.316662] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[561.399350] [116/155] (462s left) sysfs_heartbeat_interval (mixed)
[561.444793] Starting subtest: mixed
[561.445745] Starting dynamic subtest: vecs0
[566.656106] Dynamic subtest vecs0: SUCCESS (5.210s)
[566.668739] Starting dynamic subtest: ccs0
[571.843416] Dynamic subtest ccs0: SUCCESS (5.185s)
[571.855425] Starting dynamic subtest: vcs0
[577.059635] Dynamic subtest vcs0: SUCCESS (5.215s)
[577.071485] Starting dynamic subtest: bcs0
[582.289427] Dynamic subtest bcs0: SUCCESS (5.228s)
[582.301037] Starting dynamic subtest: rcs0
[587.464580] Dynamic subtest rcs0: SUCCESS (5.174s)
[587.476890] Starting dynamic subtest: vcs1
[592.666274] Dynamic subtest vcs1: SUCCESS (5.199s)
[592.667654] Subtest mixed: SUCCESS (31.221s)
[592.739112] [117/155] (431s left) kms_pipe_crc_basic (bad-source)
[592.825548] Starting subtest: bad-source
[592.826462] Subtest bad-source: SUCCESS (0.000s)
[592.896993] [118/155] (431s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[593.009149] Starting subtest: flip-vs-cursor-legacy
[600.610809] Subtest flip-vs-cursor-legacy: SUCCESS (7.602s)
[601.495858] [119/155] (422s left) syncobj_wait (invalid-signal-illegal-handle)
[601.547714] Starting subtest: invalid-signal-illegal-handle
[601.548593] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[601.636280] [120/155] (422s left) gem_mmap_offset (clear)
[601.688393] Starting subtest: clear
[601.689520] Starting dynamic subtest: smem0
[627.124793] Dynamic subtest smem0: SUCCESS (25.423s)
[627.126197] Subtest clear: SUCCESS (25.432s)
[627.236325] [121/155] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[627.384374] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[627.386339] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[627.492259] [122/155] (396s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[627.576880] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite
[627.578521] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[627.693726] [123/155] (396s left) gem_ctx_engines (independent)
[627.750903] Starting subtest: independent
[627.751783] Starting dynamic subtest: rcs0
[627.900777] Dynamic subtest rcs0: SUCCESS (0.142s)
[627.912434] Starting dynamic subtest: bcs0
[628.021846] Dynamic subtest bcs0: SUCCESS (0.129s)
[628.031129] Starting dynamic subtest: vcs0
[628.180918] Dynamic subtest vcs0: SUCCESS (0.148s)
[628.192652] Starting dynamic subtest: vcs1
[628.350693] Dynamic subtest vcs1: SUCCESS (0.178s)
[628.363098] Starting dynamic subtest: vecs0
[628.542504] Dynamic subtest vecs0: SUCCESS (0.182s)
[628.551948] Starting dynamic subtest: ccs0
[628.717908] Dynamic subtest ccs0: SUCCESS (0.184s)
[628.727502] Starting dynamic subtest: all-engines
[629.575724] Dynamic subtest all-engines: SUCCESS (0.848s)
[629.577347] Subtest independent: SUCCESS (1.818s)
[631.385722] [124/155] (392s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[631.478122] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[631.479042] Starting dynamic subtest: pipe-A-eDP-1
[631.486666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[631.496255] Starting dynamic subtest: pipe-B-eDP-1
[631.504016] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[631.513641] Starting dynamic subtest: pipe-C-eDP-1
[631.521245] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[631.530206] Starting dynamic subtest: pipe-D-eDP-1
[631.537412] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[631.538180] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[633.683813] [125/155] (390s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[633.782819] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[640.985745] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.204s)
[641.109177] [126/155] (383s left) gem_ctx_isolation (dirty-create)
[641.179479] Starting subtest: dirty-create
[641.180603] Starting dynamic subtest: rcs0
[641.356039] Dynamic subtest rcs0: SUCCESS (0.179s)
[641.366460] Starting dynamic subtest: bcs0
[641.565797] Dynamic subtest bcs0: SUCCESS (0.208s)
[641.577909] Starting dynamic subtest: vcs0
[641.764219] Dynamic subtest vcs0: SUCCESS (0.198s)
[641.774158] Starting dynamic subtest: vcs1
[643.527060] Dynamic subtest vcs1: SUCCESS (1.762s)
[643.538539] Starting dynamic subtest: vecs0
[645.534191] Dynamic subtest vecs0: SUCCESS (2.006s)
[645.545752] Starting dynamic subtest: ccs0
[647.550632] Dynamic subtest ccs0: SUCCESS (2.015s)
[647.551756] Subtest dirty-create: SUCCESS (6.374s)
[647.778788] [127/155] (376s left) gen9_exec_parse (bb-chained)
[647.839263] Subtest bb-chained: SKIP (0.000s)
[647.910463] [128/155] (376s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[648.013156] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[648.014820] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[648.126205] [129/155] (376s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[648.207463] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[648.209363] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[648.279434] [130/155] (376s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[648.361409] Starting subtest: primary-yf-tiled-reflect-x-90
[648.363217] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[648.433059] [131/155] (376s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render)
[648.527668] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render
[648.529370] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[648.622425] [132/155] (375s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[648.716853] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[648.718603] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[648.819480] [133/155] (375s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[648.907504] Starting subtest: fbcpsr-rgb565-draw-render
[656.012663] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.105s)
[656.144341] [134/155] (368s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[656.203785] Starting subtest: multi-wait-all-for-submit-signaled
[656.205058] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[656.294409] [135/155] (368s left) kms_pm_backlight (basic-brightness)
[656.394184] Starting subtest: basic-brightness
[656.468542] Starting dynamic subtest: eDP-1
[657.002488] Dynamic subtest eDP-1: SUCCESS (0.533s)
[657.003368] Subtest basic-brightness: SUCCESS (0.608s)
[657.821617] [136/155] (366s left) kms_big_fb (y-tiled-addfb)
[657.920297] Starting subtest: y-tiled-addfb
[657.922370] Subtest y-tiled-addfb: SKIP (0.000s)
[658.015790] [137/155] (366s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[658.111719] Starting subtest: stress-xrgb8888-ytiled
[658.113770] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[658.183255] [138/155] (366s left) gem_exec_fence (basic-wait)
[658.356352] Starting subtest: basic-wait
[658.357266] Starting dynamic subtest: rcs0
[658.439230] Dynamic subtest rcs0: SUCCESS (0.083s)
[658.452503] Starting dynamic subtest: bcs0
[658.500436] Dynamic subtest bcs0: SUCCESS (0.058s)
[658.514199] Starting dynamic subtest: vcs0
[658.562547] Dynamic subtest vcs0: SUCCESS (0.060s)
[658.574821] Starting dynamic subtest: vcs1
[658.626978] Dynamic subtest vcs1: SUCCESS (0.063s)
[658.640224] Starting dynamic subtest: vecs0
[658.682236] Dynamic subtest vecs0: SUCCESS (0.053s)
[658.696795] Starting dynamic subtest: ccs0
[658.741479] Dynamic subtest ccs0: SUCCESS (0.057s)
[658.742850] Subtest basic-wait: SUCCESS (0.387s)
[660.383647] [139/155] (364s left) gem_ctx_sseu (engines)
[660.435421] Subtest engines: SKIP (0.000s)
[660.497862] [140/155] (364s left) gem_exec_reloc (basic-wc-cpu)
[660.546937] Subtest basic-wc-cpu: SKIP (0.000s)
[660.621175] [141/155] (364s left) perf (missing-sample-flags)
[660.718870] Starting subtest: missing-sample-flags
[660.720094] Subtest missing-sample-flags: SUCCESS (0.000s)
[660.756137] [142/155] (364s left) kms_async_flips (test-time-stamp-atomic)
[660.855372] Starting subtest: test-time-stamp-atomic
[661.234912] Starting dynamic subtest: pipe-A-eDP-1
[662.071595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[662.452776] Starting dynamic subtest: pipe-B-eDP-1
[663.267707] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.825s)
[663.638536] Starting dynamic subtest: pipe-C-eDP-1
[664.470771] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.840s)
[664.844445] Starting dynamic subtest: pipe-D-eDP-1
[665.667641] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.830s)
[665.668739] Subtest test-time-stamp-atomic: SUCCESS (4.812s)
[666.899378] [143/155] (357s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[666.992939] Starting subtest: 4-tiled-64bpp-rotate-180
[668.712036] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.719s)
[668.864158] [144/155] (356s left) gem_reg_read (timestamp-monotonic)
[668.918571] Starting subtest: timestamp-monotonic
[673.942909] Subtest timestamp-monotonic: SUCCESS (4.979s)
[673.981407] [145/155] (350s left) kms_vrr (flip-dpms)
[674.074238] Starting subtest: flip-dpms
[674.076855] Subtest flip-dpms: SKIP (0.000s)
[674.156072] [146/155] (350s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[674.248587] Starting subtest: fbcpsr-tiling-linear
[680.898114] Subtest fbcpsr-tiling-linear: SUCCESS (6.650s)
[681.032241] [147/155] (344s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[681.140653] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[681.142718] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[681.241453] [148/155] (343s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[681.629789] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[682.467831] [149/155] (342s left) kms_psr (fbc-psr-cursor-render)
[682.551384] Starting subtest: fbc-psr-cursor-render
[682.552469] Starting dynamic subtest: eDP-1
[682.554252] Dynamic subtest eDP-1: SKIP (0.000s)
[682.555861] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[682.623682] [150/155] (342s left) kms_cursor_crc (cursor-offscreen-128x128)
[682.820287] Starting subtest: cursor-offscreen-128x128
[682.823998] Starting dynamic subtest: pipe-A-eDP-1
[684.765551] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[684.798858] Starting dynamic subtest: pipe-D-eDP-1
[687.376763] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[687.377751] Subtest cursor-offscreen-128x128: SUCCESS (4.556s)
[688.190498] [151/155] (336s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[688.297449] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[688.299534] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[688.393287] [152/155] (336s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[688.490537] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[688.492318] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[688.581841] [153/155] (336s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render)
[688.674620] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render
[688.676440] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[688.764073] [154/155] (336s left) gem_exec_fence (nb-await)
[688.941735] Starting subtest: nb-await
[688.942878] Starting dynamic subtest: rcs0
[689.003217] Dynamic subtest rcs0: SUCCESS (0.067s)
[689.017415] Starting dynamic subtest: bcs0
[689.060906] Dynamic subtest bcs0: SUCCESS (0.056s)
[689.073590] Starting dynamic subtest: vcs0
[689.121128] Dynamic subtest vcs0: SUCCESS (0.058s)
[689.134335] Starting dynamic subtest: vcs1
[689.180767] Dynamic subtest vcs1: SUCCESS (0.057s)
[689.193042] Starting dynamic subtest: vecs0
[689.241023] Dynamic subtest vecs0: SUCCESS (0.058s)
[689.256398] Starting dynamic subtest: ccs0
[689.301764] Dynamic subtest ccs0: SUCCESS (0.058s)
[689.303666] Subtest nb-await: SUCCESS (0.367s)
[691.373959] [155/155] (333s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[691.474524] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[691.476394] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[691.540849] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_psr2_su
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_flush
results: parsing output: 6/ for test: kms_invalid_mode
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_hdr
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: fbdev
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_multiple
results: parsing output: 34/ for test: gem_pwrite
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_sequence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_fb_coherency
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_flink_basic
results: parsing output: 74/ for test: kms_busy
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_3d
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: sysfs_heartbeat_interval
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_engines
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_isolation
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: syncobj_wait
results: parsing output: 134/ for test: kms_pm_backlight
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: kms_pipe_stress
results: parsing output: 137/ for test: gem_exec_fence
results: parsing output: 138/ for test: gem_ctx_sseu
results: parsing output: 139/ for test: gem_exec_reloc
results: parsing output: 140/ for test: perf
results: parsing output: 141/ for test: kms_async_flips
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: gem_reg_read
results: parsing output: 144/ for test: kms_vrr
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_chamelium_hpd
results: parsing output: 148/ for test: kms_psr
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: kms_big_fb
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exec_fence
results: parsing output: 154/ for test: kms_plane
Done.