[57.123798] Initializing watchdogs
[57.123846]   /dev/watchdog0
[57.150684] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.154955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.157292] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.160829] [001/156] (960s left) kms_frontbuffer_tracking (hdr-suspend)
[57.300893] Starting subtest: hdr-suspend
[57.305321] Subtest hdr-suspend: SKIP (0.000s)
[57.409299] [002/156] (960s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[57.504450] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[57.506781] Starting dynamic subtest: pipe-A-eDP-1
[57.515905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.523057] Starting dynamic subtest: pipe-B-eDP-1
[57.532335] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.541672] Starting dynamic subtest: pipe-C-eDP-1
[57.549966] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.556745] Starting dynamic subtest: pipe-D-eDP-1
[57.564843] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.568694] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[59.809652] [003/156] (957s left) gem_mmap_offset (perf)
[59.869715] Starting subtest: perf
[59.871961] Starting dynamic subtest: smem0
[60.235209] Dynamic subtest smem0: SUCCESS (0.364s)
[60.237589] Subtest perf: SUCCESS (0.364s)
[60.340184] [004/156] (957s left) kms_flip (dpms-off-confusion-interruptible)
[60.431058] Starting subtest: dpms-off-confusion-interruptible
[60.433483] Starting dynamic subtest: A-eDP1
[69.153503] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[69.162112] Starting dynamic subtest: B-eDP1
[77.786765] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[77.795459] Starting dynamic subtest: C-eDP1
[86.418247] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[86.428078] Starting dynamic subtest: D-eDP1
[95.046158] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[95.048316] Subtest dpms-off-confusion-interruptible: SUCCESS (34.564s)
[96.176752] [005/156] (921s left) gem_flink_basic (bad-flink)
[96.236169] Starting subtest: bad-flink
[96.238575] Subtest bad-flink: SUCCESS (0.000s)
[96.319555] [006/156] (921s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[96.411873] Starting subtest: stress-xrgb8888-yftiled
[96.416511] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[96.478581] [007/156] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[96.576227] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[103.217724] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.645s)
[103.339388] [008/156] (914s left) api_intel_allocator (open-vm)
[103.398830] Starting subtest: open-vm
[103.401304] Subtest open-vm: SUCCESS (0.003s)
[103.509140] [009/156] (914s left) kms_pwrite_crc (basic)
[103.598925] Starting subtest: basic
[104.271457] Subtest basic: SUCCESS (0.673s)
[105.129931] [010/156] (912s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[105.220188] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[105.224337] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[105.292244] [011/156] (912s left) kms_flip (2x-dpms-vs-vblank-race)
[105.386531] Starting subtest: 2x-dpms-vs-vblank-race
[105.395238] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[105.480818] [012/156] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[105.575215] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[105.579195] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[105.674903] [013/156] (912s left) gem_partial_pwrite_pread (write-display)
[105.736373] Subtest write-display: SKIP (0.000s)
[105.815785] [014/156] (912s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[105.917315] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[105.921629] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[106.013481] [015/156] (912s left) kms_properties (plane-properties-legacy)
[106.104182] Starting subtest: plane-properties-legacy
[106.105943] Starting dynamic subtest: pipe-A-eDP-1
[106.643897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[106.652997] Starting dynamic subtest: pipe-B-eDP-1
[107.897558] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[107.906775] Starting dynamic subtest: pipe-C-eDP-1
[109.130532] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[109.138139] Starting dynamic subtest: pipe-D-eDP-1
[110.378063] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[110.380356] Subtest plane-properties-legacy: SUCCESS (4.273s)
[111.184145] [016/156] (907s left) gem_mmap_wc (write-read)
[111.242059] Subtest write-read: SKIP (0.000s)
[111.300166] [017/156] (906s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[111.360086] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[111.464798] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[111.533910] [018/156] (906s left) kms_async_flips (async-flip-suspend-resume)
[111.628241] Starting subtest: async-flip-suspend-resume
[112.016246] Starting dynamic subtest: pipe-A-eDP-1
[129.922318] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.001s)
[130.292894] Starting dynamic subtest: pipe-B-eDP-1
[147.892806] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.845s)
[148.268429] Starting dynamic subtest: pipe-C-eDP-1
[165.904288] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.909s)
[166.291894] Starting dynamic subtest: pipe-D-eDP-1
[183.893236] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.860s)
[183.898050] Subtest async-flip-suspend-resume: SUCCESS (13.111s)
[185.077565] [019/156] (833s left) syncobj_wait (wait-all-for-submit-complex)
[185.137646] Starting subtest: wait-all-for-submit-complex
[185.354864] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[185.431702] [020/156] (832s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[185.533093] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[190.231006] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.699s)
[190.382981] [021/156] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[190.484737] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[190.489704] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.573483] [022/156] (827s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[190.686820] Starting subtest: x-tiled-16bpp-rotate-90
[190.706996] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[190.808017] [023/156] (827s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[190.905165] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[190.910079] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[190.990047] [024/156] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[191.095156] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[198.438062] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.344s)
[198.536087] [025/156] (820s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[198.640979] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[198.645382] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[198.734942] [026/156] (819s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[198.836764] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[198.841562] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.939700] [027/156] (819s left) kms_dp_link_training (uhbr-mst)
[199.031132] Starting subtest: uhbr-mst
[199.041614] Subtest uhbr-mst: SKIP (0.000s)
[199.115381] [028/156] (819s left) kms_cursor_crc (cursor-random-32x32)
[199.258707] Starting subtest: cursor-random-32x32
[199.305025] Subtest cursor-random-32x32: SKIP (0.044s)
[199.592760] [029/156] (819s left) perf_pmu (busy-accuracy-50)
[199.634388] Starting subtest: busy-accuracy-50
[199.636433] Starting dynamic subtest: rcs0
[201.170034] Dynamic subtest rcs0: SUCCESS (1.532s)
[201.182658] Starting dynamic subtest: bcs0
[202.712948] Dynamic subtest bcs0: SUCCESS (1.539s)
[202.724748] Starting dynamic subtest: vcs0
[204.252139] Dynamic subtest vcs0: SUCCESS (1.538s)
[204.261765] Starting dynamic subtest: vcs1
[205.794590] Dynamic subtest vcs1: SUCCESS (1.540s)
[205.804918] Starting dynamic subtest: vecs0
[207.333304] Dynamic subtest vecs0: SUCCESS (1.536s)
[207.343368] Starting dynamic subtest: ccs0
[208.878427] Dynamic subtest ccs0: SUCCESS (1.542s)
[208.881351] Subtest busy-accuracy-50: SUCCESS (9.237s)
[208.992891] [030/156] (809s left) gem_mmap_gtt (big-bo-tiledy)
[209.046195] Subtest big-bo-tiledY: SKIP (0.000s)
[209.104641] [031/156] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[209.207852] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[209.213209] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[209.305614] [032/156] (809s left) gem_exec_big (single)
[209.366075] Starting subtest: single
[212.725247] Subtest single: FAIL (3.283s)
[212.764943] [033/156] (806s left) gem_exec_reloc (basic-gtt-wc-active)
[212.869332] Subtest basic-gtt-wc-active: SKIP (0.000s)
[212.925009] [034/156] (806s left) dmabuf_sync_file (export-basic)
[213.016731] Starting subtest: export-basic
[213.018663] Subtest export-basic: SUCCESS (0.001s)
[213.067478] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[213.070863] [035/156] (805s left) syncobj_timeline (multi-wait-for-submit-signaled)
[213.124500] Starting subtest: multi-wait-for-submit-signaled
[213.127179] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[213.220597] [036/156] (805s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[213.280593] Subtest tiled-to-tiled: SKIP (0.000s)
[213.343666] [037/156] (805s left) kms_prime (basic-crc-hybrid)
[213.440574] Subtest basic-crc-hybrid: SKIP (0.000s)
[213.548250] [038/156] (805s left) gem_ppgtt (blt-vs-render-ctxn)
[213.600789] Starting subtest: blt-vs-render-ctxN
[246.338881] Subtest blt-vs-render-ctxN: SUCCESS (32.727s)
[246.467338] [039/156] (772s left) kms_content_protection (atomic-hdcp14)
[246.666259] Starting subtest: atomic-hdcp14
[246.671852] Subtest atomic-hdcp14: SKIP (0.000s)
[246.781290] [040/156] (772s left) gem_exec_flush (basic-uc-pro-default)
[246.850453] Starting subtest: basic-uc-pro-default
[252.346889] Subtest basic-uc-pro-default: SUCCESS (5.454s)
[252.496840] [041/156] (766s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[252.550971] Starting subtest: x-tiled-to-vebox-y-tiled
[252.556190] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[252.734737] [042/156] (766s left) kms_big_fb (linear-8bpp-rotate-90)
[252.828699] Starting subtest: linear-8bpp-rotate-90
[252.850501] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[252.966851] [043/156] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[253.065869] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[253.071010] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[253.172118] [044/156] (766s left) syncobj_timeline (invalid-query-illegal-handle)
[253.226801] Starting subtest: invalid-query-illegal-handle
[253.229364] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[253.317082] [045/156] (766s left) prime_mmap (test_invalid_sync_flags)
[253.376546] Starting subtest: test_invalid_sync_flags
[253.379357] Starting dynamic subtest: test_invalid_sync_flags-smem
[253.381906] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[253.384345] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[253.478111] [046/156] (766s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[253.569667] Starting subtest: bad-rotation-90-yf-tiled-ccs
[253.572359] Starting dynamic subtest: pipe-A-eDP-1
[253.602204] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[253.625759] Starting dynamic subtest: pipe-B-eDP-1
[253.654536] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[253.676832] Starting dynamic subtest: pipe-C-eDP-1
[253.702874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[253.714294] Starting dynamic subtest: pipe-D-eDP-1
[253.738173] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[253.742598] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[255.838908] [047/156] (763s left) gem_exec_schedule (u-semaphore-noskip)
[255.918202] Starting subtest: u-semaphore-noskip
[256.323709] Subtest u-semaphore-noskip: SUCCESS (0.413s)
[257.454911] [048/156] (762s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[257.560343] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[258.572845] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[258.695351] [049/156] (760s left) prime_vgem (basic-blt)
[258.767186] Starting subtest: basic-blt
[258.813630] Subtest basic-blt: SUCCESS (0.046s)
[258.938653] [050/156] (760s left) gem_fence_thrash (bo-copy)
[258.971066] Starting subtest: bo-copy
[258.989901] Subtest bo-copy: SKIP (0.017s)
[259.054693] [051/156] (760s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[259.157917] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[259.162125] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[259.230696] [052/156] (760s left) i915_hangman (error-state-basic)
[259.285132] Starting subtest: error-state-basic
[259.434925] Subtest error-state-basic: SUCCESS (0.151s)
[259.510363] [053/156] (760s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[259.608084] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[259.612205] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[259.697240] [054/156] (760s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[259.798073] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[259.802058] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[259.894664] [055/156] (759s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[259.995168] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[259.998917] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[260.094339] [056/156] (759s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[260.191037] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[260.195360] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.289265] [057/156] (759s left) kms_flip (2x-flip-vs-wf_vblank)
[260.375392] Starting subtest: 2x-flip-vs-wf_vblank
[260.386894] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[260.465076] [058/156] (759s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[260.568248] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[260.573532] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[260.675325] [059/156] (759s left) perf_pmu (rc6-all-gts)
[260.712798] Starting subtest: rc6-all-gts
[267.122547] Subtest rc6-all-gts: SUCCESS (6.354s)
[268.110053] [060/156] (751s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[268.159509] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[268.264607] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[268.344699] [061/156] (751s left) kms_concurrent (multi-plane-atomic-lowres)
[268.435776] Starting subtest: multi-plane-atomic-lowres
[268.437817] Starting dynamic subtest: pipe-A-eDP-1
[268.927382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[268.940798] Starting dynamic subtest: pipe-B-eDP-1
[270.200876] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[270.211156] Starting dynamic subtest: pipe-C-eDP-1
[271.413278] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[271.424325] Starting dynamic subtest: pipe-D-eDP-1
[272.656163] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[272.659187] Subtest multi-plane-atomic-lowres: SUCCESS (4.219s)
[273.476785] [062/156] (746s left) syncobj_timeline (wait-all-for-submit-snapshot)
[273.533264] Starting subtest: wait-all-for-submit-snapshot
[273.614544] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[273.704649] [063/156] (746s left) gem_exec_balancer (nohangcheck)
[273.955113] Starting subtest: nohangcheck
[274.865546] Subtest nohangcheck: SUCCESS (0.908s)
[275.003559] [064/156] (745s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[275.105027] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[275.109907] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[275.187575] [065/156] (745s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[275.290973] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[275.295884] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[275.385860] [066/156] (744s left) kms_lease (lease-invalid-crtc)
[275.479767] Starting subtest: lease-invalid-crtc
[275.482337] Starting dynamic subtest: pipe-A-eDP-1
[275.485177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[275.496068] Starting dynamic subtest: pipe-B-eDP-1
[275.498385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[275.513924] Starting dynamic subtest: pipe-C-eDP-1
[275.516590] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[275.527507] Starting dynamic subtest: pipe-D-eDP-1
[275.530020] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[275.532560] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[275.573087] [067/156] (744s left) gen9_exec_parse (unaligned-jump)
[275.626368] Subtest unaligned-jump: SKIP (0.000s)
[275.697201] [068/156] (744s left) kms_psr (pr-cursor-render)
[275.794189] Starting subtest: pr-cursor-render
[275.799223] Subtest pr-cursor-render: SKIP (0.000s)
[275.869987] [069/156] (744s left) kms_flip (2x-flip-vs-expired-vblank)
[275.952219] Starting subtest: 2x-flip-vs-expired-vblank
[275.962973] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[276.043122] [070/156] (744s left) kms_vblank (wait-busy-hang)
[276.134080] Starting subtest: wait-busy-hang
[276.136219] Starting dynamic subtest: pipe-A-eDP-1
[302.209944] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.081s)
[302.228304] Starting dynamic subtest: pipe-D-eDP-1
[327.165495] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.951s)
[327.168369] Subtest wait-busy-hang: SUCCESS (51.037s)
[328.034029] [071/156] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[328.126865] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[328.131650] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[328.219628] [072/156] (692s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[328.314796] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[328.319250] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[328.420980] [073/156] (692s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[328.811111] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[329.659851] [074/156] (691s left) prime_self_import (reimport-vs-gem_close-race)
[329.696228] Starting subtest: reimport-vs-gem_close-race
[334.799381] Subtest reimport-vs-gem_close-race: SUCCESS (5.099s)
[334.877383] [075/156] (685s left) kms_chamelium_color (ctm-max)
[334.989604] Subtest ctm-max: SKIP (0.000s)
[335.036293] [076/156] (685s left) gem_mmap_wc (read-write)
[335.091157] Subtest read-write: SKIP (0.000s)
[335.154672] [077/156] (685s left) gem_exec_reloc (basic-gtt-cpu-active)
[335.211149] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[335.279818] [078/156] (685s left) kms_cursor_crc (cursor-sliding-256x85)
[335.537240] Starting subtest: cursor-sliding-256x85
[335.586660] Subtest cursor-sliding-256x85: SKIP (0.043s)
[335.759663] [079/156] (685s left) gem_spin_batch (legacy-resubmit-new)
[335.815250] Starting subtest: legacy-resubmit-new
[335.818125] Starting dynamic subtest: default
[335.824780] Dynamic subtest default: SUCCESS (0.009s)
[335.835739] Starting dynamic subtest: render
[335.838229] Dynamic subtest render: SUCCESS (0.003s)
[335.848844] Starting dynamic subtest: bsd
[335.850986] Dynamic subtest bsd: SUCCESS (0.004s)
[335.861096] Starting dynamic subtest: bsd1
[335.863143] Dynamic subtest bsd1: SUCCESS (0.003s)
[335.872926] Starting dynamic subtest: bsd2
[335.875209] Dynamic subtest bsd2: SUCCESS (0.004s)
[335.885738] Starting dynamic subtest: blt
[335.888047] Dynamic subtest blt: SUCCESS (0.005s)
[335.897967] Starting dynamic subtest: vebox
[335.900123] Dynamic subtest vebox: SUCCESS (0.004s)
[335.902493] Subtest legacy-resubmit-new: SUCCESS (0.038s)
[337.449245] [080/156] (683s left) syncobj_wait (single-wait-all-signaled)
[337.507111] Starting subtest: single-wait-all-signaled
[337.509820] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[337.616112] [081/156] (683s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[337.714674] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[338.815974] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.101s)
[338.947757] [082/156] (682s left) kms_universal_plane (universal-plane-functional)
[339.043932] Starting subtest: universal-plane-functional
[339.045671] Starting dynamic subtest: pipe-A-eDP-1
[343.007536] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.963s)
[343.018978] Starting dynamic subtest: pipe-B-eDP-1
[347.400386] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.390s)
[347.412653] Starting dynamic subtest: pipe-C-eDP-1
[351.648110] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.246s)
[351.660621] Starting dynamic subtest: pipe-D-eDP-1
[355.819417] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.166s)
[355.822012] Subtest universal-plane-functional: SUCCESS (16.770s)
[356.654472] [083/156] (664s left) kms_plane_multiple (tiling-none)
[356.751629] Starting subtest: tiling-none
[356.754412] Starting dynamic subtest: pipe-A-eDP-1
[360.613180] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.859s)
[360.624530] Starting dynamic subtest: pipe-B-eDP-1
[365.172177] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.558s)
[365.186158] Starting dynamic subtest: pipe-C-eDP-1
[369.530246] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.355s)
[369.549300] Starting dynamic subtest: pipe-D-eDP-1
[373.980922] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.447s)
[373.983747] Subtest tiling-none: SUCCESS (17.224s)
[374.805928] [084/156] (646s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[374.914154] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[374.920396] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[375.016905] [085/156] (646s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[375.124738] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[375.130073] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.205297] [086/156] (646s left) kms_psr (fbc-psr-sprite-blt)
[375.299526] Starting subtest: fbc-psr-sprite-blt
[375.302047] Starting dynamic subtest: eDP-1
[375.306388] Dynamic subtest eDP-1: SKIP (0.000s)
[375.310971] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[375.375516] [087/156] (645s left) kms_cursor_crc (cursor-offscreen-512x170)
[375.673276] Starting subtest: cursor-offscreen-512x170
[375.679215] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[375.840736] [088/156] (645s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-onoff)
[375.934148] Starting subtest: hdr-1p-primscrn-spr-indfb-onoff
[375.938192] Subtest hdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[376.035096] [089/156] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[376.130248] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[376.134804] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[376.218761] [090/156] (645s left) core_getversion (all-cards)
[376.257077] Starting subtest: all-cards
[376.264631] Subtest all-cards: SUCCESS (0.010s)
[376.316879] [091/156] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[376.414505] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[383.435548] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.022s)
[383.562910] [092/156] (637s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[383.662473] Starting subtest: hdr-rgb565-draw-render
[383.668104] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[383.767749] [093/156] (637s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[384.148261] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[384.963845] [094/156] (636s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[385.055256] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[385.060886] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[385.119384] [095/156] (636s left) kms_atomic_transition (modeset-transition-nonblocking)
[385.209005] Starting subtest: modeset-transition-nonblocking
[385.211090] Starting dynamic subtest: 1x-outputs
[396.303965] Dynamic subtest 1x-outputs: SUCCESS (11.093s)
[396.306772] Subtest modeset-transition-nonblocking: SUCCESS (11.094s)
[397.166420] [096/156] (624s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[397.270964] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[397.276179] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[397.355303] [097/156] (624s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[397.453589] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[397.458546] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[397.562667] [098/156] (624s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[397.653959] Starting subtest: 2x-plain-flip-ts-check-interruptible
[397.665606] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[397.741120] [099/156] (624s left) vgem_basic (bad-pad)
[397.784067] Starting subtest: bad-pad
[397.786544] Subtest bad-pad: SUCCESS (0.000s)
[397.850754] [100/156] (624s left) gem_ppgtt (shrink-vs-evict-any)
[397.913536] Starting subtest: shrink-vs-evict-any
[403.462230] Subtest shrink-vs-evict-any: SUCCESS (5.493s)
[403.506249] [101/156] (618s left) syncobj_wait (wait-any-interrupted)
[403.561949] Starting subtest: wait-any-interrupted
[403.665829] Subtest wait-any-interrupted: SUCCESS (0.104s)
[403.748033] [102/156] (618s left) syncobj_basic (illegal-fd-to-handle)
[403.796726] Starting subtest: illegal-fd-to-handle
[403.799182] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[403.896415] [103/156] (618s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-render)
[403.995764] Starting subtest: fbchdr-rgb565-draw-render
[404.000604] Subtest fbchdr-rgb565-draw-render: SKIP (0.000s)
[404.100701] [104/156] (617s left) fbdev (nullptr)
[404.138730] Starting subtest: nullptr
[404.141411] Subtest nullptr: SUCCESS (0.000s)
[404.197855] [105/156] (617s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[404.249879] Starting subtest: y-tiled-to-vebox-yf-tiled
[404.254957] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[404.429468] [106/156] (617s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move)
[404.533048] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move
[404.538192] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[404.624223] [107/156] (617s left) i915_pm_rpm (system-suspend)
[406.673146] Starting subtest: system-suspend
[424.681400] Subtest system-suspend: SUCCESS (2.863s)
[425.072673] [108/156] (597s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[425.185851] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[425.188281] Starting dynamic subtest: pipe-A-eDP-1
[432.127353] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.933s)
[432.144009] Starting dynamic subtest: pipe-B-eDP-1
[439.231902] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.092s)
[439.234197] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.029s)
[440.132257] [109/156] (582s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[440.210806] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[440.323802] [110/156] (581s left) i915_selftest (perf)
[444.942444] Starting subtest: perf
[444.945595] Starting dynamic subtest: engine_cs
[449.338598] Dynamic subtest engine_cs: SUCCESS (4.392s)
[449.348657] Starting dynamic subtest: request
[456.675305] Dynamic subtest request: SUCCESS (7.332s)
[456.693670] Starting dynamic subtest: migrate
[461.089859] Dynamic subtest migrate: SUCCESS (4.413s)
[461.098914] Starting dynamic subtest: region
[466.825585] Dynamic subtest region: SUCCESS (5.735s)
[466.828284] Subtest perf: SUCCESS (21.879s)
[466.860488] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[466.861236] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[466.864730] [111/156] (555s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[468.416731] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[468.418925] Starting dynamic subtest: pipe-A-eDP-1
[468.442056] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[468.458243] Starting dynamic subtest: pipe-B-eDP-1
[468.480385] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.489183] Starting dynamic subtest: pipe-C-eDP-1
[468.510786] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.519138] Starting dynamic subtest: pipe-D-eDP-1
[468.541253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.545729] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[470.792224] [FACT kms_ccs (missing-ccs-buffer-yf-tiled-ccs)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[470.793420] [FACT kms_ccs (missing-ccs-buffer-yf-tiled-ccs)] new: kernel.kmod_is_loaded.i915: true
[470.796925] [112/156] (551s left) gem_exec_whisper (basic-sync-all)
[470.873237] Starting subtest: basic-sync-all
[476.248233] Subtest basic-sync-all: SUCCESS (5.372s)
[476.431390] [113/156] (545s left) gem_ctx_param (invalid-size-get)
[476.498276] Starting subtest: invalid-size-get
[476.500735] Subtest invalid-size-get: SUCCESS (0.002s)
[476.599486] [114/156] (545s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[476.705004] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[476.709276] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[476.821295] [115/156] (545s left) gem_exec_schedule (implicit-boths)
[476.889370] Starting subtest: implicit-boths
[476.891746] Starting dynamic subtest: rcs0
[477.002751] Dynamic subtest rcs0: SUCCESS (0.123s)
[477.019009] Starting dynamic subtest: vcs0
[477.087206] Dynamic subtest vcs0: SUCCESS (0.084s)
[477.099907] Starting dynamic subtest: vcs1
[477.163097] Dynamic subtest vcs1: SUCCESS (0.075s)
[477.176886] Starting dynamic subtest: vecs0
[477.241626] Dynamic subtest vecs0: SUCCESS (0.077s)
[477.254289] Starting dynamic subtest: ccs0
[477.325564] Dynamic subtest ccs0: SUCCESS (0.083s)
[477.328319] Subtest implicit-boths: SUCCESS (0.447s)
[478.657193] [116/156] (543s left) kms_draw_crc (draw-method-blt)
[478.749785] Starting subtest: draw-method-blt
[478.752099] Starting dynamic subtest: xrgb8888-untiled
[478.993553] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[479.009234] Starting dynamic subtest: rgb565-untiled
[479.204886] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[479.216967] Starting dynamic subtest: xrgb2101010-untiled
[479.415671] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[479.425905] Starting dynamic subtest: xbgr16161616f-untiled
[479.626677] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[479.636453] Starting dynamic subtest: xrgb8888-xtiled
[479.737980] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[479.747823] Starting dynamic subtest: rgb565-xtiled
[479.859781] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[479.872747] Starting dynamic subtest: xrgb2101010-xtiled
[479.959899] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[479.969464] Starting dynamic subtest: xbgr16161616f-xtiled
[480.071089] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[480.081033] Starting dynamic subtest: xrgb8888-4tiled
[480.193749] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[480.203413] Starting dynamic subtest: rgb565-4tiled
[480.315477] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[480.326082] Starting dynamic subtest: xrgb2101010-4tiled
[480.426572] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[480.435969] Starting dynamic subtest: xbgr16161616f-4tiled
[480.537781] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[480.539685] Subtest draw-method-blt: SUCCESS (1.790s)
[480.666292] [117/156] (541s left) gem_lmem_swapping (parallel-random-verify-ccs)
[480.706890] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[480.750428] [118/156] (541s left) gem_cs_tlb (engines)
[480.807818] Starting subtest: engines
[480.810014] Starting dynamic subtest: rcs0
[483.017385] Dynamic subtest rcs0: SUCCESS (2.152s)
[483.036923] Starting dynamic subtest: bcs0
[485.118162] Dynamic subtest bcs0: SUCCESS (2.151s)
[485.130845] Starting dynamic subtest: vcs0
[487.322770] Dynamic subtest vcs0: SUCCESS (2.152s)
[487.332613] Starting dynamic subtest: vcs1
[489.476179] Dynamic subtest vcs1: SUCCESS (2.151s)
[489.488418] Starting dynamic subtest: vecs0
[491.628799] Dynamic subtest vecs0: SUCCESS (2.151s)
[491.642130] Starting dynamic subtest: ccs0
[493.782081] Dynamic subtest ccs0: SUCCESS (2.152s)
[493.784535] Subtest engines: SUCCESS (12.916s)
[493.848503] [119/156] (528s left) kms_plane_scaling (planes-scaler-unity-scaling)
[493.939963] Starting subtest: planes-scaler-unity-scaling
[493.942411] Starting dynamic subtest: pipe-A
[494.001773] Dynamic subtest pipe-A: SUCCESS (0.064s)
[494.014396] Starting dynamic subtest: pipe-B
[495.175152] Dynamic subtest pipe-B: SUCCESS (1.172s)
[495.187198] Starting dynamic subtest: pipe-C
[496.288410] Dynamic subtest pipe-C: SUCCESS (1.111s)
[496.299259] Starting dynamic subtest: pipe-D
[497.436621] Dynamic subtest pipe-D: SUCCESS (1.147s)
[497.439060] Subtest planes-scaler-unity-scaling: SUCCESS (3.499s)
[498.595408] [120/156] (524s left) gem_exec_async (forked-writes)
[498.657564] Starting subtest: forked-writes
[498.659999] Starting dynamic subtest: rcs0
[498.684937] Dynamic subtest rcs0: SUCCESS (0.027s)
[498.702708] Starting dynamic subtest: bcs0
[498.707891] Dynamic subtest bcs0: SUCCESS (0.021s)
[498.720354] Starting dynamic subtest: vcs0
[498.730457] Dynamic subtest vcs0: SUCCESS (0.023s)
[498.741107] Starting dynamic subtest: vcs1
[498.751959] Dynamic subtest vcs1: SUCCESS (0.021s)
[498.762300] Starting dynamic subtest: vecs0
[498.774361] Dynamic subtest vecs0: SUCCESS (0.021s)
[498.785467] Starting dynamic subtest: ccs0
[498.798077] Dynamic subtest ccs0: SUCCESS (0.023s)
[498.800302] Subtest forked-writes: SUCCESS (0.141s)
[499.047117] [121/156] (523s left) gem_userptr_blits (create-destroy-unsync)
[499.111308] Subtest create-destroy-unsync: SKIP (0.000s)
[499.231097] [122/156] (523s left) kms_addfb_basic (bad-pitch-0)
[499.289287] Starting subtest: bad-pitch-0
[499.291566] Subtest bad-pitch-0: SUCCESS (0.000s)
[499.448992] [123/156] (523s left) kms_getfb (getfb-handle-protection)
[499.550821] Starting subtest: getfb-handle-protection
[499.569646] Subtest getfb-handle-protection: SUCCESS (0.020s)
[499.686602] [124/156] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[499.794115] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[499.798191] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[499.881709] [125/156] (523s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[499.968631] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[499.970409] Starting dynamic subtest: pipe-A-eDP-1
[499.986927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[499.996263] Starting dynamic subtest: pipe-B-eDP-1
[500.012453] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[500.021506] Starting dynamic subtest: pipe-C-eDP-1
[500.037548] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[500.046431] Starting dynamic subtest: pipe-D-eDP-1
[500.062339] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[500.064145] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[502.261729] [126/156] (520s left) gem_ctx_persistence (saturated-hostile)
[502.324185] Starting subtest: saturated-hostile
[502.326593] Starting dynamic subtest: rcs0
[503.132216] Dynamic subtest rcs0: SUCCESS (0.807s)
[503.145915] Starting dynamic subtest: bcs0
[503.923783] Dynamic subtest bcs0: SUCCESS (0.790s)
[503.938333] Starting dynamic subtest: vcs0
[504.718233] Dynamic subtest vcs0: SUCCESS (0.792s)
[504.730081] Starting dynamic subtest: vcs1
[505.518028] Dynamic subtest vcs1: SUCCESS (0.798s)
[505.530821] Starting dynamic subtest: vecs0
[506.318366] Dynamic subtest vecs0: SUCCESS (0.798s)
[506.330911] Starting dynamic subtest: ccs0
[507.164264] Dynamic subtest ccs0: SUCCESS (0.844s)
[507.167762] Subtest saturated-hostile: SUCCESS (4.839s)
[507.283456] [127/156] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[507.382886] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[507.386781] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[507.477800] [128/156] (515s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[507.570466] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[507.574441] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[507.691117] [129/156] (515s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[507.790833] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[507.794704] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[507.883718] [130/156] (515s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[507.966991] Starting subtest: plane-all-modeset-transition-internal-panels
[507.969223] Starting dynamic subtest: pipe-A-eDP-1
[509.299747] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.332s)
[509.590685] Starting dynamic subtest: pipe-B-eDP-1
[510.633153] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[510.902607] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.935s)
[511.754551] [131/156] (511s left) gem_exec_schedule (preempt-other-chain)
[511.823285] Starting subtest: preempt-other-chain
[511.825611] Starting dynamic subtest: rcs0
[511.898540] Dynamic subtest rcs0: SUCCESS (0.083s)
[511.914871] Starting dynamic subtest: bcs0
[511.980093] Dynamic subtest bcs0: SUCCESS (0.080s)
[511.997675] Starting dynamic subtest: vcs0
[512.056586] Dynamic subtest vcs0: SUCCESS (0.076s)
[512.074148] Starting dynamic subtest: vcs1
[512.134569] Dynamic subtest vcs1: SUCCESS (0.077s)
[512.151727] Starting dynamic subtest: vecs0
[512.213977] Dynamic subtest vecs0: SUCCESS (0.078s)
[512.230149] Starting dynamic subtest: ccs0
[512.298694] Dynamic subtest ccs0: SUCCESS (0.084s)
[512.301169] Subtest preempt-other-chain: SUCCESS (0.483s)
[513.667446] [132/156] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[513.774678] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[513.778656] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[513.886046] [133/156] (509s left) gem_tiling_max_stride
[514.009469] [134/156] (509s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[514.116239] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[514.120301] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[514.185748] [135/156] (509s left) gen7_exec_parse (bitmasks)
[514.251414] Subtest bitmasks: SKIP (0.000s)
[514.316363] [136/156] (509s left) gem_exec_schedule (wide)
[514.496392] Starting subtest: wide
[514.501427] Starting dynamic subtest: rcs0
[524.244329] Dynamic subtest rcs0: SUCCESS (9.698s)
[524.256376] Starting dynamic subtest: vcs0
[536.566280] Dynamic subtest vcs0: SUCCESS (12.377s)
[536.578420] Starting dynamic subtest: vcs1
[548.075625] Dynamic subtest vcs1: SUCCESS (11.511s)
[548.088627] Starting dynamic subtest: vecs0
[559.148968] Dynamic subtest vecs0: SUCCESS (11.073s)
[559.162099] Starting dynamic subtest: ccs0
[573.602605] Dynamic subtest ccs0: SUCCESS (14.400s)
[573.604911] Subtest wide: SUCCESS (59.064s)
[576.967372] [137/156] (446s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[577.063915] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[577.068240] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[577.159794] [138/156] (446s left) kms_joiner (basic-force-big-joiner)
[577.250002] Starting subtest: basic-force-big-joiner
[577.253953] Subtest basic-force-big-joiner: SKIP (0.000s)
[577.318950] [139/156] (446s left) kms_psr (fbc-psr2-cursor-plane-move)
[577.421558] Starting subtest: fbc-psr2-cursor-plane-move
[577.423763] Starting dynamic subtest: eDP-1
[577.427887] Dynamic subtest eDP-1: SKIP (0.000s)
[577.432650] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[577.492966] [140/156] (446s left) gem_mmap_wc (invalid-flags)
[577.551338] Subtest invalid-flags: SKIP (0.000s)
[577.612812] [141/156] (445s left) gem_exec_fence (keep-in-fence)
[577.799969] Starting subtest: keep-in-fence
[577.802664] Starting dynamic subtest: rcs0
[577.867865] Dynamic subtest rcs0: SUCCESS (0.068s)
[577.880497] Starting dynamic subtest: bcs0
[577.920081] Dynamic subtest bcs0: SUCCESS (0.051s)
[577.931154] Starting dynamic subtest: vcs0
[579.562988] Dynamic subtest vcs0: SUCCESS (1.639s)
[579.583792] Starting dynamic subtest: vcs1
[581.548026] Dynamic subtest vcs1: SUCCESS (1.982s)
[581.561441] Starting dynamic subtest: vecs0
[583.646953] Dynamic subtest vecs0: SUCCESS (2.044s)
[583.661791] Starting dynamic subtest: ccs0
[583.834488] Dynamic subtest ccs0: SUCCESS (0.238s)
[583.837419] Subtest keep-in-fence: SUCCESS (6.035s)
[585.692553] [142/156] (437s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[585.785305] Starting subtest: primary-yf-tiled-reflect-x-90
[585.789666] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[585.862478] [143/156] (437s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[585.950050] Starting subtest: plane-downscale-factor-0-75-with-rotation
[585.952496] Starting dynamic subtest: pipe-A
[586.178227] Dynamic subtest pipe-A: SUCCESS (0.232s)
[586.188082] Starting dynamic subtest: pipe-B
[587.519915] Dynamic subtest pipe-B: SUCCESS (1.341s)
[587.530544] Starting dynamic subtest: pipe-C
[588.865147] Dynamic subtest pipe-C: SUCCESS (1.344s)
[588.875150] Starting dynamic subtest: pipe-D
[590.225399] Dynamic subtest pipe-D: SUCCESS (1.359s)
[590.227735] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.279s)
[591.381087] [144/156] (432s left) gem_ctx_param (vm)
[591.428125] Starting subtest: vm
[591.484214] Subtest vm: SUCCESS (0.057s)
[591.633606] [145/156] (432s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[591.732377] Starting subtest: psr-rgb565-draw-blt
[598.834935] Subtest psr-rgb565-draw-blt: SUCCESS (7.108s)
[598.966131] [146/156] (424s left) kms_pm_dc (dc6-psr)
[600.058792] Starting subtest: dc6-psr
[602.946228] Subtest dc6-psr: SUCCESS (2.884s)
[603.769101] [147/156] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[603.864775] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[603.868761] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[603.963639] [148/156] (419s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[604.066118] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[611.408870] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.347s)
[611.534878] [149/156] (412s left) sw_sync (sync_busy_fork_unixsocket)
[611.571702] Starting subtest: sync_busy_fork_unixsocket
[611.580181] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[611.635006] [150/156] (412s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[611.740176] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[611.744274] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[611.837185] [151/156] (412s left) kms_flip (nonblocking-read)
[611.930891] Starting subtest: nonblocking-read
[611.933719] Subtest nonblocking-read: SUCCESS (0.000s)
[612.041255] [152/156] (412s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[612.140977] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[612.144992] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[612.236384] [153/156] (411s left) gem_pread (display)
[612.301709] Subtest display: SKIP (0.000s)
[612.354369] [154/156] (411s left) prime_mmap (test_errors)
[612.401771] Starting subtest: test_errors
[612.403744] Starting dynamic subtest: test_errors-smem
[612.497038] Dynamic subtest test_errors-smem: SUCCESS (0.095s)
[612.499353] Subtest test_errors: SUCCESS (0.097s)
[612.614221] [155/156] (411s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[612.699130] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[612.701135] Starting dynamic subtest: pipe-A-default-mode
[615.391088] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[615.393589] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.692s)
[616.260464] [156/156] (407s left) kms_psr (psr2-sprite-mmap-cpu)
[616.366118] Starting subtest: psr2-sprite-mmap-cpu
[616.368590] Starting dynamic subtest: eDP-1
[618.077073] Dynamic subtest eDP-1: SUCCESS (1.711s)
[618.079427] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.712s)
[618.938541] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_mmap_offset
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_flink_basic
results: parsing output: 5/ for test: kms_pipe_stress
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: kms_pwrite_crc
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_partial_pwrite_pread
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_async_flips
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_dp_link_training
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_big
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: dmabuf_sync_file
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: kms_prime
results: parsing output: 37/ for test: gem_ppgtt
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: prime_mmap
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: prime_vgem
results: parsing output: 49/ for test: gem_fence_thrash
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_concurrent
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: prime_self_import
results: parsing output: 74/ for test: kms_chamelium_color
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gem_spin_batch
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_universal_plane
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: core_getversion
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_chamelium_hpd
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: fbdev
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: i915_selftest
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: gem_ctx_param
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_draw_crc
results: parsing output: 116/ for test: gem_lmem_swapping
results: parsing output: 117/ for test: gem_cs_tlb
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_atomic_transition
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_tiling_max_stride
results: parsing output: 133/ for test: kms_psr2_sf
results: parsing output: 134/ for test: gen7_exec_parse
results: parsing output: 135/ for test: gem_exec_schedule
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_joiner
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: gem_mmap_wc
results: parsing output: 140/ for test: gem_exec_fence
results: parsing output: 141/ for test: kms_rotation_crc
results: parsing output: 142/ for test: kms_plane_scaling
results: parsing output: 143/ for test: gem_ctx_param
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_pm_dc
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: sw_sync
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_pread
results: parsing output: 153/ for test: prime_mmap
results: parsing output: 154/ for test: kms_flip_scaled_crc
results: parsing output: 155/ for test: kms_psr
Done.