[57.618802] Initializing watchdogs
[57.618857]   /dev/watchdog0
[57.633189] [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.637734] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.640229] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.643639] [001/131] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[57.773187] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[61.817771] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.054s)
[63.046404] [002/131] (955s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[63.138312] Starting subtest: psr-1p-pri-indfb-multidraw
[85.730218] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.601s)
[85.896745] [003/131] (932s left) kms_cursor_crc (cursor-random-128x128)
[86.108041] Starting subtest: cursor-random-128x128
[86.112218] Starting dynamic subtest: pipe-A-eDP-1
[89.451799] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.339s)
[89.482388] Starting dynamic subtest: pipe-D-eDP-1
[93.453571] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.976s)
[93.455926] Subtest cursor-random-128x128: SUCCESS (7.343s)
[94.317195] [004/131] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[94.428099] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[94.432585] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[94.555069] [005/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[94.650200] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[94.654408] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[94.774920] [006/131] (923s left) kms_flip (dpms-vs-vblank-race)
[94.874912] Starting subtest: dpms-vs-vblank-race
[94.877229] Starting dynamic subtest: A-eDP1
[99.894411] Dynamic subtest A-eDP1: SUCCESS (5.015s)
[99.902468] Starting dynamic subtest: B-eDP1
[103.394042] Dynamic subtest B-eDP1: SUCCESS (3.500s)
[103.401629] Starting dynamic subtest: C-eDP1
[107.992021] Dynamic subtest C-eDP1: SUCCESS (4.598s)
[108.002456] Starting dynamic subtest: D-eDP1
[112.622739] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[112.625153] Subtest dpms-vs-vblank-race: SUCCESS (17.750s)
[113.520156] [007/131] (904s left) kms_flip (2x-absolute-wf_vblank)
[113.633115] Starting subtest: 2x-absolute-wf_vblank
[113.645953] Subtest 2x-absolute-wf_vblank: SKIP (0.014s)
[113.745604] [008/131] (904s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[118.777231] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[118.779591] Starting dynamic subtest: pipe-A-eDP-1
[119.561376] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[119.569671] Starting dynamic subtest: pipe-B-eDP-1
[120.691756] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[120.696405] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.913s)
[121.893322] [009/131] (896s left) kms_lease (implicit-plane-lease)
[121.989360] Starting subtest: implicit-plane-lease
[121.991705] Subtest implicit-plane-lease: SUCCESS (0.003s)
[122.138980] [010/131] (896s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[122.232248] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[122.234436] Starting dynamic subtest: pipe-A-default-mode
[122.520574] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[122.525110] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.286s)
[123.429875] [011/131] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[123.535037] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[123.539944] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[123.674632] [012/131] (894s left) perf (gen12-mi-rpc)
[123.815774] Starting subtest: gen12-mi-rpc
[123.818036] Starting dynamic subtest: rcs0
[123.832738] Dynamic subtest rcs0: SUCCESS (0.016s)
[123.834806] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[123.867975] [013/131] (894s left) kms_dirtyfb (default-dirtyfb-ioctl)
[124.020831] Starting subtest: default-dirtyfb-ioctl
[124.023082] Starting dynamic subtest: A-eDP-1
[125.583435] Dynamic subtest A-eDP-1: SUCCESS (1.562s)
[125.585839] Subtest default-dirtyfb-ioctl: SUCCESS (1.563s)
[126.448937] [014/131] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[126.551592] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[126.555680] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[126.665643] [015/131] (892s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[126.769517] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[127.691215] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.923s)
[127.844261] [016/131] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[127.945540] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[132.265670] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.324s)
[133.439073] [017/131] (885s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[133.547728] Starting subtest: fbc-rgb565-draw-pwrite
[138.128050] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.583s)
[139.336685] [018/131] (879s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[139.437818] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[143.574526] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.141s)
[144.744327] [019/131] (874s left) kms_atomic_transition (plane-all-transition)
[144.836493] Starting subtest: plane-all-transition
[144.838902] Starting dynamic subtest: pipe-A-eDP-1
[147.330314] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[147.639330] Starting dynamic subtest: pipe-B-eDP-1
[150.837355] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.210s)
[151.142102] Subtest plane-all-transition: SUCCESS (6.305s)
[151.999925] [020/131] (866s left) kms_pm_dc (dc3co-vpb-simulation)
[153.110337] Starting subtest: dc3co-vpb-simulation
[161.705458] Subtest dc3co-vpb-simulation: SKIP (8.591s)
[161.869239] [021/131] (857s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[161.992639] Starting subtest: psr-modesetfrombusy
[168.116463] Subtest psr-modesetfrombusy: SUCCESS (6.124s)
[168.283337] [022/131] (850s left) kms_invalid_mode (uint-max-clock)
[168.392647] Starting subtest: uint-max-clock
[168.394616] Starting dynamic subtest: pipe-A-eDP-1
[168.674660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[168.687484] Starting dynamic subtest: pipe-B-eDP-1
[168.689698] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[168.701603] Starting dynamic subtest: pipe-C-eDP-1
[168.703881] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[168.715687] Starting dynamic subtest: pipe-D-eDP-1
[168.718033] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[168.720299] Subtest uint-max-clock: SUCCESS (0.289s)
[169.553656] [023/131] (849s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[169.649185] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[169.653302] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[169.769339] [024/131] (849s left) syncobj_eventfd (timeline-wait)
[169.834356] Starting subtest: timeline-wait
[169.843144] Subtest timeline-wait: SUCCESS (0.010s)
[169.979504] [025/131] (849s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[170.069309] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[170.071615] Starting dynamic subtest: pipe-A-eDP-1
[170.094823] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.105022] Starting dynamic subtest: pipe-B-eDP-1
[170.126729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.134075] Starting dynamic subtest: pipe-C-eDP-1
[170.155405] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.162597] Starting dynamic subtest: pipe-D-eDP-1
[170.184400] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.188800] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[172.418256] [026/131] (846s left) i915_pm_rpm (gem-execbuf-stress)
[174.045121] Starting subtest: gem-execbuf-stress
[174.047190] Starting dynamic subtest: smem0
[186.963637] Dynamic subtest smem0: SUCCESS (12.919s)
[186.974153] Starting dynamic subtest: extra-wait-smem0
[249.790947] Dynamic subtest extra-wait-smem0: SUCCESS (62.823s)
[249.793908] Subtest gem-execbuf-stress: SUCCESS (75.748s)
[250.184374] [027/131] (768s left) kms_big_fb (linear-64bpp-rotate-90)
[250.292267] Starting subtest: linear-64bpp-rotate-90
[250.311512] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[250.445457] [028/131] (768s left) kms_vblank (wait-forked)
[250.539264] Starting subtest: wait-forked
[250.541374] Starting dynamic subtest: pipe-A-eDP-1
[252.339509] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s)
[252.352893] Starting dynamic subtest: pipe-D-eDP-1
[254.845623] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.501s)
[254.847904] Subtest wait-forked: SUCCESS (4.307s)
[255.725695] [029/131] (763s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[255.843414] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[255.847528] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[255.961086] [030/131] (763s left) prime_self_import (export-vs-gem_close-race)
[256.002238] Starting subtest: export-vs-gem_close-race
[261.111371] Subtest export-vs-gem_close-race: SUCCESS (5.109s)
[261.210644] [031/131] (758s left) gem_partial_pwrite_pread (write-uncached)
[261.295722] Subtest write-uncached: SKIP (0.000s)
[261.397730] [032/131] (757s left) gem_exec_balancer (full-late)
[261.476821] Starting subtest: full-late
[265.756961] Subtest full-late: SUCCESS (4.280s)
[266.098721] [033/131] (753s left) gem_bad_reloc (negative-reloc-lut)
[266.154501] Subtest negative-reloc-lut: SKIP (0.000s)
[266.240519] [034/131] (753s left) kms_psr (fbc-pr-cursor-plane-move)
[266.339901] Starting subtest: fbc-pr-cursor-plane-move
[266.344083] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[266.435694] [035/131] (753s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[266.532751] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[273.196466] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.667s)
[273.351832] [036/131] (746s left) kms_selftest (drm_format_helper)
[273.391199] Starting subtest: drm_format_helper
[273.425119] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[273.558183] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.133s)
[273.566954] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[273.723258] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.130s)
[273.732570] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[273.800252] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.111s)
[273.817021] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[273.918631] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.119s)
[273.934705] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[274.070483] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.149s)
[274.079981] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[274.203218] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.134s)
[274.210852] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[274.353338] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.147s)
[274.361904] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[274.503080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.149s)
[274.512101] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[274.614141] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.111s)
[274.622115] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[274.747168] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.131s)
[274.756814] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[274.885054] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.137s)
[274.894297] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[275.003144] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.119s)
[275.011482] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[275.151960] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.145s)
[275.161561] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[275.287285] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.135s)
[275.296505] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[275.420991] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.133s)
[275.430075] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[275.544186] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.123s)
[275.553528] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[275.643281] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.099s)
[275.645619] Subtest drm_format_helper: SUCCESS (2.252s)
[275.864557] [037/131] (743s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[275.963120] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[275.965315] Starting dynamic subtest: pipe-A-eDP-1
[275.985648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[275.995217] Starting dynamic subtest: pipe-B-eDP-1
[276.015107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[276.023137] Starting dynamic subtest: pipe-C-eDP-1
[276.042810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[276.050692] Starting dynamic subtest: pipe-D-eDP-1
[276.070795] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[276.072683] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[278.296934] [038/131] (741s left) gem_render_copy (linear-to-vebox-yf-tiled)
[278.369746] Starting subtest: linear-to-vebox-yf-tiled
[278.374362] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[278.573378] [039/131] (741s left) perf (blocking)
[278.685854] Starting subtest: blocking
[278.688372] Starting dynamic subtest: 0-rcs0
[288.739787] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[288.750639] Starting dynamic subtest: 1-vcs1
[298.734222] Dynamic subtest 1-vcs1: SUCCESS (10.018s)
[298.736986] Subtest blocking: SUCCESS (20.046s)
[298.778573] [040/131] (720s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[298.873302] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[298.875605] Starting dynamic subtest: pipe-A-eDP-1
[298.897151] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[298.906320] Starting dynamic subtest: pipe-B-eDP-1
[298.926196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[298.933450] Starting dynamic subtest: pipe-C-eDP-1
[298.954108] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[298.962200] Starting dynamic subtest: pipe-D-eDP-1
[298.985199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[298.989745] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[301.061077] [041/131] (718s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[301.167884] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[301.172881] Starting dynamic subtest: A-eDP1
[310.082648] Dynamic subtest A-eDP1: SUCCESS (8.911s)
[310.104123] Starting dynamic subtest: B-eDP1
[319.005636] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[319.015573] Starting dynamic subtest: C-eDP1
[327.918970] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[327.929808] Starting dynamic subtest: D-eDP1
[336.838759] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[336.841213] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.671s)
[338.086490] [042/131] (681s left) gem_fenced_exec_thrash (no-spare-fences)
[338.137162] Subtest no-spare-fences: SKIP (0.000s)
[338.196445] [043/131] (681s left) gem_lmem_swapping (heavy-verify-random-ccs)
[338.240637] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[338.274257] [044/131] (681s left) perf_pmu (frequency)
[338.319916] Starting subtest: frequency
[338.324761] Starting dynamic subtest: gt0
[340.526226] Dynamic subtest gt0: SUCCESS (2.196s)
[340.536678] Starting dynamic subtest: idle-gt0
[341.031555] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[341.039705] Starting dynamic subtest: gt1
[345.907969] Dynamic subtest gt1: SUCCESS (4.872s)
[345.917439] Starting dynamic subtest: idle-gt1
[346.412811] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[346.415504] Subtest frequency: SUCCESS (8.094s)
[346.539709] [045/131] (673s left) kms_dsc (dsc-with-bpc-formats)
[346.633574] Starting subtest: dsc-with-bpc-formats
[346.743858] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[346.779850] [046/131] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[346.877763] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[346.881894] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[346.980487] [047/131] (672s left) kms_atomic_transition (modeset-transition-fencing)
[347.067327] Starting subtest: modeset-transition-fencing
[347.069576] Starting dynamic subtest: 1x-outputs
[357.898740] Dynamic subtest 1x-outputs: SUCCESS (10.834s)
[357.901262] Subtest modeset-transition-fencing: SUCCESS (10.835s)
[358.766834] [048/131] (661s left) gem_watchdog (default-virtual)
[358.843385] Starting subtest: default-virtual
[365.117036] Subtest default-virtual: SUCCESS (6.284s)
[365.207537] [049/131] (654s left) syncobj_timeline (wait-for-submit-snapshot)
[365.259825] Starting subtest: wait-for-submit-snapshot
[365.340677] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[365.439173] [050/131] (654s left) sriov_basic (enable-vfs-bind-unbind-each)
[365.486295] Starting subtest: enable-vfs-bind-unbind-each
[365.488831] Starting dynamic subtest: numvfs-1
[365.568497] Dynamic subtest numvfs-1: FAIL (0.030s)
[365.578385] Starting dynamic subtest: numvfs-2
[365.650705] Dynamic subtest numvfs-2: FAIL (0.003s)
[365.660783] Starting dynamic subtest: numvfs-3
[365.739504] Dynamic subtest numvfs-3: FAIL (0.003s)
[365.749097] Starting dynamic subtest: numvfs-4
[365.822801] Dynamic subtest numvfs-4: FAIL (0.003s)
[365.831851] Starting dynamic subtest: numvfs-5
[365.904090] Dynamic subtest numvfs-5: FAIL (0.003s)
[365.914082] Starting dynamic subtest: numvfs-6
[365.987020] Dynamic subtest numvfs-6: FAIL (0.003s)
[365.995701] Starting dynamic subtest: numvfs-7
[366.068852] Dynamic subtest numvfs-7: FAIL (0.003s)
[366.078744] Starting dynamic subtest: numvfs-random
[366.148639] Dynamic subtest numvfs-random: FAIL (0.004s)
[366.150606] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s)
[366.185766] [051/131] (653s left) perf_pmu (render-node-busy)
[366.262798] Starting subtest: render-node-busy
[366.264530] Starting dynamic subtest: rcs0
[366.865540] Dynamic subtest rcs0: SUCCESS (0.604s)
[366.876679] Starting dynamic subtest: bcs0
[367.434072] Dynamic subtest bcs0: SUCCESS (0.566s)
[367.445051] Starting dynamic subtest: vcs0
[368.917267] Dynamic subtest vcs0: SUCCESS (1.479s)
[368.928444] Starting dynamic subtest: vcs1
[370.902891] Dynamic subtest vcs1: SUCCESS (1.983s)
[370.913800] Starting dynamic subtest: vecs0
[372.885542] Dynamic subtest vecs0: SUCCESS (1.980s)
[372.894735] Starting dynamic subtest: ccs0
[373.460487] Dynamic subtest ccs0: SUCCESS (0.574s)
[373.463282] Subtest render-node-busy: SUCCESS (7.201s)
[373.560174] [052/131] (646s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[373.614858] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[373.619059] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[373.821471] [053/131] (646s left) kms_cursor_crc (cursor-suspend)
[373.944038] Starting subtest: cursor-suspend
[373.946344] Starting dynamic subtest: pipe-A-eDP-1
[406.487105] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.946s)
[406.496473] Starting dynamic subtest: pipe-D-eDP-1
[440.454604] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.775s)
[440.457381] Subtest cursor-suspend: SUCCESS (10.724s)
[441.284740] [054/131] (578s left) syncobj_basic (create-signaled)
[441.360806] Starting subtest: create-signaled
[441.363002] Subtest create-signaled: SUCCESS (0.000s)
[441.495597] [055/131] (578s left) syncobj_wait (invalid-reset-bad-pad)
[441.556756] Starting subtest: invalid-reset-bad-pad
[441.558891] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[441.673384] [056/131] (578s left) gem_exec_alignment (pi-isolated)
[441.733250] Starting subtest: pi-isolated
[491.159253] Subtest pi-isolated: SUCCESS (49.486s)
[492.315506] [057/131] (527s left) syncobj_timeline (reset-during-wait-for-submit)
[492.419764] Starting subtest: reset-during-wait-for-submit
[492.524316] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[492.626604] [058/131] (527s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[492.690776] Starting subtest: multi-wait-all-for-submit-unsubmitted
[492.793503] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[492.896588] [059/131] (527s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[493.025467] Starting subtest: fbc-modesetfrombusy
[496.847718] Subtest fbc-modesetfrombusy: SUCCESS (3.827s)
[498.111726] [060/131] (522s left) kms_addfb_basic (too-wide)
[498.215235] Starting subtest: too-wide
[498.217499] Subtest too-wide: SUCCESS (0.000s)
[498.358180] [061/131] (522s left) gem_readwrite (read-write)
[498.421159] Subtest read-write: SKIP (0.000s)
[498.493603] [062/131] (521s left) kms_chamelium_hpd (dp-hpd)
[498.897695] Subtest dp-hpd: SKIP (0.000s)
[499.719249] [063/131] (520s left) kms_psr (fbc-psr-cursor-blt)
[499.818801] Starting subtest: fbc-psr-cursor-blt
[499.820765] Starting dynamic subtest: eDP-1
[499.824849] Dynamic subtest eDP-1: SKIP (0.000s)
[499.829087] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[499.914669] [064/131] (520s left) perf (invalid-remove-userspace-config)
[500.044160] Starting subtest: invalid-remove-userspace-config
[500.051509] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[500.089627] [065/131] (520s left) syncobj_wait (invalid-reset-illegal-handle)
[500.149592] Starting subtest: invalid-reset-illegal-handle
[500.151566] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[500.281943] [066/131] (520s left) vgem_basic (dmabuf-export)
[500.402013] Starting subtest: dmabuf-export
[500.443560] Subtest dmabuf-export: SUCCESS (0.042s)
[500.575486] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[500.578662] [067/131] (520s left) kms_plane_scaling (invalid-num-scalers)
[500.675864] Starting subtest: invalid-num-scalers
[500.677884] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[500.695925] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[500.707777] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[500.733400] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[500.743970] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[500.763320] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[500.774356] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[500.792894] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[500.794922] Subtest invalid-num-scalers: SUCCESS (0.119s)
[500.941276] [068/131] (519s left) gem_compute (compute-square)
[501.003527] Starting subtest: compute-square
[501.006863] Subtest compute-square: SUCCESS (0.006s)
[501.168863] [069/131] (519s left) syncobj_timeline (invalid-signal-zero-handles)
[501.232955] Starting subtest: invalid-signal-zero-handles
[501.234871] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[501.370797] [070/131] (519s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[501.472773] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[501.474590] Starting dynamic subtest: pipe-A-eDP-1
[501.493390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.502672] Starting dynamic subtest: pipe-B-eDP-1
[501.519857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.528627] Starting dynamic subtest: pipe-C-eDP-1
[501.546454] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.554929] Starting dynamic subtest: pipe-D-eDP-1
[501.572868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.577354] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[503.732921] [071/131] (517s left) gem_mmap_offset (ptrace)
[503.786886] Starting subtest: ptrace
[503.789342] Starting dynamic subtest: smem0-wb
[503.808924] Dynamic subtest smem0-wb: SUCCESS (0.021s)
[503.823585] Starting dynamic subtest: smem0-wc
[503.836062] Dynamic subtest smem0-wc: SUCCESS (0.026s)
[503.845045] Starting dynamic subtest: smem0-uc
[503.855167] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[503.857432] Subtest ptrace: SUCCESS (0.072s)
[503.992623] [072/131] (516s left) gem_exec_schedule (preemptive-hang)
[504.167768] Starting subtest: preemptive-hang
[504.170581] Starting dynamic subtest: rcs0
[513.866236] Dynamic subtest rcs0: SUCCESS (9.702s)
[513.877910] Starting dynamic subtest: bcs0
[522.819319] Dynamic subtest bcs0: SUCCESS (8.951s)
[522.831474] Starting dynamic subtest: vcs0
[531.840515] Dynamic subtest vcs0: SUCCESS (9.025s)
[531.852363] Starting dynamic subtest: vcs1
[540.867049] Dynamic subtest vcs1: SUCCESS (9.022s)
[540.879014] Starting dynamic subtest: vecs0
[549.830983] Dynamic subtest vecs0: SUCCESS (8.958s)
[549.843195] Starting dynamic subtest: ccs0
[558.853952] Dynamic subtest ccs0: SUCCESS (9.020s)
[558.856434] Subtest preemptive-hang: SUCCESS (54.690s)
[559.138828] [073/131] (461s left) kms_addfb_basic (basic)
[559.204828] Starting subtest: basic
[559.206778] Subtest basic: SUCCESS (0.000s)
[559.361783] [074/131] (461s left) perf (polling)
[559.456097] Starting subtest: polling
[559.458492] Starting dynamic subtest: 0-rcs0
[569.470664] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[569.480928] Starting dynamic subtest: 1-vcs1
[579.495120] Dynamic subtest 1-vcs1: SUCCESS (10.024s)
[579.497843] Subtest polling: SUCCESS (20.038s)
[579.543360] [075/131] (441s left) gen9_exec_parse (bb-start-far)
[579.600863] Subtest bb-start-far: SKIP (0.000s)
[579.680944] [076/131] (441s left) gem_exec_parallel (basic)
[579.755029] Starting subtest: basic
[579.757450] Starting dynamic subtest: rcs0
[581.304342] Dynamic subtest rcs0: SUCCESS (1.549s)
[581.314641] Starting dynamic subtest: bcs0
[582.811231] Dynamic subtest bcs0: SUCCESS (1.504s)
[582.823882] Starting dynamic subtest: vcs0
[584.670639] Dynamic subtest vcs0: SUCCESS (1.856s)
[584.682471] Starting dynamic subtest: vcs1
[586.653876] Dynamic subtest vcs1: SUCCESS (1.980s)
[586.666650] Starting dynamic subtest: vecs0
[588.722687] Dynamic subtest vecs0: SUCCESS (2.046s)
[588.736469] Starting dynamic subtest: ccs0
[590.192619] Dynamic subtest ccs0: SUCCESS (1.491s)
[590.195138] Subtest basic: SUCCESS (10.440s)
[590.406690] [077/131] (430s left) core_setmaster (master-drop-set-user)
[590.509038] Starting subtest: master-drop-set-user
[590.520503] Subtest master-drop-set-user: SUCCESS (0.015s)
[590.560410] [078/131] (430s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[590.662530] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[591.475555] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[591.663112] [079/131] (429s left) gem_exec_fence (syncobj-channel)
[592.117994] Starting subtest: syncobj-channel
[593.138350] Subtest syncobj-channel: SUCCESS (1.017s)
[593.882093] [080/131] (427s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[593.989901] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[593.994117] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[594.122600] [081/131] (427s left) gem_exec_store (pages)
[594.194024] Starting subtest: pages
[594.196381] Starting dynamic subtest: rcs0
[594.300660] Dynamic subtest rcs0: SUCCESS (0.107s)
[594.312263] Starting dynamic subtest: bcs0
[594.391008] Dynamic subtest bcs0: SUCCESS (0.088s)
[594.402882] Starting dynamic subtest: vcs0
[594.464098] Dynamic subtest vcs0: SUCCESS (0.072s)
[594.475785] Starting dynamic subtest: vcs1
[594.542684] Dynamic subtest vcs1: SUCCESS (0.077s)
[594.554310] Starting dynamic subtest: vecs0
[594.622194] Dynamic subtest vecs0: SUCCESS (0.079s)
[594.633759] Starting dynamic subtest: ccs0
[594.693852] Dynamic subtest ccs0: SUCCESS (0.071s)
[594.696160] Subtest pages: SUCCESS (0.500s)
[594.901326] [082/131] (426s left) syncobj_wait (reset-during-wait-for-submit)
[594.964448] Starting subtest: reset-during-wait-for-submit
[595.068222] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[595.172272] [083/131] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[595.286314] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[595.290740] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[595.414945] [084/131] (425s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[595.519383] Starting subtest: fbc-psr2-sprite-mmap-gtt
[595.521594] Starting dynamic subtest: eDP-1
[595.525584] Dynamic subtest eDP-1: SKIP (0.000s)
[595.529605] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[595.615159] [085/131] (425s left) kms_content_protection (uevent)
[595.766562] Starting subtest: uevent
[595.770612] Subtest uevent: SKIP (0.001s)
[595.933686] [086/131] (425s left) gem_mmap_gtt (flink-race)
[596.002320] Subtest flink-race: SKIP (0.000s)
[596.077088] [087/131] (425s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[596.175876] Starting subtest: x-tiled-8bpp-rotate-90
[596.197577] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[596.359409] [088/131] (425s left) i915_pm_rps (thresholds-idle)
[596.422934] Starting subtest: thresholds-idle
[596.426958] Subtest thresholds-idle: SKIP (0.001s)
[596.551223] [089/131] (425s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[596.654953] Starting subtest: basic-max-pipe-crc-check
[596.658640] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[596.700812] [090/131] (424s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[596.763718] Starting subtest: single-wait-all-for-submit-unsubmitted
[596.873800] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[596.979314] [091/131] (424s left) gem_mmap_gtt (cpuset-big-copy-xy)
[597.034024] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[597.098111] [092/131] (424s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[597.160470] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[597.162320] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[597.284821] [093/131] (424s left) kms_content_protection (atomic)
[597.429183] Starting subtest: atomic
[597.434352] Subtest atomic: SKIP (0.000s)
[597.597665] [094/131] (424s left) gem_softpin (full)
[597.669930] Starting subtest: full
[597.676866] Subtest full: SUCCESS (0.008s)
[597.819542] [095/131] (423s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[597.943491] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[597.947199] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[598.135033] [096/131] (423s left) gem_exec_params (mmapped)
[598.192307] Starting subtest: mmapped
[598.196463] Subtest mmapped: SUCCESS (0.003s)
[598.354456] [097/131] (423s left) kms_psr (psr2-cursor-plane-onoff)
[598.454760] Starting subtest: psr2-cursor-plane-onoff
[598.456675] Starting dynamic subtest: eDP-1
[600.176964] Dynamic subtest eDP-1: SUCCESS (1.720s)
[600.178957] Subtest psr2-cursor-plane-onoff: SUCCESS (1.721s)
[600.991899] [098/131] (420s left) kms_plane_scaling (planes-upscale-20x20)
[601.099570] Starting subtest: planes-upscale-20x20
[601.101867] Starting dynamic subtest: pipe-A
[601.160916] Dynamic subtest pipe-A: SUCCESS (0.063s)
[601.178527] Starting dynamic subtest: pipe-B
[602.291243] Dynamic subtest pipe-B: SUCCESS (1.129s)
[602.302337] Starting dynamic subtest: pipe-C
[603.404011] Dynamic subtest pipe-C: SUCCESS (1.112s)
[603.414990] Starting dynamic subtest: pipe-D
[604.529038] Dynamic subtest pipe-D: SUCCESS (1.125s)
[604.531350] Subtest planes-upscale-20x20: SUCCESS (3.434s)
[605.727145] [099/131] (416s left) gem_sync (basic-many-each)
[605.804225] Starting subtest: basic-many-each
[608.070506] Subtest basic-many-each: SUCCESS (2.279s)
[608.277734] [100/131] (413s left) kms_chamelium_color (ctm-0-50)
[608.379346] Subtest ctm-0-50: SKIP (0.000s)
[608.424524] [101/131] (413s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[608.510639] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[608.512895] Starting dynamic subtest: pipe-A-default-mode
[608.810645] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[608.815238] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.299s)
[609.644094] [102/131] (412s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[609.748818] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[618.148683] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.404s)
[618.298489] [103/131] (403s left) sysfs_heartbeat_interval (invalid)
[618.366935] Starting subtest: invalid
[618.369221] Starting dynamic subtest: vecs0
[618.371715] Dynamic subtest vecs0: SUCCESS (0.000s)
[618.387151] Starting dynamic subtest: ccs0
[618.389517] Dynamic subtest ccs0: SUCCESS (0.000s)
[618.401317] Starting dynamic subtest: vcs0
[618.403624] Dynamic subtest vcs0: SUCCESS (0.000s)
[618.414458] Starting dynamic subtest: bcs0
[618.416589] Dynamic subtest bcs0: SUCCESS (0.000s)
[618.425359] Starting dynamic subtest: rcs0
[618.427419] Dynamic subtest rcs0: SUCCESS (0.000s)
[618.438957] Starting dynamic subtest: vcs1
[618.441034] Dynamic subtest vcs1: SUCCESS (0.000s)
[618.443192] Subtest invalid: SUCCESS (0.005s)
[618.501524] [104/131] (403s left) gem_mmap_wc (write-gtt-read-wc)
[618.564506] Subtest write-gtt-read-wc: SKIP (0.000s)
[618.622834] [105/131] (403s left) kms_scaling_modes (scaling-mode-full)
[618.718542] Starting subtest: scaling-mode-full
[618.720699] Starting dynamic subtest: pipe-A-eDP-1
[618.816373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[618.826792] Starting dynamic subtest: pipe-B-eDP-1
[619.985568] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[619.994941] Starting dynamic subtest: pipe-C-eDP-1
[621.100757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[621.110907] Starting dynamic subtest: pipe-D-eDP-1
[622.236998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[622.239434] Subtest scaling-mode-full: SUCCESS (3.521s)
[623.529501] [106/131] (398s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[623.599337] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[623.666486] [107/131] (398s left) syncobj_wait (invalid-wait-illegal-handle)
[623.731112] Starting subtest: invalid-wait-illegal-handle
[623.733403] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[623.869500] [108/131] (398s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[623.937318] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[624.011558] [109/131] (398s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[624.105681] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[624.109830] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[624.236303] [110/131] (398s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[629.263327] Starting subtest: psr2-cursor-plane-update-sf
[629.265726] Starting dynamic subtest: pipe-A-eDP-1
[630.577518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.312s)
[630.586974] Starting dynamic subtest: pipe-B-eDP-1
[631.927087] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[631.929373] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.664s)
[632.819877] [111/131] (389s left) i915_hangman (engine-engine-hang)
[632.883810] Starting subtest: engine-engine-hang
[632.885935] Starting dynamic subtest: rcs0
[634.685629] Dynamic subtest rcs0: SUCCESS (1.802s)
[634.697939] Starting dynamic subtest: bcs0
[636.668088] Dynamic subtest bcs0: SUCCESS (1.980s)
[636.681016] Starting dynamic subtest: vcs0
[638.716674] Dynamic subtest vcs0: SUCCESS (2.046s)
[638.730053] Starting dynamic subtest: vcs1
[640.700440] Dynamic subtest vcs1: SUCCESS (1.982s)
[640.713922] Starting dynamic subtest: vecs0
[642.683627] Dynamic subtest vecs0: SUCCESS (1.981s)
[642.697094] Starting dynamic subtest: ccs0
[644.667727] Dynamic subtest ccs0: SUCCESS (1.982s)
[644.670668] Subtest engine-engine-hang: SUCCESS (11.789s)
[644.774842] [112/131] (377s left) api_intel_bb (object-noreloc-purge-cache-simple)
[644.843771] Starting subtest: object-noreloc-purge-cache-simple
[644.850990] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[645.023737] [113/131] (377s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[645.118117] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[645.500586] Starting dynamic subtest: pipe-A-eDP-1
[648.270588] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.769s)
[648.645580] Starting dynamic subtest: pipe-B-eDP-1
[651.397953] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[651.756474] Starting dynamic subtest: pipe-C-eDP-1
[654.521729] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[654.881083] Starting dynamic subtest: pipe-D-eDP-1
[657.649580] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[657.651992] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.536s)
[658.854224] [114/131] (363s left) gem_exec_gttfill (basic)
[658.927764] Starting subtest: basic
[661.284996] Subtest basic: SUCCESS (2.357s)
[661.501452] [115/131] (361s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[661.649712] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[668.220362] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.571s)
[668.378242] [116/131] (354s left) gem_ctx_persistence (engines-hostile-preempt)
[668.449914] Starting subtest: engines-hostile-preempt
[668.452266] Starting dynamic subtest: rcs0
[668.550797] Dynamic subtest rcs0: SUCCESS (0.100s)
[668.563020] Starting dynamic subtest: bcs0
[668.598214] Dynamic subtest bcs0: SUCCESS (0.045s)
[668.610659] Starting dynamic subtest: vcs0
[669.742622] Dynamic subtest vcs0: SUCCESS (1.141s)
[669.754975] Starting dynamic subtest: vcs1
[671.692976] Dynamic subtest vcs1: SUCCESS (1.947s)
[671.705141] Starting dynamic subtest: vecs0
[673.677475] Dynamic subtest vecs0: SUCCESS (1.982s)
[673.689518] Starting dynamic subtest: ccs0
[673.785136] Dynamic subtest ccs0: SUCCESS (0.107s)
[673.787930] Subtest engines-hostile-preempt: SUCCESS (5.334s)
[673.893569] [117/131] (348s left) kms_flip (2x-flip-vs-expired-vblank)
[673.995722] Starting subtest: 2x-flip-vs-expired-vblank
[674.007566] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[674.109231] [118/131] (348s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[674.208512] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[680.754858] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.546s)
[680.914654] [119/131] (341s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[681.307959] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[682.101703] [120/131] (340s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[682.167021] Starting subtest: etime-multi-wait-for-submit-submitted
[682.274225] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[682.373692] [121/131] (340s left) api_intel_allocator (fork-simple-stress)
[682.438785] Starting subtest: fork-simple-stress
[687.835177] Subtest fork-simple-stress: SUCCESS (5.395s)
[687.999435] [122/131] (334s left) kms_pm_rpm (modeset-pc8-residency-stress)
[689.876945] Starting subtest: modeset-pc8-residency-stress
[689.882181] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[690.295907] [123/131] (332s left) i915_drm_fdinfo (most-busy-idle-check-all)
[690.352602] Starting subtest: most-busy-idle-check-all
[690.355492] Starting dynamic subtest: rcs0
[690.360303] Dynamic subtest rcs0: SKIP (0.004s)
[690.371335] Starting dynamic subtest: bcs0
[690.376018] Dynamic subtest bcs0: SKIP (0.000s)
[690.385414] Starting dynamic subtest: vcs0
[690.390044] Dynamic subtest vcs0: SKIP (0.000s)
[690.399449] Starting dynamic subtest: vcs1
[690.403980] Dynamic subtest vcs1: SKIP (0.000s)
[690.413477] Starting dynamic subtest: vecs0
[690.418020] Dynamic subtest vecs0: SKIP (0.000s)
[690.427545] Starting dynamic subtest: ccs0
[690.431947] Dynamic subtest ccs0: SKIP (0.000s)
[690.436357] Subtest most-busy-idle-check-all: SKIP (0.009s)
[690.477569] [124/131] (332s left) kms_plane (pixel-format)
[690.621969] Starting subtest: pixel-format
[690.647417] Starting dynamic subtest: pipe-A-plane-0
[695.559055] Dynamic subtest pipe-A-plane-0: SUCCESS (4.911s)
[695.568846] Starting dynamic subtest: pipe-A-plane-3
[697.870505] Dynamic subtest pipe-A-plane-3: SUCCESS (2.310s)
[697.883368] Starting dynamic subtest: pipe-A-plane-5
[698.093873] Dynamic subtest pipe-A-plane-5: SUCCESS (0.222s)
[699.254926] Starting dynamic subtest: pipe-B-plane-0
[704.113999] Dynamic subtest pipe-B-plane-0: SUCCESS (4.866s)
[704.126950] Starting dynamic subtest: pipe-B-plane-3
[706.313807] Dynamic subtest pipe-B-plane-3: SUCCESS (2.197s)
[706.332765] Starting dynamic subtest: pipe-B-plane-5
[706.513506] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s)
[706.830872] Subtest pixel-format: SUCCESS (16.207s)
[707.652459] [125/131] (315s left) gem_exec_schedule (semaphore-noskip)
[707.734931] Starting subtest: semaphore-noskip
[708.139089] Subtest semaphore-noskip: SUCCESS (0.412s)
[708.511077] [126/131] (314s left) syncobj_basic (bad-flags-handle-to-fd)
[708.570872] Starting subtest: bad-flags-handle-to-fd
[708.573100] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[708.693084] [127/131] (314s left) gem_ppgtt (flink-and-close-vma-leak)
[708.764356] Starting subtest: flink-and-close-vma-leak
[708.804840] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[708.957664] [128/131] (314s left) gem_ctx_persistence (userptr)
[709.029067] Starting subtest: userptr
[709.231282] Subtest userptr: SUCCESS (0.204s)
[709.336166] [129/131] (313s left) gem_exec_balancer (parallel-keep-submit-fence)
[709.599614] Starting subtest: parallel-keep-submit-fence
[710.655883] Subtest parallel-keep-submit-fence: SUCCESS (1.056s)
[710.807314] [130/131] (312s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[710.918820] Starting subtest: y-tiled-16bpp-rotate-180
[710.923099] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[711.036725] [131/131] (312s left) kms_psr (psr2-sprite-render)
[711.136213] Starting subtest: psr2-sprite-render
[711.138444] Starting dynamic subtest: eDP-1
[712.813845] Dynamic subtest eDP-1: SUCCESS (1.676s)
[712.815830] Subtest psr2-sprite-render: SUCCESS (1.677s)
[713.703762] 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.