[58.112048] Initializing watchdogs
[58.112091]   /dev/watchdog0
[58.125550] [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]
[58.129874] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.132202] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.135465] [001/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[58.254070] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[58.256470] Starting dynamic subtest: pipe-A-eDP-1
[58.712764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[58.722226] Starting dynamic subtest: pipe-B-eDP-1
[58.742482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[58.750236] Starting dynamic subtest: pipe-C-eDP-1
[58.769668] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[58.776284] Starting dynamic subtest: pipe-D-eDP-1
[58.796716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[58.799069] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.472s)
[60.974200] [002/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[61.070344] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[61.074682] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[61.163111] [003/133] (957s left) kms_psr (pr-cursor-blt)
[61.260206] Starting subtest: pr-cursor-blt
[61.264581] Subtest pr-cursor-blt: SKIP (0.000s)
[61.330793] [004/133] (957s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[61.416968] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[61.792354] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[64.591302] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.743s)
[64.600134] Starting dynamic subtest: pipe-A-eDP-1-4
[66.763244] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[66.773499] Starting dynamic subtest: pipe-A-eDP-1-4
[68.722065] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[68.732034] Starting dynamic subtest: pipe-A-eDP-1-x
[70.963526] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[71.284527] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[74.118640] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[74.129736] Starting dynamic subtest: pipe-B-eDP-1-4
[76.304541] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[76.316692] Starting dynamic subtest: pipe-B-eDP-1-4
[78.262909] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[78.270817] Starting dynamic subtest: pipe-B-eDP-1-x
[80.504647] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[80.823272] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[83.651454] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[83.663270] Starting dynamic subtest: pipe-C-eDP-1-4
[85.847362] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.195s)
[85.857502] Starting dynamic subtest: pipe-C-eDP-1-4
[87.805724] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[87.815452] Starting dynamic subtest: pipe-C-eDP-1-x
[90.047133] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[90.358855] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[93.129937] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[93.142078] Starting dynamic subtest: pipe-D-eDP-1-4
[95.378463] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.195s)
[95.388493] Starting dynamic subtest: pipe-D-eDP-1-4
[97.336221] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[97.346207] Starting dynamic subtest: pipe-D-eDP-1-x
[99.565929] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[99.568807] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.098s)
[100.717836] [005/133] (918s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[100.829156] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[100.833370] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[100.911076] [006/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[101.000506] Starting subtest: primary-4-tiled-reflect-x-180
[108.062605] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.064s)
[109.292862] [007/133] (909s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[109.397450] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[110.497556] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.100s)
[110.625041] [008/133] (908s left) gem_userptr_blits (dmabuf-sync)
[110.704570] Starting subtest: dmabuf-sync
[110.710759] Subtest dmabuf-sync: SKIP (0.003s)
[110.853471] [009/133] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[110.951711] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[118.128086] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.176s)
[118.271850] [010/133] (900s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[118.404180] Starting subtest: cursorA-vs-flipB-atomic-transitions
[118.408749] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[118.546882] [011/133] (900s left) kms_chamelium_hpd (hdmi-hpd)
[118.919080] Subtest hdmi-hpd: SKIP (0.000s)
[119.742395] [012/133] (899s left) kms_frontbuffer_tracking (fbc-stridechange)
[119.839850] Starting subtest: fbc-stridechange
[123.165397] Subtest fbc-stridechange: SUCCESS (3.329s)
[124.359658] [013/133] (894s left) gem_ctx_shared (q-independent)
[124.419672] Starting subtest: Q-independent
[124.422258] Starting dynamic subtest: rcs0
[124.486713] Dynamic subtest rcs0: SUCCESS (0.066s)
[124.496917] Starting dynamic subtest: vcs0
[124.528442] Dynamic subtest vcs0: SUCCESS (0.042s)
[124.536408] Starting dynamic subtest: vcs1
[124.572202] Dynamic subtest vcs1: SUCCESS (0.044s)
[124.581430] Starting dynamic subtest: vecs0
[124.607646] Dynamic subtest vecs0: SUCCESS (0.035s)
[124.616326] Starting dynamic subtest: ccs0
[124.660730] Dynamic subtest ccs0: SUCCESS (0.052s)
[124.663812] Subtest Q-independent: SUCCESS (0.240s)
[125.996835] [014/133] (893s left) gem_madvise (dontneed-before-mmap)
[126.033164] Starting subtest: dontneed-before-mmap
[126.062405] Subtest dontneed-before-mmap: SUCCESS (0.029s)
[126.173224] [015/133] (892s left) gem_wait (write-busy)
[126.238011] Starting subtest: write-busy
[126.240456] Starting dynamic subtest: all-engines
[126.877587] Dynamic subtest all-engines: SUCCESS (0.639s)
[126.892489] Starting dynamic subtest: rcs0
[127.428833] Dynamic subtest rcs0: SUCCESS (0.550s)
[127.442850] Starting dynamic subtest: bcs0
[127.978789] Dynamic subtest bcs0: SUCCESS (0.550s)
[127.992742] Starting dynamic subtest: vcs0
[129.877979] Dynamic subtest vcs0: SUCCESS (1.896s)
[129.891881] Starting dynamic subtest: vcs1
[131.923750] Dynamic subtest vcs1: SUCCESS (2.045s)
[131.938612] Starting dynamic subtest: vecs0
[133.908482] Dynamic subtest vecs0: SUCCESS (1.983s)
[133.923085] Starting dynamic subtest: ccs0
[134.457991] Dynamic subtest ccs0: SUCCESS (0.549s)
[134.461029] Subtest write-busy: SUCCESS (8.219s)
[134.664931] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[134.668535] [016/133] (884s left) kms_joiner (invalid-modeset-big-joiner)
[134.762368] Starting subtest: invalid-modeset-big-joiner
[134.766666] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[134.830729] [017/133] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[134.941736] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[134.946252] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[135.047237] [018/133] (884s left) kms_cursor_crc (cursor-offscreen-64x21)
[135.235300] Starting subtest: cursor-offscreen-64x21
[135.282069] Subtest cursor-offscreen-64x21: SKIP (0.041s)
[135.521792] [019/133] (883s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[135.622784] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[135.633537] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[135.706470] [020/133] (883s left) gem_mmap (basic-small-bo)
[135.762131] Subtest basic-small-bo: SKIP (0.000s)
[135.826275] [021/133] (883s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[135.918721] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[135.922184] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[136.025147] [022/133] (883s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[136.111920] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[136.115576] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[137.282743] [023/133] (882s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[137.392641] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[137.396622] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[137.490668] [024/133] (882s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[137.548679] Starting subtest: single-wait-all-for-submit-signaled
[137.550977] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[137.645149] [025/133] (881s left) kms_cursor_crc (cursor-sliding-64x21)
[137.841967] Starting subtest: cursor-sliding-64x21
[137.891293] Subtest cursor-sliding-64x21: SKIP (0.044s)
[138.131431] [026/133] (881s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[138.235482] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[138.238830] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[138.304049] [027/133] (881s left) template (b)
[138.373320] Starting subtest: B
[138.375309] Subtest B: SUCCESS (0.000s)
[138.468290] [028/133] (881s left) kms_content_protection (legacy)
[138.604587] Starting subtest: legacy
[138.608497] Subtest legacy: SKIP (0.000s)
[138.729966] [029/133] (880s left) syncobj_timeline (etime-single-wait-submitted)
[138.788799] Starting subtest: etime-single-wait-submitted
[138.896974] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[138.971755] [030/133] (880s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[139.078310] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[139.082664] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[139.174467] [031/133] (880s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[139.298593] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[139.303045] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[139.450275] [032/133] (880s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[139.547818] Starting subtest: blocking-absolute-wf_vblank-interruptible
[139.550043] Starting dynamic subtest: A-eDP1
[148.277281] Dynamic subtest A-eDP1: SUCCESS (8.694s)
[148.287063] Starting dynamic subtest: B-eDP1
[157.006770] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[157.022980] Starting dynamic subtest: C-eDP1
[165.737709] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[165.747339] Starting dynamic subtest: D-eDP1
[174.455207] Dynamic subtest D-eDP1: SUCCESS (8.714s)
[174.457593] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.865s)
[175.633930] [033/133] (844s left) syncobj_basic (bad-pad-handle-to-fd)
[175.703214] Starting subtest: bad-pad-handle-to-fd
[175.705143] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[175.800588] [034/133] (844s left) syncobj_timeline (invalid-query-zero-handles)
[175.850617] Starting subtest: invalid-query-zero-handles
[175.852513] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[175.933517] [035/133] (843s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[176.015909] Starting subtest: fb-8bpc-vs-panel-6bpc
[176.018073] Starting dynamic subtest: pipe-A-eDP-1
[177.377389] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.361s)
[177.379726] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.362s)
[178.196112] [036/133] (841s left) core_auth (getclient-simple)
[178.229842] Starting subtest: getclient-simple
[178.246123] Subtest getclient-simple: SUCCESS (0.015s)
[178.346138] [037/133] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[178.452606] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[185.293610] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.844s)
[185.392897] [038/133] (834s left) kms_flip (flip-vs-suspend)
[185.485350] Starting subtest: flip-vs-suspend
[185.487468] Starting dynamic subtest: A-eDP1
[330.658971] Dynamic subtest A-eDP1: SUCCESS (12.187s)
[330.661994] Subtest flip-vs-suspend: SUCCESS (12.190s)
[330.802898] [039/133] (689s left) i915_pm_rps (min-max-config-loaded)
[330.870190] Starting subtest: min-max-config-loaded
[330.875425] Subtest min-max-config-loaded: SKIP (0.002s)
[330.978853] [040/133] (689s left) core_sysfs (read-all-entries)
[331.032458] Starting subtest: read-all-entries
[331.035103] Subtest read-all-entries: SUCCESS (0.003s)
[331.116698] [041/133] (689s left) kms_lease (setcrtc-implicit-plane)
[331.215121] Starting subtest: setcrtc-implicit-plane
[331.217980] Starting dynamic subtest: pipe-A-eDP-1
[331.662201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[331.672687] Starting dynamic subtest: pipe-B-eDP-1
[332.845380] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s)
[332.856431] Starting dynamic subtest: pipe-C-eDP-1
[333.946031] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[333.956135] Starting dynamic subtest: pipe-D-eDP-1
[335.077600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[335.080195] Subtest setcrtc-implicit-plane: SUCCESS (3.860s)
[335.933007] [042/133] (684s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[336.035573] Starting subtest: stress-xrgb8888-4tiled
[341.909910] Subtest stress-xrgb8888-4tiled: SUCCESS (5.871s)
[341.966225] [043/133] (678s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[342.063991] Starting subtest: x-tiled-16bpp-rotate-180
[343.299806] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.235s)
[343.421797] [044/133] (676s left) gem_mmap_gtt (cpuset-big-copy-odd)
[343.485297] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[343.540571] [045/133] (676s left) gem_ctx_engines (none)
[343.598793] Starting subtest: none
[343.601431] Subtest none: SUCCESS (0.001s)
[343.789743] [046/133] (676s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[343.876076] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[343.878719] Starting dynamic subtest: pipe-A-eDP-1
[343.906213] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[343.916991] Starting dynamic subtest: pipe-B-eDP-1
[343.944211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[343.953119] Starting dynamic subtest: pipe-C-eDP-1
[343.979321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[343.990670] Starting dynamic subtest: pipe-D-eDP-1
[344.017001] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[344.022151] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[346.104439] [047/133] (674s left) gem_exec_whisper (basic-normal)
[346.174244] Starting subtest: basic-normal
[349.874720] Subtest basic-normal: SUCCESS (3.698s)
[350.062185] [048/133] (670s left) gen9_exec_parse (bb-start-out)
[350.130824] Subtest bb-start-out: SKIP (0.000s)
[350.203222] [049/133] (670s left) gem_mmap_offset (partial-remap)
[350.263288] Starting subtest: partial-remap
[350.266034] Starting dynamic subtest: smem0
[350.276414] Dynamic subtest smem0: SUCCESS (0.006s)
[350.279012] Subtest partial-remap: SUCCESS (0.007s)
[350.400775] [050/133] (670s left) gem_exec_gttfill (multigpu-basic)
[350.584798] Starting subtest: multigpu-basic
[363.221045] Subtest multigpu-basic: SUCCESS (12.636s)
[363.279581] [051/133] (657s left) gem_exec_basic (basic)
[363.381335] Starting subtest: basic
[363.384260] Starting dynamic subtest: rcs0-smem
[363.390473] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[363.400725] Starting dynamic subtest: bcs0-smem
[363.403471] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[363.412448] Starting dynamic subtest: vcs0-smem
[363.414985] Dynamic subtest vcs0-smem: SUCCESS (0.004s)
[363.423390] Starting dynamic subtest: vcs1-smem
[363.425894] Dynamic subtest vcs1-smem: SUCCESS (0.004s)
[363.434417] Starting dynamic subtest: vecs0-smem
[363.436955] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[363.445427] Starting dynamic subtest: ccs0-smem
[363.447937] Dynamic subtest ccs0-smem: SUCCESS (0.005s)
[363.450215] Subtest basic: SUCCESS (0.031s)
[364.931840] [052/133] (655s left) kms_atomic (test-only)
[365.044175] Starting subtest: test-only
[365.131036] Starting dynamic subtest: pipe-A-eDP-1
[367.632406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[367.635391] Subtest test-only: SUCCESS (2.591s)
[368.429891] [053/133] (652s left) kms_psr (fbc-pr-sprite-plane-onoff)
[368.521203] Starting subtest: fbc-pr-sprite-plane-onoff
[368.526232] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[368.592066] [054/133] (652s left) gem_render_copy_redux (normal)
[368.653942] Starting subtest: normal
[368.927221] Subtest normal: SUCCESS (0.272s)
[369.030527] [055/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[369.132628] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[369.137560] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[369.225810] [056/133] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[369.317194] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[369.322374] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[369.418822] [057/133] (651s left) gem_pread (bench)
[369.475165] Subtest bench: SKIP (0.000s)
[369.544608] [058/133] (651s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[369.668649] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[369.672431] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[369.814553] [059/133] (651s left) kms_draw_crc (fill-fb)
[369.898984] Starting subtest: fill-fb
[370.316339] Subtest fill-fb: SUCCESS (0.419s)
[370.410806] [060/133] (650s left) api_intel_bb (add-remove-objects)
[370.462139] Starting subtest: add-remove-objects
[370.467268] Subtest add-remove-objects: SUCCESS (0.007s)
[370.550933] [061/133] (650s left) kms_psr (psr-cursor-plane-move)
[370.646940] Starting subtest: psr-cursor-plane-move
[370.649305] Starting dynamic subtest: eDP-1
[372.432398] Dynamic subtest eDP-1: SUCCESS (1.786s)
[372.435452] Subtest psr-cursor-plane-move: SUCCESS (1.787s)
[373.292877] [062/133] (647s left) kms_vblank (wait-forked-hang)
[373.386340] Starting subtest: wait-forked-hang
[373.389558] Starting dynamic subtest: pipe-A-eDP-1
[399.638390] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.252s)
[399.655099] Starting dynamic subtest: pipe-D-eDP-1
[424.655130] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s)
[424.658412] Subtest wait-forked-hang: SUCCESS (51.270s)
[425.456603] [063/133] (595s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[425.564239] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[425.569061] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.657239] [064/133] (595s left) kms_getfb (getfb-handle-zero)
[425.755489] Starting subtest: getfb-handle-zero
[425.758235] Subtest getfb-handle-zero: SUCCESS (0.000s)
[425.871168] [065/133] (595s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[425.932329] Starting subtest: multi-wait-for-submit-submitted-signaled
[425.935339] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[426.025538] [066/133] (595s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[426.089193] Starting subtest: x-tiled-to-vebox-yf-tiled
[426.094626] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[426.272442] [067/133] (595s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[426.358446] Starting subtest: plane-all-modeset-transition-internal-panels
[426.361337] Starting dynamic subtest: pipe-A-eDP-1
[427.700218] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.342s)
[427.984293] Starting dynamic subtest: pipe-B-eDP-1
[429.025250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[429.295945] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.939s)
[430.137894] [068/133] (591s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[430.239342] Starting subtest: plane-downscale-factor-0-5-with-rotation
[430.241844] Starting dynamic subtest: pipe-A
[430.259905] Dynamic subtest pipe-A: SKIP (0.016s)
[430.269151] Starting dynamic subtest: pipe-B
[430.290604] Dynamic subtest pipe-B: SKIP (0.028s)
[430.300119] Starting dynamic subtest: pipe-C
[430.317003] Dynamic subtest pipe-C: SKIP (0.028s)
[430.326306] Starting dynamic subtest: pipe-D
[430.346975] Dynamic subtest pipe-D: SKIP (0.028s)
[430.352003] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.103s)
[430.429952] [069/133] (590s left) perf_pmu (invalid-open)
[430.476932] Starting subtest: invalid-open
[430.479692] Subtest invalid-open: SUCCESS (0.000s)
[430.567034] [070/133] (590s left) gem_softpin (safe-alignment)
[430.630717] Starting subtest: safe-alignment
[430.656296] Subtest safe-alignment: SUCCESS (0.026s)
[431.927840] [071/133] (589s left) sriov_basic (enable-vfs-bind-unbind-each)
[431.991226] Starting subtest: enable-vfs-bind-unbind-each
[431.994319] Starting dynamic subtest: numvfs-1
[432.085441] Dynamic subtest numvfs-1: FAIL (0.031s)
[432.094264] Starting dynamic subtest: numvfs-2
[432.181138] Dynamic subtest numvfs-2: FAIL (0.003s)
[432.191952] Starting dynamic subtest: numvfs-3
[432.278788] Dynamic subtest numvfs-3: FAIL (0.003s)
[432.288377] Starting dynamic subtest: numvfs-4
[432.377330] Dynamic subtest numvfs-4: FAIL (0.003s)
[432.387884] Starting dynamic subtest: numvfs-5
[432.463374] Dynamic subtest numvfs-5: FAIL (0.003s)
[432.471983] Starting dynamic subtest: numvfs-6
[432.560046] Dynamic subtest numvfs-6: FAIL (0.003s)
[432.569406] Starting dynamic subtest: numvfs-7
[432.651441] Dynamic subtest numvfs-7: FAIL (0.003s)
[432.660818] Starting dynamic subtest: numvfs-random
[432.737195] Dynamic subtest numvfs-random: FAIL (0.003s)
[432.739224] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s)
[432.779329] [072/133] (588s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[432.976128] Starting subtest: cursor-rapid-movement-64x64
[432.978234] Starting dynamic subtest: pipe-A-eDP-1
[433.509695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[433.548649] Starting dynamic subtest: pipe-D-eDP-1
[434.760381] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[434.763037] Subtest cursor-rapid-movement-64x64: SUCCESS (1.784s)
[435.599291] [073/133] (585s left) gem_exec_fence (syncobj-timeline-chain-engines)
[436.149408] Starting subtest: syncobj-timeline-chain-engines
[436.256591] Subtest syncobj-timeline-chain-engines: SUCCESS (0.107s)
[438.006807] [074/133] (583s left) kms_flip (2x-wf_vblank-ts-check)
[438.111412] Starting subtest: 2x-wf_vblank-ts-check
[438.121394] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s)
[438.199684] [075/133] (583s left) kms_color (ctm-0-50)
[438.285430] Starting subtest: ctm-0-50
[438.288216] Starting dynamic subtest: pipe-A-eDP-1
[441.837209] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.549s)
[441.847060] Starting dynamic subtest: pipe-B-eDP-1
[446.127168] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.289s)
[446.137393] Starting dynamic subtest: pipe-C-eDP-1
[450.167710] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.042s)
[450.177572] Starting dynamic subtest: pipe-D-eDP-1
[454.172957] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.002s)
[454.175749] Subtest ctm-0-50: SUCCESS (15.885s)
[454.997614] [076/133] (566s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[455.093989] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[455.096217] Starting dynamic subtest: pipe-A-default-mode
[456.250235] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[456.254993] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.155s)
[456.386776] [077/133] (565s left) syncobj_timeline (wait-for-submit-snapshot)
[456.450777] Starting subtest: wait-for-submit-snapshot
[456.531235] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[456.620295] [078/133] (565s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[456.716119] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[456.743097] Starting dynamic subtest: pipe-A-plane-0
[457.431457] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[457.440504] Starting dynamic subtest: pipe-A-plane-3
[457.920941] Dynamic subtest pipe-A-plane-3: SUCCESS (0.488s)
[459.011261] Starting dynamic subtest: pipe-B-plane-0
[459.691211] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[459.702710] Starting dynamic subtest: pipe-B-plane-3
[460.179685] Dynamic subtest pipe-B-plane-3: SUCCESS (0.488s)
[460.501875] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.786s)
[461.304157] [079/133] (560s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[461.364439] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[461.370185] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[461.550806] [080/133] (560s left) kms_hdr (bpc-switch-dpms)
[461.650856] Starting subtest: bpc-switch-dpms
[462.682757] Starting dynamic subtest: pipe-A-eDP-1
[467.212267] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.532s)
[467.215255] Subtest bpc-switch-dpms: SUCCESS (5.564s)
[467.337512] [081/133] (554s left) gem_ctx_freq (sysfs)
[467.403380] Starting subtest: sysfs
[467.405929] Starting dynamic subtest: gt0
[472.922542] Dynamic subtest gt0: SUCCESS (5.518s)
[472.935408] Starting dynamic subtest: gt1
[514.893761] Dynamic subtest gt1: SUCCESS (41.965s)
[514.896813] Subtest sysfs: SUCCESS (47.487s)
[515.001676] [082/133] (506s left) gem_exec_schedule (promotion)
[515.096778] Starting subtest: promotion
[515.099399] Starting dynamic subtest: rcs0
[515.262559] Dynamic subtest rcs0: SUCCESS (0.173s)
[515.275086] Starting dynamic subtest: vcs0
[515.390205] Dynamic subtest vcs0: SUCCESS (0.126s)
[515.403116] Starting dynamic subtest: vcs1
[515.519459] Dynamic subtest vcs1: SUCCESS (0.128s)
[515.532696] Starting dynamic subtest: vecs0
[515.645109] Dynamic subtest vecs0: SUCCESS (0.125s)
[515.657427] Starting dynamic subtest: ccs0
[515.792910] Dynamic subtest ccs0: SUCCESS (0.147s)
[515.796068] Subtest promotion: SUCCESS (0.704s)
[516.964870] [083/133] (504s left) kms_flip (2x-modeset-vs-vblank-race)
[517.064633] Starting subtest: 2x-modeset-vs-vblank-race
[517.073403] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[517.151448] [084/133] (504s left) i915_drm_fdinfo (basics)
[517.198282] Starting subtest: basics
[517.200893] Subtest basics: SUCCESS (0.000s)
[517.262995] [085/133] (504s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[517.363404] Starting subtest: y-tiled-16bpp-rotate-0
[517.368552] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[517.470145] [086/133] (504s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[517.567614] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[517.572304] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[517.671128] [087/133] (504s left) kms_psr (fbc-psr-cursor-render)
[517.754076] Starting subtest: fbc-psr-cursor-render
[517.756635] Starting dynamic subtest: eDP-1
[517.761255] Dynamic subtest eDP-1: SKIP (0.000s)
[517.766143] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[517.825160] [088/133] (504s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[517.925944] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[517.928261] Starting dynamic subtest: pipe-A-eDP-1
[517.951248] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[517.961771] Starting dynamic subtest: pipe-B-eDP-1
[517.984157] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.004293] Starting dynamic subtest: pipe-C-eDP-1
[518.023952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.035360] Starting dynamic subtest: pipe-D-eDP-1
[518.059194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.064206] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[520.224083] [089/133] (501s left) kms_psr (fbc-pr-cursor-blt)
[520.311587] Starting subtest: fbc-pr-cursor-blt
[520.316786] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[520.387792] [090/133] (501s left) gem_workarounds (reset-context)
[520.455983] Starting subtest: reset-context
[520.627188] Subtest reset-context: SUCCESS (0.169s)
[520.766933] [091/133] (501s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[520.861175] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[520.866284] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[520.936017] [092/133] (501s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[521.042864] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[521.047892] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[521.143033] [093/133] (501s left) i915_module_load (resize-bar)
[521.185463] Starting subtest: resize-bar
[521.192645] Subtest resize-bar: SKIP (0.007s)
[521.254872] [094/133] (501s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[521.320578] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[521.419928] [095/133] (501s left) gem_mmap (basic)
[521.484664] Subtest basic: SKIP (0.000s)
[521.545563] [096/133] (501s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[521.593421] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[521.698601] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[521.777007] [097/133] (500s left) kms_universal_plane (universal-plane-functional)
[521.864071] Starting subtest: universal-plane-functional
[521.866550] Starting dynamic subtest: pipe-A-eDP-1
[525.832129] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.967s)
[525.842725] Starting dynamic subtest: pipe-B-eDP-1
[530.291250] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.458s)
[530.302462] Starting dynamic subtest: pipe-C-eDP-1
[534.684466] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.393s)
[534.695268] Starting dynamic subtest: pipe-D-eDP-1
[539.047367] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.359s)
[539.050467] Subtest universal-plane-functional: SUCCESS (17.183s)
[539.915917] [098/133] (482s left) gem_render_copy (y-tiled-ccs-to-linear)
[539.977288] Starting subtest: y-tiled-ccs-to-linear
[539.982949] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[540.154681] [099/133] (482s left) gem_ccs (ctrl-surf-copy)
[540.216174] Starting subtest: ctrl-surf-copy
[540.222160] Subtest ctrl-surf-copy: SKIP (0.000s)
[540.331810] [100/133] (482s left) kms_rotation_crc (primary-rotation-90)
[540.416294] Starting subtest: primary-rotation-90
[540.421234] Subtest primary-rotation-90: SKIP (0.001s)
[540.490278] [101/133] (482s left) gem_lmem_swapping (heavy-verify-multi)
[540.539091] Subtest heavy-verify-multi: SKIP (0.000s)
[540.591035] [102/133] (482s left) kms_feature_discovery (display-1x)
[540.689912] Starting subtest: display-1x
[540.692266] Subtest display-1x: SUCCESS (0.000s)
[540.760881] [103/133] (482s left) gem_softpin (overlap)
[540.816419] Starting subtest: overlap
[541.771155] Subtest overlap: SUCCESS (0.955s)
[541.891953] [104/133] (481s left) kms_big_fb (linear-32bpp-rotate-180)
[542.016579] Starting subtest: linear-32bpp-rotate-180
[543.597268] Subtest linear-32bpp-rotate-180: SUCCESS (1.580s)
[543.744655] [105/133] (479s left) gem_mmap_gtt (medium-copy-odd)
[543.805306] Subtest medium-copy-odd: SKIP (0.000s)
[543.871846] [106/133] (479s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[543.923470] Starting subtest: multi-wait-for-submit-available-submitted
[543.926254] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[544.018313] [107/133] (479s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[544.079691] Starting subtest: map-fixed-invalidate-overlap
[544.083412] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[544.197802] [108/133] (478s left) gem_exec_schedule (preempt-queue)
[544.272387] Subtest preempt-queue: SKIP (0.000s)
[544.568617] [109/133] (478s left) gem_eio (wait-1us)
[544.795035] Starting subtest: wait-1us
[545.177377] Subtest wait-1us: SUCCESS (0.382s)
[545.303043] [110/133] (477s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[545.392070] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[545.397154] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[545.487244] [111/133] (477s left) syncobj_wait (wait-all-complex)
[545.540085] Starting subtest: wait-all-complex
[545.757239] Subtest wait-all-complex: SUCCESS (0.217s)
[545.834532] [112/133] (477s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[545.951935] Starting subtest: cursorB-vs-flipA-legacy
[545.957026] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[546.101400] [113/133] (477s left) gem_ctx_param (basic-default)
[546.151560] Starting subtest: basic-default
[546.154295] Subtest basic-default: SUCCESS (0.000s)
[546.228908] [114/133] (477s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[546.287276] Starting subtest: basic-batch-kernel-default-cmd
[546.292274] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[546.474159] [115/133] (476s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[546.572377] Starting subtest: 4-tiled-32bpp-rotate-90
[546.593248] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[546.706221] [116/133] (476s left) perf (gen12-invalid-class-instance)
[546.854369] Starting subtest: gen12-invalid-class-instance
[546.868401] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[546.908632] [117/133] (476s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[547.002219] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[547.006520] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[547.099276] [118/133] (476s left) kms_flip (2x-flip-vs-panning-interruptible)
[547.195546] Starting subtest: 2x-flip-vs-panning-interruptible
[547.206532] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[547.295812] [119/133] (476s left) i915_pm_rps (thresholds-idle-park)
[547.360270] Starting subtest: thresholds-idle-park
[547.366391] Subtest thresholds-idle-park: SKIP (0.000s)
[547.461669] [120/133] (476s left) kms_plane_multiple (2x-tiling-4)
[547.544065] Starting subtest: 2x-tiling-4
[547.547806] Subtest 2x-tiling-4: SKIP (0.000s)
[547.614166] [121/133] (476s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[547.705134] Starting subtest: random-ccs-data-y-tiled-ccs
[547.707432] Starting dynamic subtest: pipe-A-eDP-1
[547.731989] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[547.742666] Starting dynamic subtest: pipe-B-eDP-1
[547.766976] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[547.775829] Starting dynamic subtest: pipe-C-eDP-1
[547.800220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[547.809166] Starting dynamic subtest: pipe-D-eDP-1
[547.837130] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[547.841542] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[549.981144] [122/133] (473s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[550.086018] Starting subtest: psr-2p-pri-indfb-multidraw
[550.091206] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[550.186726] [123/133] (473s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[550.275280] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[550.277979] Starting dynamic subtest: pipe-A
[550.300922] Dynamic subtest pipe-A: SKIP (0.018s)
[550.314030] Starting dynamic subtest: pipe-B
[550.332388] Dynamic subtest pipe-B: SKIP (0.032s)
[550.341755] Starting dynamic subtest: pipe-C
[550.363058] Dynamic subtest pipe-C: SKIP (0.032s)
[550.372217] Starting dynamic subtest: pipe-D
[550.397739] Dynamic subtest pipe-D: SKIP (0.031s)
[550.403215] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.116s)
[550.501652] [124/133] (473s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[550.603615] Starting subtest: yf-tiled-64bpp-rotate-0
[550.607937] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[550.700883] [125/133] (473s left) gem_flink_race (flink_name)
[550.746080] Starting subtest: flink_name
[556.189960] Subtest flink_name: SUCCESS (5.391s)
[556.264946] [126/133] (467s left) gem_exec_balancer (invalid-bonds)
[556.340138] Starting subtest: invalid-bonds
[556.345679] Subtest invalid-bonds: SKIP (0.000s)
[556.650179] [127/133] (467s left) gem_workarounds (reset-fd)
[556.717824] Starting subtest: reset-fd
[556.908727] Subtest reset-fd: SUCCESS (0.191s)
[557.028148] [128/133] (466s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[559.068460] Starting subtest: dpms-mode-unset-lpsp
[563.109710] Subtest dpms-mode-unset-lpsp: SUCCESS (4.046s)
[563.515064] [129/133] (460s left) gem_ctx_persistence (legacy-engines-cleanup)
[563.573203] Starting subtest: legacy-engines-cleanup
[563.575806] Starting dynamic subtest: render
[563.646407] Dynamic subtest render: SUCCESS (0.073s)
[563.659276] Starting dynamic subtest: bsd1
[563.681109] Dynamic subtest bsd1: SUCCESS (0.033s)
[563.691188] Starting dynamic subtest: bsd2
[563.700030] Dynamic subtest bsd2: SUCCESS (0.017s)
[563.709318] Starting dynamic subtest: blt
[563.757185] Dynamic subtest blt: SUCCESS (0.056s)
[563.769153] Starting dynamic subtest: vebox
[563.791235] Dynamic subtest vebox: SUCCESS (0.032s)
[563.793815] Subtest legacy-engines-cleanup: SUCCESS (0.219s)
[563.873556] [130/133] (460s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[564.261905] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[565.104904] [131/133] (458s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[567.032197] Starting subtest: modeset-lpsp-stress-no-wait
[576.694317] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.664s)
[576.774013] [132/133] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[576.882247] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[576.888060] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[576.973479] [133/133] (447s left) gem_softpin (softpin)
[577.034390] Starting subtest: softpin
[609.278061] Subtest softpin: SUCCESS (32.238s)
[609.401132] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_shared
results: parsing output: 13/ for test: gem_madvise
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: template
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_dither
results: parsing output: 35/ for test: core_auth
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: core_sysfs
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: kms_pipe_stress
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: gem_ctx_engines
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_exec_gttfill
results: parsing output: 50/ for test: gem_exec_basic
results: parsing output: 51/ for test: kms_atomic
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_render_copy_redux
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_pread
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_draw_crc
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_getfb
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: sriov_basic
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_color
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_hdr
results: parsing output: 80/ for test: gem_ctx_freq
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_workarounds
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_module_load
results: parsing output: 93/ for test: kms_pipe_b_c_ivb
results: parsing output: 94/ for test: gem_mmap
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_universal_plane
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: gem_ccs
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_feature_discovery
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_param
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_plane_multiple
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_flink_race
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_workarounds
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_softpin
Done.