[56.695526] Initializing watchdogs
[56.695572]   /dev/watchdog0
[56.709019] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.713337] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.715546] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.718754] [001/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[56.862704] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[60.860337] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.013s)
[62.046447] [002/131] (955s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[62.145957] Starting subtest: psr-1p-pri-indfb-multidraw
[85.035222] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.906s)
[85.193743] [003/131] (932s left) kms_cursor_crc (cursor-random-128x128)
[85.408306] Starting subtest: cursor-random-128x128
[85.412386] Starting dynamic subtest: pipe-A-eDP-1
[88.751356] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.337s)
[88.777766] Starting dynamic subtest: pipe-D-eDP-1
[92.723626] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.950s)
[92.726055] Subtest cursor-random-128x128: SUCCESS (7.315s)
[93.607582] [004/131] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[93.721909] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[93.726155] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[93.850971] [005/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[93.941445] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[93.945769] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[94.070703] [006/131] (923s left) kms_flip (dpms-vs-vblank-race)
[94.176390] Starting subtest: dpms-vs-vblank-race
[94.178663] Starting dynamic subtest: A-eDP1
[99.173292] Dynamic subtest A-eDP1: SUCCESS (4.998s)
[99.181220] Starting dynamic subtest: B-eDP1
[102.684028] Dynamic subtest B-eDP1: SUCCESS (3.508s)
[102.692197] Starting dynamic subtest: C-eDP1
[107.318262] Dynamic subtest C-eDP1: SUCCESS (4.633s)
[107.326602] Starting dynamic subtest: D-eDP1
[111.940897] Dynamic subtest D-eDP1: SUCCESS (4.623s)
[111.943332] Subtest dpms-vs-vblank-race: SUCCESS (17.770s)
[112.833565] [007/131] (904s left) kms_flip (2x-absolute-wf_vblank)
[112.935106] Starting subtest: 2x-absolute-wf_vblank
[112.947275] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[113.071494] [008/131] (904s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[118.096500] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[118.098850] Starting dynamic subtest: pipe-A-eDP-1
[118.860689] Dynamic subtest pipe-A-eDP-1: SKIP (0.760s)
[118.868186] Starting dynamic subtest: pipe-B-eDP-1
[119.989232] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[119.993927] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.892s)
[121.208742] [009/131] (896s left) kms_lease (implicit-plane-lease)
[121.320846] Starting subtest: implicit-plane-lease
[121.323140] Subtest implicit-plane-lease: SUCCESS (0.002s)
[121.440425] [010/131] (896s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[121.533100] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[121.535394] Starting dynamic subtest: pipe-A-default-mode
[121.824226] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[121.828772] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.290s)
[122.643442] [011/131] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[122.737573] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[122.741795] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[122.876094] [012/131] (894s left) perf (gen12-mi-rpc)
[123.007502] Starting subtest: gen12-mi-rpc
[123.009415] Starting dynamic subtest: rcs0
[123.023843] Dynamic subtest rcs0: SUCCESS (0.016s)
[123.026108] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[123.062672] [013/131] (894s left) kms_dirtyfb (default-dirtyfb-ioctl)
[123.203174] Starting subtest: default-dirtyfb-ioctl
[123.205464] Starting dynamic subtest: A-eDP-1
[124.763498] Dynamic subtest A-eDP-1: SUCCESS (1.561s)
[124.765923] Subtest default-dirtyfb-ioctl: SUCCESS (1.562s)
[125.585556] [014/131] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[125.691683] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[125.695701] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[125.833934] [015/131] (891s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[125.938803] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[126.929944] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.991s)
[127.106226] [016/131] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[127.204177] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[131.482551] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.280s)
[132.713929] [017/131] (885s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[132.814722] Starting subtest: fbc-rgb565-draw-pwrite
[137.393416] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.582s)
[138.588787] [018/131] (879s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[138.692724] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[142.797344] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.108s)
[143.984414] [019/131] (873s left) kms_atomic_transition (plane-all-transition)
[144.078168] Starting subtest: plane-all-transition
[144.080506] Starting dynamic subtest: pipe-A-eDP-1
[146.570874] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[146.879658] Starting dynamic subtest: pipe-B-eDP-1
[150.087646] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.216s)
[150.388893] Subtest plane-all-transition: SUCCESS (6.311s)
[151.234154] [020/131] (866s left) kms_pm_dc (dc3co-vpb-simulation)
[152.354231] Starting subtest: dc3co-vpb-simulation
[161.129821] Subtest dc3co-vpb-simulation: SKIP (8.771s)
[161.281497] [021/131] (856s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[161.397709] Starting subtest: psr-modesetfrombusy
[167.571506] Subtest psr-modesetfrombusy: SUCCESS (6.178s)
[167.790695] [022/131] (850s left) kms_invalid_mode (uint-max-clock)
[167.900033] Starting subtest: uint-max-clock
[167.902180] Starting dynamic subtest: pipe-A-eDP-1
[168.186438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[168.194630] Starting dynamic subtest: pipe-B-eDP-1
[168.196502] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[168.203150] Starting dynamic subtest: pipe-C-eDP-1
[168.205038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[168.212078] Starting dynamic subtest: pipe-D-eDP-1
[168.214319] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[168.216488] Subtest uint-max-clock: SUCCESS (0.293s)
[169.011194] [023/131] (849s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[169.127639] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[169.131912] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[169.275376] [024/131] (848s left) syncobj_eventfd (timeline-wait)
[169.336138] Starting subtest: timeline-wait
[169.344917] Subtest timeline-wait: SUCCESS (0.010s)
[169.478560] [025/131] (848s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[169.584337] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[169.586678] Starting dynamic subtest: pipe-A-eDP-1
[169.609621] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[169.618859] Starting dynamic subtest: pipe-B-eDP-1
[169.639529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.646784] Starting dynamic subtest: pipe-C-eDP-1
[169.669106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.677214] Starting dynamic subtest: pipe-D-eDP-1
[169.699051] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.703368] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[171.781062] [026/131] (846s left) i915_pm_rpm (gem-execbuf-stress)
[174.018673] Starting subtest: gem-execbuf-stress
[174.020581] Starting dynamic subtest: smem0
[186.760504] Dynamic subtest smem0: SUCCESS (12.743s)
[186.769460] Starting dynamic subtest: extra-wait-smem0
[249.711766] Dynamic subtest extra-wait-smem0: SUCCESS (62.945s)
[249.714866] Subtest gem-execbuf-stress: SUCCESS (75.693s)
[250.111441] [027/131] (768s left) kms_big_fb (linear-64bpp-rotate-90)
[250.226209] Starting subtest: linear-64bpp-rotate-90
[250.245340] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[250.405582] [028/131] (767s left) kms_vblank (wait-forked)
[250.489193] Starting subtest: wait-forked
[250.491099] Starting dynamic subtest: pipe-A-eDP-1
[252.291583] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[252.305071] Starting dynamic subtest: pipe-D-eDP-1
[254.778228] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.483s)
[254.780431] Subtest wait-forked: SUCCESS (4.290s)
[255.664727] [029/131] (762s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[255.772637] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[255.777278] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[255.895108] [030/131] (762s left) prime_self_import (export-vs-gem_close-race)
[255.937650] Starting subtest: export-vs-gem_close-race
[261.031623] Subtest export-vs-gem_close-race: SUCCESS (5.094s)
[261.144624] [031/131] (757s left) gem_partial_pwrite_pread (write-uncached)
[261.212769] Subtest write-uncached: SKIP (0.000s)
[261.297234] [032/131] (757s left) gem_exec_balancer (full-late)
[261.365547] Starting subtest: full-late
[265.813784] Subtest full-late: SUCCESS (4.448s)
[266.170114] [033/131] (752s left) gem_bad_reloc (negative-reloc-lut)
[266.224603] Subtest negative-reloc-lut: SKIP (0.000s)
[266.304620] [034/131] (752s left) kms_psr (fbc-pr-cursor-plane-move)
[266.401095] Starting subtest: fbc-pr-cursor-plane-move
[266.405632] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[266.496954] [035/131] (752s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[266.583806] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[273.277424] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.697s)
[273.410773] [036/131] (745s left) kms_selftest (drm_format_helper)
[273.446468] Starting subtest: drm_format_helper
[273.482407] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[273.632080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.149s)
[273.641919] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[273.756191] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.122s)
[273.767682] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[273.877507] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.120s)
[273.886756] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[274.037679] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.160s)
[274.044954] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[274.199193] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.161s)
[274.207817] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[274.340140] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.140s)
[274.349237] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[274.492177] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.151s)
[274.500224] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[274.617950] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.123s)
[274.626990] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[274.748212] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.130s)
[274.757209] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[274.885864] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.137s)
[274.894748] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[275.019356] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.135s)
[275.027262] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[275.148426] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.126s)
[275.155719] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[275.296671] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.148s)
[275.303860] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[275.447131] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.148s)
[275.456060] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[275.575970] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.128s)
[275.583638] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[275.714082] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.138s)
[275.721749] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[275.837089] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.123s)
[275.839279] Subtest drm_format_helper: SUCCESS (2.393s)
[276.048619] [037/131] (742s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[276.151878] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[276.153800] Starting dynamic subtest: pipe-A-eDP-1
[276.174122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[276.183289] Starting dynamic subtest: pipe-B-eDP-1
[276.203197] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[276.211191] Starting dynamic subtest: pipe-C-eDP-1
[276.230977] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[276.238931] Starting dynamic subtest: pipe-D-eDP-1
[276.259888] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[276.262198] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[278.478613] [038/131] (740s left) gem_render_copy (linear-to-vebox-yf-tiled)
[278.544700] Starting subtest: linear-to-vebox-yf-tiled
[278.548979] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[278.750464] [039/131] (739s left) perf (blocking)
[278.848425] Starting subtest: blocking
[278.850841] Starting dynamic subtest: 0-rcs0
[288.885129] Dynamic subtest 0-rcs0: SUCCESS (10.034s)
[288.892991] Starting dynamic subtest: 1-vecs0
[298.907042] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[298.909787] Subtest blocking: SUCCESS (20.056s)
[298.951849] [040/131] (719s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[299.052829] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[299.055119] Starting dynamic subtest: pipe-A-eDP-1
[299.077562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.085808] Starting dynamic subtest: pipe-B-eDP-1
[299.106438] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.113889] Starting dynamic subtest: pipe-C-eDP-1
[299.135452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.143891] Starting dynamic subtest: pipe-D-eDP-1
[299.165242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.169576] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[301.256450] [041/131] (717s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[301.367229] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[301.369699] Starting dynamic subtest: A-eDP1
[310.270510] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[310.293362] Starting dynamic subtest: B-eDP1
[319.195214] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[319.208741] Starting dynamic subtest: C-eDP1
[328.111829] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[328.119901] Starting dynamic subtest: D-eDP1
[337.037063] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[337.041911] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.674s)
[338.289072] [042/131] (680s left) gem_fenced_exec_thrash (no-spare-fences)
[338.360417] Subtest no-spare-fences: SKIP (0.000s)
[338.436800] [043/131] (680s left) gem_lmem_swapping (heavy-verify-random-ccs)
[338.477581] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[338.521461] [044/131] (680s left) perf_pmu (frequency)
[338.562217] Starting subtest: frequency
[338.564517] Starting dynamic subtest: gt0
[340.669521] Dynamic subtest gt0: SUCCESS (2.101s)
[340.683314] Starting dynamic subtest: idle-gt0
[341.174611] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[341.184730] Starting dynamic subtest: gt1
[345.861784] Dynamic subtest gt1: SUCCESS (4.682s)
[345.870119] Starting dynamic subtest: idle-gt1
[346.407292] Dynamic subtest idle-gt1: SUCCESS (0.545s)
[346.409432] Subtest frequency: SUCCESS (7.849s)
[346.529727] [045/131] (672s left) kms_dsc (dsc-with-bpc-formats)
[346.641262] Starting subtest: dsc-with-bpc-formats
[346.750467] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[346.785477] [046/131] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[346.885570] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[346.889783] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[347.015929] [047/131] (671s left) kms_atomic_transition (modeset-transition-fencing)
[347.113284] Starting subtest: modeset-transition-fencing
[347.115225] Starting dynamic subtest: 1x-outputs
[357.915870] Dynamic subtest 1x-outputs: SUCCESS (10.800s)
[357.918199] Subtest modeset-transition-fencing: SUCCESS (10.801s)
[358.804119] [048/131] (660s left) gem_watchdog (default-virtual)
[358.884764] Starting subtest: default-virtual
[365.157611] Subtest default-virtual: SUCCESS (6.283s)
[365.276580] [049/131] (653s left) syncobj_timeline (wait-for-submit-snapshot)
[365.347596] Starting subtest: wait-for-submit-snapshot
[365.427984] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[365.531628] [050/131] (653s left) sriov_basic (enable-vfs-bind-unbind-each)
[365.591934] Starting subtest: enable-vfs-bind-unbind-each
[365.593967] Starting dynamic subtest: numvfs-1
[365.667803] Dynamic subtest numvfs-1: FAIL (0.014s)
[365.677293] Starting dynamic subtest: numvfs-2
[365.749998] Dynamic subtest numvfs-2: FAIL (0.004s)
[365.759623] Starting dynamic subtest: numvfs-3
[365.832686] Dynamic subtest numvfs-3: FAIL (0.004s)
[365.842636] Starting dynamic subtest: numvfs-4
[365.914647] Dynamic subtest numvfs-4: FAIL (0.004s)
[365.924277] Starting dynamic subtest: numvfs-5
[365.997195] Dynamic subtest numvfs-5: FAIL (0.004s)
[366.006370] Starting dynamic subtest: numvfs-6
[366.079468] Dynamic subtest numvfs-6: FAIL (0.004s)
[366.089683] Starting dynamic subtest: numvfs-7
[366.162422] Dynamic subtest numvfs-7: FAIL (0.004s)
[366.171992] Starting dynamic subtest: numvfs-random
[366.231233] Dynamic subtest numvfs-random: FAIL (0.004s)
[366.233173] Subtest enable-vfs-bind-unbind-each: FAIL (0.045s)
[366.266627] [051/131] (652s left) perf_pmu (render-node-busy)
[366.358880] Starting subtest: render-node-busy
[366.360655] Starting dynamic subtest: rcs0
[366.976594] Dynamic subtest rcs0: SUCCESS (0.619s)
[366.987205] Starting dynamic subtest: bcs0
[367.548259] Dynamic subtest bcs0: SUCCESS (0.570s)
[367.559624] Starting dynamic subtest: vcs0
[368.917204] Dynamic subtest vcs0: SUCCESS (1.365s)
[368.928744] Starting dynamic subtest: vcs1
[370.901108] Dynamic subtest vcs1: SUCCESS (1.981s)
[370.912333] Starting dynamic subtest: vecs0
[372.885017] Dynamic subtest vecs0: SUCCESS (1.981s)
[372.896534] Starting dynamic subtest: ccs0
[373.454073] Dynamic subtest ccs0: SUCCESS (0.568s)
[373.456594] Subtest render-node-busy: SUCCESS (7.098s)
[373.555205] [052/131] (645s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[373.624772] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[373.629455] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[373.837450] [053/131] (645s left) kms_cursor_crc (cursor-suspend)
[373.976888] Starting subtest: cursor-suspend
[373.978748] Starting dynamic subtest: pipe-A-eDP-1
[406.900218] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.687s)
[406.910128] Starting dynamic subtest: pipe-D-eDP-1
[440.884820] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.744s)
[440.887172] Subtest cursor-suspend: SUCCESS (11.435s)
[441.723660] [054/131] (577s left) syncobj_basic (create-signaled)
[441.790106] Starting subtest: create-signaled
[441.792417] Subtest create-signaled: SUCCESS (0.000s)
[441.933882] [055/131] (577s left) syncobj_wait (invalid-reset-bad-pad)
[441.990282] Starting subtest: invalid-reset-bad-pad
[441.992307] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[442.117578] [056/131] (577s left) gem_exec_alignment (pi-isolated)
[442.180024] Starting subtest: pi-isolated
[492.750688] Subtest pi-isolated: SUCCESS (50.661s)
[493.902085] [057/131] (525s left) syncobj_timeline (reset-during-wait-for-submit)
[494.012999] Starting subtest: reset-during-wait-for-submit
[494.116571] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[494.224871] [058/131] (525s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[494.285282] Starting subtest: multi-wait-all-for-submit-unsubmitted
[494.386177] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[494.489561] [059/131] (524s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[494.606521] Starting subtest: fbc-modesetfrombusy
[498.466069] Subtest fbc-modesetfrombusy: SUCCESS (3.863s)
[499.714650] [060/131] (519s left) kms_addfb_basic (too-wide)
[499.826369] Starting subtest: too-wide
[499.828666] Subtest too-wide: SUCCESS (0.000s)
[499.959482] [061/131] (519s left) gem_readwrite (read-write)
[500.029435] Subtest read-write: SKIP (0.000s)
[500.091704] [062/131] (519s left) kms_chamelium_hpd (dp-hpd)
[500.486737] Subtest dp-hpd: SKIP (0.000s)
[501.317617] [063/131] (518s left) kms_psr (fbc-psr-cursor-blt)
[501.416510] Starting subtest: fbc-psr-cursor-blt
[501.418850] Starting dynamic subtest: eDP-1
[501.423392] Dynamic subtest eDP-1: SKIP (0.000s)
[501.427593] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[501.513121] [064/131] (518s left) perf (invalid-remove-userspace-config)
[501.625686] Starting subtest: invalid-remove-userspace-config
[501.639521] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[501.677810] [065/131] (518s left) syncobj_wait (invalid-reset-illegal-handle)
[501.745505] Starting subtest: invalid-reset-illegal-handle
[501.747759] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[501.863324] [066/131] (517s left) vgem_basic (dmabuf-export)
[502.019058] Starting subtest: dmabuf-export
[502.044650] Subtest dmabuf-export: SUCCESS (0.026s)
[502.176949] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[502.179964] [067/131] (517s left) kms_plane_scaling (invalid-num-scalers)
[502.277545] Starting subtest: invalid-num-scalers
[502.279402] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[502.297382] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[502.306403] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[502.329262] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[502.338170] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[502.362923] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[502.371746] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[502.404912] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.038s)
[502.406812] Subtest invalid-num-scalers: SUCCESS (0.127s)
[502.545386] [068/131] (517s left) gem_compute (compute-square)
[502.608671] Starting subtest: compute-square
[502.613082] Subtest compute-square: SUCCESS (0.007s)
[502.752981] [069/131] (517s left) syncobj_timeline (invalid-signal-zero-handles)
[502.819723] Starting subtest: invalid-signal-zero-handles
[502.821763] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[502.950224] [070/131] (516s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[503.045571] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[503.047422] Starting dynamic subtest: pipe-A-eDP-1
[503.065419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[503.074289] Starting dynamic subtest: pipe-B-eDP-1
[503.091799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[503.100380] Starting dynamic subtest: pipe-C-eDP-1
[503.117096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[503.125303] Starting dynamic subtest: pipe-D-eDP-1
[503.143441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[503.147253] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[505.239230] [071/131] (514s left) gem_mmap_offset (ptrace)
[505.288719] Starting subtest: ptrace
[505.291024] Starting dynamic subtest: smem0-wb
[505.306257] Dynamic subtest smem0-wb: SUCCESS (0.017s)
[505.315688] Starting dynamic subtest: smem0-wc
[505.325831] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[505.334988] Starting dynamic subtest: smem0-uc
[505.346404] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[505.348674] Subtest ptrace: SUCCESS (0.061s)
[505.512407] [072/131] (514s left) gem_exec_schedule (preemptive-hang)
[505.691218] Starting subtest: preemptive-hang
[505.693588] Starting dynamic subtest: rcs0
[514.535201] Dynamic subtest rcs0: SUCCESS (8.846s)
[514.551235] Starting dynamic subtest: bcs0
[523.553407] Dynamic subtest bcs0: SUCCESS (9.021s)
[523.562643] Starting dynamic subtest: vcs0
[532.580181] Dynamic subtest vcs0: SUCCESS (9.027s)
[532.591942] Starting dynamic subtest: vcs1
[541.535682] Dynamic subtest vcs1: SUCCESS (8.952s)
[541.551883] Starting dynamic subtest: vecs0
[550.557337] Dynamic subtest vecs0: SUCCESS (9.015s)
[550.573152] Starting dynamic subtest: ccs0
[559.522828] Dynamic subtest ccs0: SUCCESS (8.965s)
[559.525531] Subtest preemptive-hang: SUCCESS (53.836s)
[559.809222] [073/131] (460s left) kms_addfb_basic (basic)
[559.875789] Starting subtest: basic
[559.878505] Subtest basic: SUCCESS (0.000s)
[560.054406] [074/131] (460s left) perf (polling)
[560.153871] Starting subtest: polling
[560.156169] Starting dynamic subtest: 0-rcs0
[570.168953] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[570.179476] Starting dynamic subtest: 1-vcs1
[580.188899] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[580.191338] Subtest polling: SUCCESS (20.033s)
[580.239026] [075/131] (439s left) gen9_exec_parse (bb-start-far)
[580.317177] Subtest bb-start-far: SKIP (0.000s)
[580.408769] [076/131] (439s left) gem_exec_parallel (basic)
[580.481787] Starting subtest: basic
[580.484169] Starting dynamic subtest: rcs0
[582.038962] Dynamic subtest rcs0: SUCCESS (1.556s)
[582.051218] Starting dynamic subtest: bcs0
[583.540193] Dynamic subtest bcs0: SUCCESS (1.499s)
[583.552063] Starting dynamic subtest: vcs0
[585.399274] Dynamic subtest vcs0: SUCCESS (1.856s)
[585.410809] Starting dynamic subtest: vcs1
[587.448066] Dynamic subtest vcs1: SUCCESS (2.047s)
[587.461103] Starting dynamic subtest: vecs0
[589.430696] Dynamic subtest vecs0: SUCCESS (1.980s)
[589.443382] Starting dynamic subtest: ccs0
[590.928387] Dynamic subtest ccs0: SUCCESS (1.496s)
[590.930938] Subtest basic: SUCCESS (10.448s)
[591.144246] [077/131] (429s left) core_setmaster (master-drop-set-user)
[591.245040] Starting subtest: master-drop-set-user
[591.257225] Subtest master-drop-set-user: SUCCESS (0.015s)
[591.298240] [078/131] (428s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[591.414072] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[592.216253] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[592.420335] [079/131] (427s left) gem_exec_fence (syncobj-channel)
[592.874741] Starting subtest: syncobj-channel
[593.896577] Subtest syncobj-channel: SUCCESS (1.018s)
[594.526673] [080/131] (425s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[594.616276] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[594.620645] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[594.729075] [081/131] (425s left) gem_exec_store (pages)
[594.804291] Starting subtest: pages
[594.806512] Starting dynamic subtest: rcs0
[594.905209] Dynamic subtest rcs0: SUCCESS (0.102s)
[594.917162] Starting dynamic subtest: bcs0
[594.982476] Dynamic subtest bcs0: SUCCESS (0.076s)
[594.993628] Starting dynamic subtest: vcs0
[595.048561] Dynamic subtest vcs0: SUCCESS (0.065s)
[595.060383] Starting dynamic subtest: vcs1
[595.123460] Dynamic subtest vcs1: SUCCESS (0.074s)
[595.135181] Starting dynamic subtest: vecs0
[595.216333] Dynamic subtest vecs0: SUCCESS (0.092s)
[595.228178] Starting dynamic subtest: ccs0
[595.297662] Dynamic subtest ccs0: SUCCESS (0.080s)
[595.300134] Subtest pages: SUCCESS (0.495s)
[595.505618] [082/131] (424s left) syncobj_wait (reset-during-wait-for-submit)
[595.571203] Starting subtest: reset-during-wait-for-submit
[595.671858] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[595.776977] [083/131] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[595.878967] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[595.883036] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[596.005509] [084/131] (424s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[596.115561] Starting subtest: fbc-psr2-sprite-mmap-gtt
[596.117831] Starting dynamic subtest: eDP-1
[596.121886] Dynamic subtest eDP-1: SKIP (0.000s)
[596.125978] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[596.215703] [085/131] (424s left) kms_content_protection (uevent)
[596.358994] Starting subtest: uevent
[596.363488] Subtest uevent: SKIP (0.000s)
[596.536623] [086/131] (424s left) gem_mmap_gtt (flink-race)
[596.602204] Subtest flink-race: SKIP (0.000s)
[596.669807] [087/131] (423s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[596.766388] Starting subtest: x-tiled-8bpp-rotate-90
[596.791035] Subtest x-tiled-8bpp-rotate-90: SKIP (0.024s)
[596.957250] [088/131] (423s left) i915_pm_rps (thresholds-idle)
[597.010228] Starting subtest: thresholds-idle
[597.014254] Subtest thresholds-idle: SKIP (0.000s)
[597.153592] [089/131] (423s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[597.250187] Starting subtest: basic-max-pipe-crc-check
[597.253892] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[597.295896] [090/131] (423s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[597.367932] Starting subtest: single-wait-all-for-submit-unsubmitted
[597.474894] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[597.578694] [091/131] (423s left) gem_mmap_gtt (cpuset-big-copy-xy)
[597.632873] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[597.704389] [092/131] (423s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[597.754736] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[597.756895] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[597.899064] [093/131] (423s left) kms_content_protection (atomic)
[598.050758] Starting subtest: atomic
[598.054987] Subtest atomic: SKIP (0.000s)
[598.221172] [094/131] (422s left) gem_softpin (full)
[598.292379] Starting subtest: full
[598.299800] Subtest full: SUCCESS (0.007s)
[598.454556] [095/131] (422s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[598.589554] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[598.593495] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[598.766409] [096/131] (422s left) gem_exec_params (mmapped)
[598.822918] Starting subtest: mmapped
[598.824919] Subtest mmapped: SUCCESS (0.002s)
[598.986416] [097/131] (422s left) kms_psr (psr2-cursor-plane-onoff)
[599.095504] Starting subtest: psr2-cursor-plane-onoff
[599.097398] Starting dynamic subtest: eDP-1
[600.764567] Dynamic subtest eDP-1: SUCCESS (1.665s)
[600.766827] Subtest psr2-cursor-plane-onoff: SUCCESS (1.666s)
[601.592643] [098/131] (419s left) kms_plane_scaling (planes-upscale-20x20)
[601.708577] Starting subtest: planes-upscale-20x20
[601.710855] Starting dynamic subtest: pipe-A
[601.771407] Dynamic subtest pipe-A: SUCCESS (0.065s)
[601.782855] Starting dynamic subtest: pipe-B
[602.876958] Dynamic subtest pipe-B: SUCCESS (1.105s)
[602.888090] Starting dynamic subtest: pipe-C
[603.980854] Dynamic subtest pipe-C: SUCCESS (1.103s)
[603.990876] Starting dynamic subtest: pipe-D
[605.114829] Dynamic subtest pipe-D: SUCCESS (1.133s)
[605.117305] Subtest planes-upscale-20x20: SUCCESS (3.410s)
[606.297934] [099/131] (414s left) gem_sync (basic-many-each)
[606.372380] Starting subtest: basic-many-each
[608.675489] Subtest basic-many-each: SUCCESS (2.313s)
[608.887087] [100/131] (412s left) kms_chamelium_color (ctm-0-50)
[608.991501] Subtest ctm-0-50: SKIP (0.000s)
[609.036333] [101/131] (412s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[609.134079] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[609.136346] Starting dynamic subtest: pipe-A-default-mode
[609.442848] Dynamic subtest pipe-A-default-mode: SKIP (0.307s)
[609.447438] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.308s)
[610.326708] [102/131] (410s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[610.430510] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[619.017850] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.591s)
[619.221095] [103/131] (402s left) sysfs_heartbeat_interval (invalid)
[619.296369] Starting subtest: invalid
[619.298680] Starting dynamic subtest: vecs0
[619.300955] Dynamic subtest vecs0: SUCCESS (0.000s)
[619.311135] Starting dynamic subtest: ccs0
[619.313069] Dynamic subtest ccs0: SUCCESS (0.000s)
[619.321876] Starting dynamic subtest: vcs0
[619.323722] Dynamic subtest vcs0: SUCCESS (0.000s)
[619.333152] Starting dynamic subtest: bcs0
[619.335216] Dynamic subtest bcs0: SUCCESS (0.000s)
[619.346736] Starting dynamic subtest: rcs0
[619.348667] Dynamic subtest rcs0: SUCCESS (0.000s)
[619.358918] Starting dynamic subtest: vcs1
[619.361158] Dynamic subtest vcs1: SUCCESS (0.000s)
[619.363291] Subtest invalid: SUCCESS (0.005s)
[619.451540] [104/131] (401s left) gem_mmap_wc (write-gtt-read-wc)
[619.516160] Subtest write-gtt-read-wc: SKIP (0.000s)
[619.584433] [105/131] (401s left) kms_scaling_modes (scaling-mode-full)
[619.688022] Starting subtest: scaling-mode-full
[619.690230] Starting dynamic subtest: pipe-A-eDP-1
[619.781987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[619.796915] Starting dynamic subtest: pipe-B-eDP-1
[620.911843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[620.921561] Starting dynamic subtest: pipe-C-eDP-1
[622.030582] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[622.042118] Starting dynamic subtest: pipe-D-eDP-1
[623.166436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[623.168946] Subtest scaling-mode-full: SUCCESS (3.483s)
[624.358594] [106/131] (397s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[624.411703] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[624.485357] [107/131] (397s left) syncobj_wait (invalid-wait-illegal-handle)
[624.539075] Starting subtest: invalid-wait-illegal-handle
[624.541375] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[624.677555] [108/131] (396s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[624.723115] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[624.792277] [109/131] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[624.897881] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[624.902302] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[625.020517] [110/131] (396s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[630.025626] Starting subtest: psr2-cursor-plane-update-sf
[630.027950] Starting dynamic subtest: pipe-A-eDP-1
[631.333139] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.308s)
[631.344278] Starting dynamic subtest: pipe-B-eDP-1
[632.669817] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[632.672057] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.646s)
[633.560709] [111/131] (388s left) i915_hangman (engine-engine-hang)
[633.635563] Starting subtest: engine-engine-hang
[633.637478] Starting dynamic subtest: rcs0
[635.414001] Dynamic subtest rcs0: SUCCESS (1.779s)
[635.430639] Starting dynamic subtest: bcs0
[637.333732] Dynamic subtest bcs0: SUCCESS (1.916s)
[637.349242] Starting dynamic subtest: vcs0
[639.381226] Dynamic subtest vcs0: SUCCESS (2.046s)
[639.393955] Starting dynamic subtest: vcs1
[641.365652] Dynamic subtest vcs1: SUCCESS (1.982s)
[641.379069] Starting dynamic subtest: vecs0
[643.415222] Dynamic subtest vecs0: SUCCESS (2.047s)
[643.428188] Starting dynamic subtest: ccs0
[645.397298] Dynamic subtest ccs0: SUCCESS (1.980s)
[645.400184] Subtest engine-engine-hang: SUCCESS (11.767s)
[645.503327] [112/131] (376s left) api_intel_bb (object-noreloc-purge-cache-simple)
[645.566069] Starting subtest: object-noreloc-purge-cache-simple
[645.572700] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[645.692048] [113/131] (376s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[645.795236] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[646.172988] Starting dynamic subtest: pipe-A-eDP-1
[648.912558] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.740s)
[649.276213] Starting dynamic subtest: pipe-B-eDP-1
[652.047646] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.780s)
[652.418296] Starting dynamic subtest: pipe-C-eDP-1
[655.164583] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.755s)
[655.535732] Starting dynamic subtest: pipe-D-eDP-1
[658.301379] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[658.303838] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.509s)
[659.524705] [114/131] (362s left) gem_exec_gttfill (basic)
[659.595227] Starting subtest: basic
[661.980643] Subtest basic: SUCCESS (2.386s)
[662.193114] [115/131] (359s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[662.341666] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[668.888396] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.550s)
[669.048372] [116/131] (352s left) gem_ctx_persistence (engines-hostile-preempt)
[669.116674] Starting subtest: engines-hostile-preempt
[669.118863] Starting dynamic subtest: rcs0
[669.214164] Dynamic subtest rcs0: SUCCESS (0.100s)
[669.225532] Starting dynamic subtest: bcs0
[669.281088] Dynamic subtest bcs0: SUCCESS (0.064s)
[669.291852] Starting dynamic subtest: vcs0
[670.410367] Dynamic subtest vcs0: SUCCESS (1.125s)
[670.423012] Starting dynamic subtest: vcs1
[672.457432] Dynamic subtest vcs1: SUCCESS (2.043s)
[672.469371] Starting dynamic subtest: vecs0
[674.408101] Dynamic subtest vecs0: SUCCESS (1.946s)
[674.418992] Starting dynamic subtest: ccs0
[674.475950] Dynamic subtest ccs0: SUCCESS (0.067s)
[674.478407] Subtest engines-hostile-preempt: SUCCESS (5.361s)
[674.645929] [117/131] (347s left) kms_flip (2x-flip-vs-expired-vblank)
[674.760519] Starting subtest: 2x-flip-vs-expired-vblank
[674.769660] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[674.874688] [118/131] (347s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[674.972769] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[681.518245] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.545s)
[681.668234] [119/131] (340s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[682.052403] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[682.843560] [120/131] (339s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[682.905892] Starting subtest: etime-multi-wait-for-submit-submitted
[683.011641] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[683.108262] [121/131] (339s left) api_intel_allocator (fork-simple-stress)
[683.160881] Starting subtest: fork-simple-stress
[688.558039] Subtest fork-simple-stress: SUCCESS (5.397s)
[688.716851] [122/131] (333s left) kms_pm_rpm (modeset-pc8-residency-stress)
[690.580002] Starting subtest: modeset-pc8-residency-stress
[690.584705] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[691.039621] [123/131] (331s left) i915_drm_fdinfo (most-busy-idle-check-all)
[691.083015] Starting subtest: most-busy-idle-check-all
[691.085197] Starting dynamic subtest: rcs0
[691.089270] Dynamic subtest rcs0: SKIP (0.004s)
[691.099051] Starting dynamic subtest: bcs0
[691.103060] Dynamic subtest bcs0: SKIP (0.000s)
[691.112627] Starting dynamic subtest: vcs0
[691.116920] Dynamic subtest vcs0: SKIP (0.000s)
[691.125573] Starting dynamic subtest: vcs1
[691.129560] Dynamic subtest vcs1: SKIP (0.000s)
[691.137956] Starting dynamic subtest: vecs0
[691.141998] Dynamic subtest vecs0: SKIP (0.000s)
[691.150497] Starting dynamic subtest: ccs0
[691.154474] Dynamic subtest ccs0: SKIP (0.000s)
[691.158465] Subtest most-busy-idle-check-all: SKIP (0.010s)
[691.196678] [124/131] (331s left) kms_plane (pixel-format)
[691.365581] Starting subtest: pixel-format
[691.391940] Starting dynamic subtest: pipe-A-plane-0
[696.381533] Dynamic subtest pipe-A-plane-0: SUCCESS (4.989s)
[696.393582] Starting dynamic subtest: pipe-A-plane-3
[698.682293] Dynamic subtest pipe-A-plane-3: SUCCESS (2.299s)
[698.699456] Starting dynamic subtest: pipe-A-plane-5
[698.892821] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[699.987023] Starting dynamic subtest: pipe-B-plane-0
[704.990237] Dynamic subtest pipe-B-plane-0: SUCCESS (5.011s)
[705.000089] Starting dynamic subtest: pipe-B-plane-3
[707.234942] Dynamic subtest pipe-B-plane-3: SUCCESS (2.243s)
[707.246615] Starting dynamic subtest: pipe-B-plane-5
[707.445972] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[707.753142] Subtest pixel-format: SUCCESS (16.386s)
[708.574866] [125/131] (313s left) gem_exec_schedule (semaphore-noskip)
[708.658784] Starting subtest: semaphore-noskip
[709.068810] Subtest semaphore-noskip: SUCCESS (0.415s)
[709.437230] [126/131] (312s left) syncobj_basic (bad-flags-handle-to-fd)
[709.494436] Starting subtest: bad-flags-handle-to-fd
[709.496566] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[709.632702] [127/131] (312s left) gem_ppgtt (flink-and-close-vma-leak)
[709.699483] Starting subtest: flink-and-close-vma-leak
[709.739810] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[709.897466] [128/131] (312s left) gem_ctx_persistence (userptr)
[709.965711] Starting subtest: userptr
[710.197177] Subtest userptr: SUCCESS (0.234s)
[710.299716] [129/131] (312s left) gem_exec_balancer (parallel-keep-submit-fence)
[710.559668] Starting subtest: parallel-keep-submit-fence
[711.622864] Subtest parallel-keep-submit-fence: SUCCESS (1.064s)
[711.775755] [130/131] (310s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[711.890192] Starting subtest: y-tiled-16bpp-rotate-180
[711.894553] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[712.025481] [131/131] (310s left) kms_psr (psr2-sprite-render)
[712.125877] Starting subtest: psr2-sprite-render
[712.128052] Starting dynamic subtest: eDP-1
[713.854367] Dynamic subtest eDP-1: SUCCESS (1.729s)
[713.856680] Subtest psr2-sprite-render: SUCCESS (1.730s)
[714.741978] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_lease
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_dirtyfb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_atomic_transition
results: parsing output: 19/ for test: kms_pm_dc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_eventfd
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: prime_self_import
results: parsing output: 30/ for test: gem_partial_pwrite_pread
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: gem_bad_reloc
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_selftest
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_fenced_exec_thrash
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_dsc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_atomic_transition
results: parsing output: 47/ for test: gem_watchdog
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: sriov_basic
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: syncobj_basic
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_exec_alignment
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: gem_readwrite
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: gem_compute
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: gen9_exec_parse
results: parsing output: 75/ for test: gem_exec_parallel
results: parsing output: 76/ for test: core_setmaster
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_store
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_multipipe_modeset
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: gem_sync
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: sysfs_heartbeat_interval
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_scaling_modes
results: parsing output: 105/ for test: kms_pipe_b_c_ivb
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: i915_hangman
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: gem_ppgtt
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_psr
Done.