[54.613734] Initializing watchdogs
[54.613783]   /dev/watchdog0
[54.627087] [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]
[54.631820] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.634021] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.637187] [001/131] (960s left) kms_psr (fbc-psr2-primary-page-flip)
[54.747077] Starting subtest: fbc-psr2-primary-page-flip
[54.749331] Starting dynamic subtest: eDP-1
[54.753552] Dynamic subtest eDP-1: SKIP (0.000s)
[54.757760] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[54.836586] [002/131] (960s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[54.939155] Starting subtest: bo-too-small-due-to-tiling
[54.943323] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[55.057939] [003/131] (960s left) gem_exec_fence (concurrent)
[55.241304] Starting subtest: concurrent
[55.245458] Subtest concurrent: SKIP (0.000s)
[57.031444] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[57.034762] [004/131] (958s left) gem_exec_reloc (basic-gtt-cpu)
[57.100427] Subtest basic-gtt-cpu: SKIP (0.000s)
[57.188962] [005/131] (958s left) gen3_mixed_blits
[57.317938] [006/131] (958s left) syncobj_timeline (device-submit-unordered)
[57.371678] Starting subtest: device-submit-unordered
[57.374018] Subtest device-submit-unordered: SUCCESS (0.000s)
[57.509578] [007/131] (957s left) kms_big_fb (x-tiled-addfb)
[57.612391] Starting subtest: x-tiled-addfb
[57.614352] Subtest x-tiled-addfb: SUCCESS (0.000s)
[57.738577] [008/131] (957s left) kms_cursor_crc (cursor-onscreen-32x10)
[57.903672] Starting subtest: cursor-onscreen-32x10
[57.950233] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[58.231026] [009/131] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[58.319223] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[58.322795] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[58.413336] [010/131] (957s left) api_intel_bb (object-reloc-keep-cache)
[58.467174] Starting subtest: object-reloc-keep-cache
[58.471258] Subtest object-reloc-keep-cache: SKIP (0.003s)
[58.556479] [011/131] (956s left) gem_pwrite (basic-exhaustion)
[58.606817] Subtest basic-exhaustion: SKIP (0.000s)
[58.661971] [012/131] (956s left) gem_workarounds (basic-read)
[58.728049] Starting subtest: basic-read
[58.737214] Subtest basic-read: SUCCESS (0.010s)
[58.901181] [013/131] (956s left) gem_mmap_gtt (medium-copy-odd)
[58.948531] Subtest medium-copy-odd: SKIP (0.000s)
[59.010173] [014/131] (956s left) gem_workarounds (suspend-resume-fd)
[59.076096] Starting subtest: suspend-resume-fd
[75.822529] Subtest suspend-resume-fd: SUCCESS (1.278s)
[75.964863] [015/131] (939s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[80.861790] Starting subtest: fbc-pr-cursor-plane-update-sf
[80.866419] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[81.709547] [016/131] (933s left) kms_invalid_mode (clock-too-high)
[81.809079] Starting subtest: clock-too-high
[81.811289] Starting dynamic subtest: pipe-A-eDP-1
[81.815548] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[81.824971] Starting dynamic subtest: pipe-B-eDP-1
[81.829054] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[81.836633] Starting dynamic subtest: pipe-C-eDP-1
[81.841057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[81.849167] Starting dynamic subtest: pipe-D-eDP-1
[81.853505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[81.857810] Subtest clock-too-high: SKIP (0.002s)
[81.898409] [017/131] (933s left) kms_plane_cursor (primary)
[81.998757] Starting subtest: primary
[82.002853] Starting dynamic subtest: pipe-A-eDP-1-size-64
[84.646188] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.686s)
[84.671566] Starting dynamic subtest: pipe-A-eDP-1-size-128
[87.375910] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.740s)
[87.400033] Starting dynamic subtest: pipe-A-eDP-1-size-256
[90.100904] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.727s)
[90.412840] Starting dynamic subtest: pipe-B-eDP-1-size-64
[93.843210] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.457s)
[93.867971] Starting dynamic subtest: pipe-B-eDP-1-size-128
[96.524577] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.671s)
[96.548716] Starting dynamic subtest: pipe-B-eDP-1-size-256
[99.274012] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.739s)
[99.587058] Starting dynamic subtest: pipe-C-eDP-1-size-64
[102.541433] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.970s)
[102.569439] Starting dynamic subtest: pipe-C-eDP-1-size-128
[104.782983] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.224s)
[104.814619] Starting dynamic subtest: pipe-C-eDP-1-size-256
[107.102701] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.302s)
[107.422047] Starting dynamic subtest: pipe-D-eDP-1-size-64
[110.406815] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.994s)
[110.431234] Starting dynamic subtest: pipe-D-eDP-1-size-128
[112.685552] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.258s)
[112.710989] Starting dynamic subtest: pipe-D-eDP-1-size-256
[114.973921] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.269s)
[115.281695] Subtest primary: SUCCESS (33.412s)
[116.110255] [018/131] (899s left) kms_cursor_crc (cursor-sliding-256x256)
[116.353678] Starting subtest: cursor-sliding-256x256
[116.356049] Starting dynamic subtest: pipe-A-eDP-1
[119.591579] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[119.618054] Starting dynamic subtest: pipe-D-eDP-1
[123.455724] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.846s)
[123.457935] Subtest cursor-sliding-256x256: SUCCESS (7.103s)
[124.287566] [019/131] (891s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[124.389148] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[131.159488] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.773s)
[131.331854] [020/131] (884s left) i915_drm_fdinfo (idle)
[131.381679] Starting subtest: idle
[131.384107] Starting dynamic subtest: rcs0
[131.967057] Dynamic subtest rcs0: SUCCESS (0.588s)
[131.978276] Starting dynamic subtest: bcs0
[132.474660] Dynamic subtest bcs0: SUCCESS (0.504s)
[132.484078] Starting dynamic subtest: vcs0
[132.979973] Dynamic subtest vcs0: SUCCESS (0.503s)
[132.990344] Starting dynamic subtest: vcs1
[133.485822] Dynamic subtest vcs1: SUCCESS (0.503s)
[133.494805] Starting dynamic subtest: vecs0
[133.992070] Dynamic subtest vecs0: SUCCESS (0.503s)
[134.003612] Starting dynamic subtest: ccs0
[134.497962] Dynamic subtest ccs0: SUCCESS (0.504s)
[134.501073] Subtest idle: SUCCESS (3.120s)
[134.608401] [021/131] (881s left) kms_flip (2x-plain-flip)
[134.707982] Starting subtest: 2x-plain-flip
[134.716615] Subtest 2x-plain-flip: SKIP (0.010s)
[134.822829] [022/131] (881s left) kms_big_fb (linear-32bpp-rotate-0)
[134.909201] Starting subtest: linear-32bpp-rotate-0
[136.353905] Subtest linear-32bpp-rotate-0: SUCCESS (1.444s)
[136.532283] [023/131] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[136.619905] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[136.623373] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[136.715114] [024/131] (879s left) gem_ctx_engines (invalid-engines)
[136.778210] Starting subtest: invalid-engines
[136.787219] Subtest invalid-engines: SUCCESS (0.009s)
[137.066598] [025/131] (878s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[137.124010] Starting subtest: single-wait-all-for-submit-unsubmitted
[137.229373] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[137.317045] [026/131] (878s left) kms_cursor_legacy (torture-bo)
[137.430504] Starting subtest: torture-bo
[137.432719] Starting dynamic subtest: pipe-A
[143.220305] Dynamic subtest pipe-A: SUCCESS (5.789s)
[143.231453] Starting dynamic subtest: pipe-B
[149.292813] Dynamic subtest pipe-B: SUCCESS (6.071s)
[149.305103] Starting dynamic subtest: pipe-C
[155.715272] Dynamic subtest pipe-C: SUCCESS (6.423s)
[155.726793] Starting dynamic subtest: pipe-D
[161.681732] Dynamic subtest pipe-D: SUCCESS (5.966s)
[161.693659] Starting dynamic subtest: all-pipes
[168.103047] Dynamic subtest all-pipes: SUCCESS (6.419s)
[168.105904] Subtest torture-bo: SUCCESS (30.681s)
[168.295376] [027/131] (847s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[168.361412] Starting subtest: etime-multi-wait-for-submit-submitted
[168.470416] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[168.559047] [028/131] (847s left) kms_vrr (negative-basic)
[168.657426] Starting subtest: negative-basic
[168.663983] Starting dynamic subtest: pipe-A-eDP-1
[174.065518] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.402s)
[174.366282] Subtest negative-basic: SUCCESS (5.710s)
[175.230624] [029/131] (840s left) kms_psr (psr-basic)
[175.318263] Starting subtest: psr-basic
[175.320552] Starting dynamic subtest: eDP-1
[176.908676] Dynamic subtest eDP-1: SUCCESS (1.592s)
[176.911287] Subtest psr-basic: SUCCESS (1.593s)
[177.709879] [030/131] (838s left) gem_spin_batch (resubmit-new-all)
[177.771076] Starting subtest: resubmit-new-all
[177.773586] Starting dynamic subtest: rcs0
[177.784479] Dynamic subtest rcs0: SUCCESS (0.013s)
[177.792987] Starting dynamic subtest: bcs0
[177.795176] Dynamic subtest bcs0: SUCCESS (0.010s)
[177.802974] Starting dynamic subtest: vcs0
[177.805244] Dynamic subtest vcs0: SUCCESS (0.009s)
[177.813204] Starting dynamic subtest: vcs1
[177.815445] Dynamic subtest vcs1: SUCCESS (0.009s)
[177.823214] Starting dynamic subtest: vecs0
[177.825384] Dynamic subtest vecs0: SUCCESS (0.009s)
[177.833260] Starting dynamic subtest: ccs0
[177.835395] Dynamic subtest ccs0: SUCCESS (0.009s)
[177.837596] Subtest resubmit-new-all: SUCCESS (0.062s)
[179.458713] [031/131] (836s left) gem_exec_async (forked-writes)
[179.522210] Starting subtest: forked-writes
[179.524463] Starting dynamic subtest: rcs0
[179.551218] Dynamic subtest rcs0: SUCCESS (0.028s)
[179.560127] Starting dynamic subtest: bcs0
[179.573813] Dynamic subtest bcs0: SUCCESS (0.022s)
[179.582558] Starting dynamic subtest: vcs0
[179.594321] Dynamic subtest vcs0: SUCCESS (0.020s)
[179.603502] Starting dynamic subtest: vcs1
[179.615046] Dynamic subtest vcs1: SUCCESS (0.020s)
[179.624373] Starting dynamic subtest: vecs0
[179.636516] Dynamic subtest vecs0: SUCCESS (0.021s)
[179.645316] Starting dynamic subtest: ccs0
[179.656382] Dynamic subtest ccs0: SUCCESS (0.019s)
[179.658653] Subtest forked-writes: SUCCESS (0.135s)
[179.882381] [032/131] (836s left) api_intel_bb (add-remove-objects)
[179.945840] Starting subtest: add-remove-objects
[179.951322] Subtest add-remove-objects: SUCCESS (0.006s)
[180.117391] [033/131] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[180.223674] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[180.228081] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[180.332125] [034/131] (836s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[180.438579] Starting subtest: psr-rgb565-draw-render
[187.387561] Subtest psr-rgb565-draw-render: SUCCESS (6.949s)
[187.555769] [035/131] (828s left) kms_flip (2x-plain-flip-ts-check)
[187.647271] Starting subtest: 2x-plain-flip-ts-check
[187.655090] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[187.756298] [036/131] (828s left) dumb_buffer (invalid-bpp)
[187.817479] Starting subtest: invalid-bpp
[187.819656] Subtest invalid-bpp: SUCCESS (0.000s)
[187.958469] [037/131] (828s left) sysfs_timeslice_duration (duration)
[188.012658] Starting subtest: duration
[188.015065] Starting dynamic subtest: vecs0
[201.329224] Dynamic subtest vecs0: SUCCESS (13.311s)
[201.340753] Starting dynamic subtest: ccs0
[214.495322] Dynamic subtest ccs0: SUCCESS (13.165s)
[214.507167] Starting dynamic subtest: vcs0
[228.338056] Dynamic subtest vcs0: SUCCESS (13.837s)
[228.350719] Starting dynamic subtest: bcs0
[241.468982] Dynamic subtest bcs0: SUCCESS (13.134s)
[241.481712] Starting dynamic subtest: rcs0
[254.620890] Dynamic subtest rcs0: SUCCESS (13.151s)
[254.634933] Starting dynamic subtest: vcs1
[268.336419] Dynamic subtest vcs1: SUCCESS (13.714s)
[268.339353] Subtest duration: SUCCESS (80.330s)
[268.425040] [038/131] (748s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[268.533615] Starting subtest: y-tiled-64bpp-rotate-180
[268.537708] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[268.654244] [039/131] (747s left) prime_vgem (wait)
[268.717550] Starting subtest: wait
[268.719924] Starting dynamic subtest: rcs0
[268.781045] Dynamic subtest rcs0: SUCCESS (0.063s)
[268.789961] Starting dynamic subtest: bcs0
[268.864061] Dynamic subtest bcs0: SUCCESS (0.082s)
[268.872202] Starting dynamic subtest: vcs0
[268.906159] Dynamic subtest vcs0: SUCCESS (0.041s)
[268.914434] Starting dynamic subtest: vcs1
[268.955760] Dynamic subtest vcs1: SUCCESS (0.049s)
[268.963953] Starting dynamic subtest: vecs0
[269.000431] Dynamic subtest vecs0: SUCCESS (0.044s)
[269.008831] Starting dynamic subtest: ccs0
[269.044422] Dynamic subtest ccs0: SUCCESS (0.043s)
[269.046715] Subtest wait: SUCCESS (0.328s)
[269.191406] [040/131] (747s left) gem_pipe_control_store_loop (fresh-buffer)
[269.246644] Starting subtest: fresh-buffer
[271.400359] Subtest fresh-buffer: SUCCESS (2.152s)
[271.545289] [041/131] (745s left) gem_ctx_persistence (heartbeat-many)
[271.618029] Starting subtest: heartbeat-many
[271.622582] Subtest heartbeat-many: SKIP (0.000s)
[271.737482] [042/131] (745s left) dumb_buffer (map-invalid-size)
[271.787606] Starting subtest: map-invalid-size
[271.789838] Subtest map-invalid-size: SUCCESS (0.000s)
[271.923451] [043/131] (744s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[272.036262] Starting subtest: pipe-fbc-rte
[272.042565] Starting dynamic subtest: pipe-B-eDP-1
[277.483682] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.458s)
[277.491239] Subtest pipe-fbc-rte: SUCCESS (5.460s)
[279.765586] [044/131] (737s left) gem_fence_thrash (bo-write-verify-x)
[279.801193] Starting subtest: bo-write-verify-x
[279.815682] Subtest bo-write-verify-x: SKIP (0.014s)
[279.885442] [045/131] (736s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[279.949850] Starting subtest: basic-batch-kernel-default-cmd
[279.953966] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[280.148065] [046/131] (736s left) i915_hangman (gt-engine-error)
[280.195745] Starting subtest: gt-engine-error
[280.198549] Starting dynamic subtest: rcs0
[281.330374] Dynamic subtest rcs0: SUCCESS (1.133s)
[281.342242] Starting dynamic subtest: bcs0
[283.376511] Dynamic subtest bcs0: SUCCESS (2.044s)
[283.388727] Starting dynamic subtest: vcs0
[285.359201] Dynamic subtest vcs0: SUCCESS (1.980s)
[285.370818] Starting dynamic subtest: vcs1
[287.344648] Dynamic subtest vcs1: SUCCESS (1.983s)
[287.355021] Starting dynamic subtest: vecs0
[289.392054] Dynamic subtest vecs0: SUCCESS (2.045s)
[289.403614] Starting dynamic subtest: ccs0
[291.376336] Dynamic subtest ccs0: SUCCESS (1.982s)
[291.379273] Subtest gt-engine-error: SUCCESS (11.184s)
[291.480937] [047/131] (725s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[291.579275] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[292.625969] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.046s)
[292.768841] [048/131] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[292.873247] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[292.876661] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[292.991923] [049/131] (724s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[293.080140] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[293.082152] Starting dynamic subtest: pipe-A-default-mode
[295.806501] Dynamic subtest pipe-A-default-mode: SUCCESS (2.728s)
[295.808847] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.730s)
[296.665807] [050/131] (720s left) kms_chamelium_frames (hdmi-crc-multiple)
[297.045479] Subtest hdmi-crc-multiple: SKIP (0.000s)
[297.848761] [051/131] (719s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[297.948347] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[297.959638] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[298.104392] [052/131] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[298.204385] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[305.143061] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.938s)
[305.311153] [053/131] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[305.419433] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[305.423794] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[305.565188] [054/131] (711s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[305.627527] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[305.629771] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[305.755399] [055/131] (711s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[305.856745] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[305.859024] Starting dynamic subtest: pipe-A-eDP-1
[305.881397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[305.890165] Starting dynamic subtest: pipe-B-eDP-1
[305.910167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[305.917909] Starting dynamic subtest: pipe-C-eDP-1
[305.938662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[305.946441] Starting dynamic subtest: pipe-D-eDP-1
[305.967952] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[305.972263] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[308.076412] [056/131] (709s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[308.163743] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[312.307936] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.146s)
[313.495567] [057/131] (703s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[313.586062] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[313.588379] Starting dynamic subtest: pipe-A
[313.602925] Dynamic subtest pipe-A: SKIP (0.015s)
[313.611790] Starting dynamic subtest: pipe-B
[313.631688] Dynamic subtest pipe-B: SKIP (0.028s)
[313.639978] Starting dynamic subtest: pipe-C
[313.665167] Dynamic subtest pipe-C: SKIP (0.030s)
[313.675387] Starting dynamic subtest: pipe-D
[313.696436] Dynamic subtest pipe-D: SKIP (0.031s)
[313.700052] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.108s)
[313.823165] [058/131] (703s left) kms_psr (fbc-psr-cursor-plane-move)
[313.913899] Starting subtest: fbc-psr-cursor-plane-move
[313.916198] Starting dynamic subtest: eDP-1
[313.920454] Dynamic subtest eDP-1: SKIP (0.000s)
[313.924759] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[314.011603] [059/131] (703s left) gem_exec_fence (syncobj-invalid-wait)
[314.449461] Starting subtest: syncobj-invalid-wait
[314.451826] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[316.493329] [060/131] (700s left) syncobj_basic (bad-create-flags)
[316.551602] Starting subtest: bad-create-flags
[316.553612] Subtest bad-create-flags: SUCCESS (0.000s)
[316.665100] [061/131] (700s left) kms_feature_discovery (display-1x)
[316.762914] Starting subtest: display-1x
[316.765272] Subtest display-1x: SUCCESS (0.000s)
[316.862344] [062/131] (700s left) kms_pm_rpm (modeset-lpsp-stress)
[318.489385] Starting subtest: modeset-lpsp-stress
[334.899737] Subtest modeset-lpsp-stress: SUCCESS (16.408s)
[334.999877] [063/131] (682s left) prime_mmap_kms (buffer-sharing)
[335.098225] Starting subtest: buffer-sharing
[335.524213] Subtest buffer-sharing: SUCCESS (0.425s)
[336.412258] [064/131] (681s left) kms_chamelium_color (degamma)
[336.507774] Subtest degamma: SKIP (0.000s)
[336.551557] [065/131] (681s left) gem_ctx_param (invalid-get-ringsize)
[336.608698] Starting subtest: invalid-get-ringsize
[336.611083] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[336.731019] [066/131] (680s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[341.793622] Starting subtest: psr2-overlay-plane-update-continuous-sf
[341.795930] Starting dynamic subtest: pipe-A-eDP-1
[343.542102] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.748s)
[343.554629] Starting dynamic subtest: pipe-B-eDP-1
[345.264682] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.719s)
[345.266990] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.472s)
[346.101298] [067/131] (671s left) gem_exec_reloc (basic-write-read-active)
[346.167359] Subtest basic-write-read-active: SKIP (0.000s)
[346.260371] [068/131] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[346.355630] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[353.609058] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.255s)
[353.786292] [069/131] (664s left) kms_force_connector_basic (force-load-detect)
[353.882871] Starting subtest: force-load-detect
[353.887628] Subtest force-load-detect: SKIP (0.000s)
[354.018945] [070/131] (663s left) kms_pm_rpm (modeset-non-lpsp-stress)
[355.546775] Starting subtest: modeset-non-lpsp-stress
[356.690064] Subtest modeset-non-lpsp-stress: SKIP (1.143s)
[357.080694] [071/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[357.175772] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[357.180053] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[357.297201] [072/131] (660s left) gem_exec_schedule (fairslice-all)
[357.371687] Starting subtest: fairslice-all
[359.427888] Subtest fairslice-all: SUCCESS (2.055s)
[361.468976] [073/131] (656s left) kms_color (ctm-0-25)
[361.572217] Starting subtest: ctm-0-25
[361.574437] Starting dynamic subtest: pipe-A-eDP-1
[364.928903] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.356s)
[364.940183] Starting dynamic subtest: pipe-B-eDP-1
[368.944803] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.015s)
[368.955144] Starting dynamic subtest: pipe-C-eDP-1
[372.872219] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.928s)
[372.880642] Starting dynamic subtest: pipe-D-eDP-1
[376.883354] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.008s)
[376.885619] Subtest ctm-0-25: SUCCESS (15.309s)
[377.741327] [074/131] (640s left) gem_flink_race (flink_close)
[377.777588] Starting subtest: flink_close
[382.900376] Subtest flink_close: SUCCESS (5.120s)
[382.986611] [075/131] (635s left) gem_exec_params (rel-constants-invalid)
[383.051278] Starting subtest: rel-constants-invalid
[383.053441] Subtest rel-constants-invalid: SUCCESS (0.000s)
[383.167178] [076/131] (634s left) gen9_exec_parse (secure-batches)
[383.227068] Subtest secure-batches: SKIP (0.000s)
[383.314796] [077/131] (634s left) drm_read (short-buffer-nonblock)
[383.470978] Starting subtest: short-buffer-nonblock
[383.473422] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[383.642101] [078/131] (634s left) kms_psr (psr2-cursor-mmap-gtt)
[383.742584] Starting subtest: psr2-cursor-mmap-gtt
[383.744925] Starting dynamic subtest: eDP-1
[385.414675] Dynamic subtest eDP-1: SUCCESS (1.673s)
[385.417049] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.674s)
[386.308093] [079/131] (631s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[386.400334] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[386.402648] Starting dynamic subtest: pipe-A
[386.509782] Dynamic subtest pipe-A: SKIP (0.105s)
[386.518975] Starting dynamic subtest: pipe-B
[387.665300] Dynamic subtest pipe-B: SKIP (1.155s)
[387.674241] Starting dynamic subtest: pipe-C
[388.802598] Dynamic subtest pipe-C: SUCCESS (1.143s)
[388.810880] Starting dynamic subtest: pipe-D
[389.953959] Dynamic subtest pipe-D: SUCCESS (1.150s)
[389.956352] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.557s)
[391.154768] [080/131] (627s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[391.251246] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[391.253569] Starting dynamic subtest: pipe-A-eDP-1
[391.274154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[391.285886] Starting dynamic subtest: pipe-B-eDP-1
[391.304725] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[391.313308] Starting dynamic subtest: pipe-C-eDP-1
[391.332446] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[391.341583] Starting dynamic subtest: pipe-D-eDP-1
[391.362062] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[391.364432] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[393.443347] [081/131] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[393.544749] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[393.548735] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[393.675329] [082/131] (624s left) syncobj_basic (bad-destroy-pad)
[393.738917] Starting subtest: bad-destroy-pad
[393.741541] Subtest bad-destroy-pad: SUCCESS (0.000s)
[393.856913] [083/131] (624s left) gem_userptr_blits (dmabuf-unsync)
[393.911443] Subtest dmabuf-unsync: SKIP (0.000s)
[394.061276] [084/131] (624s left) kms_rotation_crc (sprite-rotation-180)
[394.154434] Starting subtest: sprite-rotation-180
[399.115431] Subtest sprite-rotation-180: SUCCESS (4.963s)
[400.400954] [085/131] (618s left) gem_vm_create (invalid-create)
[400.464703] Starting subtest: invalid-create
[400.467129] Subtest invalid-create: SUCCESS (0.002s)
[400.601590] [086/131] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[400.691544] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[400.696120] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[400.812891] [087/131] (617s left) syncobj_wait (multi-wait-for-submit-signaled)
[400.870045] Starting subtest: multi-wait-for-submit-signaled
[400.872290] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[400.993647] [088/131] (617s left) vgem_basic (mmap)
[401.040677] Starting subtest: mmap
[401.055733] Subtest mmap: SUCCESS (0.017s)
[401.118289] [089/131] (617s left) gem_eio (in-flight-internal-10ms)
[401.347240] Starting subtest: in-flight-internal-10ms
[402.456249] Subtest in-flight-internal-10ms: SUCCESS (1.107s)
[402.621479] [090/131] (616s left) gem_partial_pwrite_pread (reads-snoop)
[402.685276] Subtest reads-snoop: SKIP (0.000s)
[402.756224] [091/131] (615s left) gem_exec_schedule (timeslicing)
[402.829513] Starting subtest: timeslicing
[402.831520] Starting dynamic subtest: rcs0
[402.839163] Dynamic subtest rcs0: SUCCESS (0.021s)
[402.851336] Starting dynamic subtest: bcs0
[402.859582] Dynamic subtest bcs0: SUCCESS (0.020s)
[402.869117] Starting dynamic subtest: vcs0
[402.880403] Dynamic subtest vcs0: SUCCESS (0.020s)
[402.890037] Starting dynamic subtest: vcs1
[402.900406] Dynamic subtest vcs1: SUCCESS (0.019s)
[402.909467] Starting dynamic subtest: vecs0
[402.920246] Dynamic subtest vecs0: SUCCESS (0.019s)
[402.929076] Starting dynamic subtest: ccs0
[402.940518] Dynamic subtest ccs0: SUCCESS (0.020s)
[402.942813] Subtest timeslicing: SUCCESS (0.124s)
[404.426572] [092/131] (614s left) kms_addfb_basic (master-rmfb)
[404.473877] Starting subtest: master-rmfb
[404.476126] Subtest master-rmfb: SUCCESS (0.001s)
[404.623505] [093/131] (614s left) gem_set_tiling_vs_gtt
[404.739529] [094/131] (614s left) gem_exec_reloc (basic-cpu-gtt)
[404.795592] Subtest basic-cpu-gtt: SKIP (0.000s)
[404.882770] [095/131] (614s left) kms_cursor_crc (cursor-onscreen-max-size)
[405.181205] Starting subtest: cursor-onscreen-max-size
[405.187467] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[405.327919] [096/131] (613s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[405.428129] Starting subtest: psr-rgb101010-draw-render
[412.611601] Subtest psr-rgb101010-draw-render: SUCCESS (7.185s)
[412.724100] [097/131] (606s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[412.830028] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[416.379406] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.554s)
[417.520277] [098/131] (601s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[417.643262] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[426.599608] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.958s)
[427.425207] [099/131] (591s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[427.518269] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[427.520491] Starting dynamic subtest: pipe-A-eDP-1
[427.529637] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.538764] Starting dynamic subtest: pipe-B-eDP-1
[427.547970] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.557592] Starting dynamic subtest: pipe-C-eDP-1
[427.566103] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.574898] Starting dynamic subtest: pipe-D-eDP-1
[427.583065] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.587061] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[429.698361] [100/131] (589s left) kms_pwrite_crc
[431.335605] [101/131] (587s left) syncobj_timeline (wait-all-for-submit-snapshot)
[431.380366] Starting subtest: wait-all-for-submit-snapshot
[431.460537] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[431.561836] [102/131] (587s left) kms_psr (fbc-pr-sprite-blt)
[431.649097] Starting subtest: fbc-pr-sprite-blt
[431.653388] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[431.732708] [103/131] (587s left) kms_content_protection (dp-mst-lic-type-1)
[431.856465] Starting subtest: dp-mst-lic-type-1
[431.861366] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[432.005500] [104/131] (587s left) kms_writeback (writeback-fb-id)
[432.097832] Subtest writeback-fb-id: SKIP (0.000s)
[432.147218] [105/131] (587s left) kms_async_flips (test-cursor-atomic)
[432.233390] Starting subtest: test-cursor-atomic
[432.237770] Subtest test-cursor-atomic: SKIP (0.000s)
[433.460920] [106/131] (585s left) gem_media_fill (media-fill)
[433.529579] Subtest media-fill: SKIP (0.000s)
[433.659336] [107/131] (585s left) kms_properties (plane-properties-legacy)
[433.756203] Starting subtest: plane-properties-legacy
[433.758115] Starting dynamic subtest: pipe-A-eDP-1
[434.311032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[434.322596] Starting dynamic subtest: pipe-B-eDP-1
[435.615182] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[435.625650] Starting dynamic subtest: pipe-C-eDP-1
[436.855149] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s)
[436.865305] Starting dynamic subtest: pipe-D-eDP-1
[438.086582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[438.088946] Subtest plane-properties-legacy: SUCCESS (4.334s)
[438.890886] [108/131] (580s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[438.957899] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[438.962473] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[439.168568] [109/131] (580s left) gem_lmem_swapping (heavy-verify-random)
[439.210208] Subtest heavy-verify-random: SKIP (0.000s)
[439.251182] [110/131] (580s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[439.313666] Starting subtest: invalid-single-wait-all-unsubmitted
[439.315917] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[439.450341] [111/131] (580s left) kms_lease (lease-invalid-connector)
[439.547046] Starting subtest: lease-invalid-connector
[439.549234] Starting dynamic subtest: pipe-A-eDP-1
[439.551785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[439.560655] Starting dynamic subtest: pipe-B-eDP-1
[439.562885] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[439.571625] Starting dynamic subtest: pipe-C-eDP-1
[439.573585] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[439.582159] Starting dynamic subtest: pipe-D-eDP-1
[439.584266] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[439.586339] Subtest lease-invalid-connector: SUCCESS (0.004s)
[439.634406] [112/131] (579s left) gem_eio (kms)
[439.904826] Starting subtest: kms
[460.479775] Subtest kms: SUCCESS (20.576s)
[461.664679] [113/131] (557s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[461.752179] Starting subtest: extended-pageflip-modeset-hang-oldfb
[461.754453] Starting dynamic subtest: pipe-A
[469.650176] Dynamic subtest pipe-A: SUCCESS (7.898s)
[469.660398] Starting dynamic subtest: pipe-D
[478.280879] Dynamic subtest pipe-D: SUCCESS (8.629s)
[478.283248] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.532s)
[479.131437] [114/131] (540s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[479.233385] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[480.225663] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.992s)
[480.392013] [115/131] (539s left) perf (buffer-fill)
[480.509569] Starting subtest: buffer-fill
[480.511172] Starting dynamic subtest: 0-rcs0
[482.756634] Dynamic subtest 0-rcs0: SUCCESS (2.246s)
[482.767126] Starting dynamic subtest: 1-vecs0
[487.159069] Dynamic subtest 1-vecs0: SUCCESS (4.401s)
[487.161798] Subtest buffer-fill: SUCCESS (6.650s)
[487.199240] [116/131] (532s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[487.303035] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[487.307503] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[487.443429] [117/131] (532s left) kms_vblank (query-forked-hang)
[487.537362] Starting subtest: query-forked-hang
[487.539227] Starting dynamic subtest: pipe-A-eDP-1
[514.126904] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.594s)
[514.141969] Starting dynamic subtest: pipe-D-eDP-1
[529.168669] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[529.171110] Subtest query-forked-hang: SUCCESS (41.641s)
[529.986535] [118/131] (489s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[530.081046] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[530.083340] Starting dynamic subtest: pipe-A-eDP-1
[530.104190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[530.115333] Starting dynamic subtest: pipe-B-eDP-1
[530.134813] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[530.144256] Starting dynamic subtest: pipe-C-eDP-1
[530.163839] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[530.173193] Starting dynamic subtest: pipe-D-eDP-1
[530.194448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[530.197073] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[532.267731] [119/131] (487s left) perf_pmu (semaphore-wait-idle)
[532.311720] Starting subtest: semaphore-wait-idle
[532.314276] Starting dynamic subtest: rcs0
[532.826479] Dynamic subtest rcs0: SUCCESS (0.514s)
[532.839690] Starting dynamic subtest: bcs0
[533.340961] Dynamic subtest bcs0: SUCCESS (0.511s)
[533.351816] Starting dynamic subtest: vcs0
[533.854693] Dynamic subtest vcs0: SUCCESS (0.511s)
[533.865873] Starting dynamic subtest: vcs1
[534.368378] Dynamic subtest vcs1: SUCCESS (0.511s)
[534.379892] Starting dynamic subtest: vecs0
[534.881962] Dynamic subtest vecs0: SUCCESS (0.511s)
[534.893059] Starting dynamic subtest: ccs0
[535.397313] Dynamic subtest ccs0: SUCCESS (0.512s)
[535.400297] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[535.544692] [120/131] (484s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[535.631070] Starting subtest: psr-1p-pri-indfb-multidraw
[557.729855] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.100s)
[557.875672] [121/131] (462s left) i915_pm_rpm (sysfs-read)
[559.506487] Starting subtest: sysfs-read
[560.665300] Subtest sysfs-read: SUCCESS (1.154s)
[561.066718] [122/131] (458s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[561.124807] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[561.129459] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[561.323720] [123/131] (458s left) gem_fence_thrash (bo-write-verify-none)
[561.355805] Starting subtest: bo-write-verify-none
[561.378957] Subtest bo-write-verify-none: SKIP (0.024s)
[561.435675] [124/131] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[561.538746] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[568.425445] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.884s)
[568.550535] [125/131] (451s left) i915_pm_rps (waitboost)
[568.609631] Starting subtest: waitboost
[568.688668] Subtest waitboost: FAIL (0.030s)
[568.768661] [126/131] (451s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[568.866334] Starting subtest: compare-crc-sanitycheck-xr24
[568.868607] Starting dynamic subtest: pipe-A-eDP-1
[569.461023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s)
[569.477609] Starting dynamic subtest: pipe-B-eDP-1
[570.718517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.256s)
[570.728809] Starting dynamic subtest: pipe-C-eDP-1
[571.913114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.190s)
[571.925755] Starting dynamic subtest: pipe-D-eDP-1
[573.176120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s)
[573.178585] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.310s)
[574.031811] [127/131] (446s left) gem_exec_schedule (u-submit-late-slice)
[574.109701] Starting subtest: u-submit-late-slice
[574.111957] Starting dynamic subtest: rcs0
[574.144333] Dynamic subtest rcs0: SUCCESS (0.043s)
[574.157079] Starting dynamic subtest: bcs0
[574.180942] Dynamic subtest bcs0: SUCCESS (0.036s)
[574.191123] Starting dynamic subtest: vcs0
[574.215083] Dynamic subtest vcs0: SUCCESS (0.032s)
[574.225141] Starting dynamic subtest: vcs1
[574.245737] Dynamic subtest vcs1: SUCCESS (0.030s)
[574.257765] Starting dynamic subtest: vecs0
[574.282922] Dynamic subtest vecs0: SUCCESS (0.036s)
[574.294903] Starting dynamic subtest: ccs0
[574.320231] Dynamic subtest ccs0: SUCCESS (0.036s)
[574.322803] Subtest u-submit-late-slice: SUCCESS (0.219s)
[575.515741] [128/131] (444s left) gem_mmap_offset (close-race)
[575.578940] Starting subtest: close-race
[595.680580] Subtest close-race: SUCCESS (20.091s)
[595.839241] [129/131] (424s left) gem_exec_schedule (implicit-boths)
[595.912825] Starting subtest: implicit-boths
[595.915619] Starting dynamic subtest: rcs0
[596.086047] Dynamic subtest rcs0: SUCCESS (0.179s)
[596.098665] Starting dynamic subtest: vcs0
[596.195215] Dynamic subtest vcs0: SUCCESS (0.109s)
[596.207522] Starting dynamic subtest: vcs1
[596.328359] Dynamic subtest vcs1: SUCCESS (0.133s)
[596.340738] Starting dynamic subtest: vecs0
[596.429619] Dynamic subtest vecs0: SUCCESS (0.100s)
[596.442215] Starting dynamic subtest: ccs0
[596.559285] Dynamic subtest ccs0: SUCCESS (0.129s)
[596.562259] Subtest implicit-boths: SUCCESS (0.653s)
[597.528441] [130/131] (422s left) kms_scaling_modes (scaling-mode-full)
[597.626126] Starting subtest: scaling-mode-full
[597.628298] Starting dynamic subtest: pipe-A-eDP-1
[597.718058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[597.732943] Starting dynamic subtest: pipe-B-eDP-1
[598.933989] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[598.944815] Starting dynamic subtest: pipe-C-eDP-1
[600.132236] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[600.141961] Starting dynamic subtest: pipe-D-eDP-1
[601.263504] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[601.265872] Subtest scaling-mode-full: SUCCESS (3.639s)
[602.457280] [131/131] (417s left) gem_softpin (softpin)
[602.524298] Starting subtest: softpin
[634.766447] Subtest softpin: SUCCESS (32.228s)
[634.936082] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gen3_mixed_blits
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: gem_pwrite
results: parsing output: 11/ for test: gem_workarounds
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_invalid_mode
results: parsing output: 16/ for test: kms_plane_cursor
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_engines
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_vrr
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: gem_exec_async
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: dumb_buffer
results: parsing output: 36/ for test: sysfs_timeslice_duration
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: gem_pipe_control_store_loop
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: dumb_buffer
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_fence_thrash
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane_scaling
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: syncobj_basic
results: parsing output: 60/ for test: kms_feature_discovery
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: prime_mmap_kms
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: gem_flink_race
results: parsing output: 74/ for test: gem_exec_params
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: drm_read
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: gem_vm_create
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: vgem_basic
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: gem_set_tiling_vs_gtt
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_pwrite_crc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_writeback
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: gem_media_fill
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_pm_rpm
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_scaling_modes
results: parsing output: 130/ for test: gem_softpin
Done.