[56.659825] Initializing watchdogs
[56.659874]   /dev/watchdog0
[56.675497] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.680612] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.683606] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.686914] [001/131] (960s left) kms_psr (fbc-psr2-primary-page-flip)
[56.788774] Starting subtest: fbc-psr2-primary-page-flip
[56.790988] Starting dynamic subtest: eDP-1
[56.795249] Dynamic subtest eDP-1: SKIP (0.000s)
[56.799623] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[56.866591] [002/131] (960s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[56.954971] Starting subtest: bo-too-small-due-to-tiling
[56.959208] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[57.072121] [003/131] (960s left) gem_exec_fence (concurrent)
[57.252851] Starting subtest: concurrent
[57.256992] Subtest concurrent: SKIP (0.000s)
[59.015890] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[59.018927] [004/131] (958s left) gem_exec_reloc (basic-gtt-cpu)
[59.079878] Subtest basic-gtt-cpu: SKIP (0.000s)
[59.165698] [005/131] (958s left) gen3_mixed_blits
[59.282040] [006/131] (958s left) syncobj_timeline (device-submit-unordered)
[59.332704] Starting subtest: device-submit-unordered
[59.334955] Subtest device-submit-unordered: SUCCESS (0.000s)
[59.458256] [007/131] (957s left) kms_big_fb (x-tiled-addfb)
[59.561547] Starting subtest: x-tiled-addfb
[59.563878] Subtest x-tiled-addfb: SUCCESS (0.000s)
[59.680213] [008/131] (957s left) kms_cursor_crc (cursor-onscreen-32x10)
[59.841836] Starting subtest: cursor-onscreen-32x10
[59.892033] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[60.172402] [009/131] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[60.282474] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[60.286171] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.417023] [010/131] (957s left) api_intel_bb (object-reloc-keep-cache)
[60.472194] Starting subtest: object-reloc-keep-cache
[60.476195] Subtest object-reloc-keep-cache: SKIP (0.003s)
[60.608664] [011/131] (956s left) gem_pwrite (basic-exhaustion)
[60.660870] Subtest basic-exhaustion: SKIP (0.000s)
[60.728278] [012/131] (956s left) gem_workarounds (basic-read)
[60.793319] Starting subtest: basic-read
[60.804312] Subtest basic-read: SUCCESS (0.011s)
[60.940826] [013/131] (956s left) gem_mmap_gtt (medium-copy-odd)
[61.001920] Subtest medium-copy-odd: SKIP (0.000s)
[61.060662] [014/131] (956s left) gem_workarounds (suspend-resume-fd)
[61.138061] Starting subtest: suspend-resume-fd
[77.911271] Subtest suspend-resume-fd: SUCCESS (1.691s)
[85.070564] [015/131] (939s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[90.142577] Starting subtest: fbc-pr-cursor-plane-update-sf
[90.147737] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.003s)
[91.015351] [016/131] (933s left) kms_invalid_mode (clock-too-high)
[91.122231] Starting subtest: clock-too-high
[91.124544] Starting dynamic subtest: pipe-A-eDP-1
[91.129033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.139377] Starting dynamic subtest: pipe-B-eDP-1
[91.143529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.151450] Starting dynamic subtest: pipe-C-eDP-1
[91.155856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.164959] Starting dynamic subtest: pipe-D-eDP-1
[91.169239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.173450] Subtest clock-too-high: SKIP (0.003s)
[91.212889] [017/131] (933s left) kms_plane_cursor (primary)
[91.306607] Starting subtest: primary
[91.311094] Starting dynamic subtest: pipe-A-eDP-1-size-64
[94.004050] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.698s)
[94.029714] Starting dynamic subtest: pipe-A-eDP-1-size-128
[96.772221] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.749s)
[96.795939] Starting dynamic subtest: pipe-A-eDP-1-size-256
[99.507291] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.716s)
[99.821326] Starting dynamic subtest: pipe-B-eDP-1-size-64
[103.232254] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.420s)
[103.256263] Starting dynamic subtest: pipe-B-eDP-1-size-128
[105.921924] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.671s)
[105.946965] Starting dynamic subtest: pipe-B-eDP-1-size-256
[108.713906] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.773s)
[109.026860] Starting dynamic subtest: pipe-C-eDP-1-size-64
[112.067664] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.049s)
[112.092905] Starting dynamic subtest: pipe-C-eDP-1-size-128
[114.356237] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.269s)
[114.382469] Starting dynamic subtest: pipe-C-eDP-1-size-256
[116.756727] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.381s)
[117.074407] Starting dynamic subtest: pipe-D-eDP-1-size-64
[120.140158] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.076s)
[120.166516] Starting dynamic subtest: pipe-D-eDP-1-size-128
[122.496845] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.337s)
[122.522574] Starting dynamic subtest: pipe-D-eDP-1-size-256
[124.841931] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.324s)
[125.147171] Subtest primary: SUCCESS (33.839s)
[126.032392] [018/131] (898s left) kms_cursor_crc (cursor-sliding-256x256)
[126.288365] Starting subtest: cursor-sliding-256x256
[126.294165] Starting dynamic subtest: pipe-A-eDP-1
[129.557151] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.263s)
[129.589133] Starting dynamic subtest: pipe-D-eDP-1
[133.410950] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.833s)
[133.413372] Subtest cursor-sliding-256x256: SUCCESS (7.122s)
[134.308026] [019/131] (890s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[134.414299] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[141.252418] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.840s)
[141.414011] [020/131] (883s left) i915_drm_fdinfo (idle)
[141.453254] Starting subtest: idle
[141.455389] Starting dynamic subtest: rcs0
[142.028367] Dynamic subtest rcs0: SUCCESS (0.577s)
[142.038896] Starting dynamic subtest: bcs0
[142.536035] Dynamic subtest bcs0: SUCCESS (0.503s)
[142.547418] Starting dynamic subtest: vcs0
[143.041315] Dynamic subtest vcs0: SUCCESS (0.503s)
[143.052518] Starting dynamic subtest: vcs1
[143.548986] Dynamic subtest vcs1: SUCCESS (0.505s)
[143.560635] Starting dynamic subtest: vecs0
[144.056122] Dynamic subtest vecs0: SUCCESS (0.504s)
[144.067586] Starting dynamic subtest: ccs0
[144.563944] Dynamic subtest ccs0: SUCCESS (0.504s)
[144.566692] Subtest idle: SUCCESS (3.112s)
[144.643146] [021/131] (880s left) kms_flip (2x-plain-flip)
[144.741010] Starting subtest: 2x-plain-flip
[144.752520] Subtest 2x-plain-flip: SKIP (0.011s)
[144.860497] [022/131] (880s left) kms_big_fb (linear-32bpp-rotate-0)
[144.969054] Starting subtest: linear-32bpp-rotate-0
[146.381546] Subtest linear-32bpp-rotate-0: SUCCESS (1.412s)
[146.557506] [023/131] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[146.659659] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[146.663247] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[146.769709] [024/131] (878s left) gem_ctx_engines (invalid-engines)
[146.833923] Starting subtest: invalid-engines
[146.842609] Subtest invalid-engines: SUCCESS (0.009s)
[147.083763] [025/131] (878s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[147.142837] Starting subtest: single-wait-all-for-submit-unsubmitted
[147.244288] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[147.345169] [026/131] (877s left) kms_cursor_legacy (torture-bo)
[147.468852] Starting subtest: torture-bo
[147.470706] Starting dynamic subtest: pipe-A
[153.145663] Dynamic subtest pipe-A: SUCCESS (5.674s)
[153.157625] Starting dynamic subtest: pipe-B
[159.284051] Dynamic subtest pipe-B: SUCCESS (6.135s)
[159.294779] Starting dynamic subtest: pipe-C
[165.387518] Dynamic subtest pipe-C: SUCCESS (6.101s)
[165.399532] Starting dynamic subtest: pipe-D
[171.339498] Dynamic subtest pipe-D: SUCCESS (5.949s)
[171.351989] Starting dynamic subtest: all-pipes
[177.811055] Dynamic subtest all-pipes: SUCCESS (6.470s)
[177.813700] Subtest torture-bo: SUCCESS (30.341s)
[177.977441] [027/131] (847s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[178.033101] Starting subtest: etime-multi-wait-for-submit-submitted
[178.140992] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[178.242357] [028/131] (847s left) kms_vrr (negative-basic)
[178.341092] Starting subtest: negative-basic
[178.347377] Starting dynamic subtest: pipe-A-eDP-1
[183.763175] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[184.062821] Subtest negative-basic: SUCCESS (5.721s)
[184.881495] [029/131] (840s left) kms_psr (psr-basic)
[184.971141] Starting subtest: psr-basic
[184.973450] Starting dynamic subtest: eDP-1
[186.535433] Dynamic subtest eDP-1: SUCCESS (1.562s)
[186.537623] Subtest psr-basic: SUCCESS (1.563s)
[187.432566] [030/131] (837s left) gem_spin_batch (resubmit-new-all)
[187.488288] Starting subtest: resubmit-new-all
[187.490683] Starting dynamic subtest: rcs0
[187.502816] Dynamic subtest rcs0: SUCCESS (0.014s)
[187.512987] Starting dynamic subtest: bcs0
[187.515376] Dynamic subtest bcs0: SUCCESS (0.010s)
[187.526714] Starting dynamic subtest: vcs0
[187.528962] Dynamic subtest vcs0: SUCCESS (0.009s)
[187.537131] Starting dynamic subtest: vcs1
[187.539431] Dynamic subtest vcs1: SUCCESS (0.012s)
[187.547665] Starting dynamic subtest: vecs0
[187.549454] Dynamic subtest vecs0: SUCCESS (0.008s)
[187.557590] Starting dynamic subtest: ccs0
[187.559877] Dynamic subtest ccs0: SUCCESS (0.009s)
[187.562024] Subtest resubmit-new-all: SUCCESS (0.067s)
[189.043969] [031/131] (836s left) gem_exec_async (forked-writes)
[189.099526] Starting subtest: forked-writes
[189.102104] Starting dynamic subtest: rcs0
[189.125141] Dynamic subtest rcs0: SUCCESS (0.026s)
[189.137280] Starting dynamic subtest: bcs0
[189.151045] Dynamic subtest bcs0: SUCCESS (0.025s)
[189.160345] Starting dynamic subtest: vcs0
[189.174499] Dynamic subtest vcs0: SUCCESS (0.022s)
[189.183070] Starting dynamic subtest: vcs1
[189.195777] Dynamic subtest vcs1: SUCCESS (0.021s)
[189.207168] Starting dynamic subtest: vecs0
[189.218174] Dynamic subtest vecs0: SUCCESS (0.022s)
[189.230758] Starting dynamic subtest: ccs0
[189.238741] Dynamic subtest ccs0: SUCCESS (0.020s)
[189.241009] Subtest forked-writes: SUCCESS (0.140s)
[189.509514] [032/131] (835s left) api_intel_bb (add-remove-objects)
[189.561796] Starting subtest: add-remove-objects
[189.564037] Subtest add-remove-objects: SUCCESS (0.005s)
[189.726862] [033/131] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[189.825170] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[189.829121] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[189.955031] [034/131] (835s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[190.039126] Starting subtest: psr-rgb565-draw-render
[196.958311] Subtest psr-rgb565-draw-render: SUCCESS (6.920s)
[197.109297] [035/131] (828s left) kms_flip (2x-plain-flip-ts-check)
[197.214187] Starting subtest: 2x-plain-flip-ts-check
[197.225458] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[197.357448] [036/131] (828s left) dumb_buffer (invalid-bpp)
[197.415839] Starting subtest: invalid-bpp
[197.418107] Subtest invalid-bpp: SUCCESS (0.000s)
[197.550693] [037/131] (828s left) sysfs_timeslice_duration (duration)
[197.610341] Starting subtest: duration
[197.612771] Starting dynamic subtest: vecs0
[210.974350] Dynamic subtest vecs0: SUCCESS (13.361s)
[210.984529] Starting dynamic subtest: ccs0
[224.137017] Dynamic subtest ccs0: SUCCESS (13.160s)
[224.148341] Starting dynamic subtest: vcs0
[237.982457] Dynamic subtest vcs0: SUCCESS (13.841s)
[237.992613] Starting dynamic subtest: bcs0
[251.138099] Dynamic subtest bcs0: SUCCESS (13.154s)
[251.150714] Starting dynamic subtest: rcs0
[264.286836] Dynamic subtest rcs0: SUCCESS (13.147s)
[264.298448] Starting dynamic subtest: vcs1
[277.918093] Dynamic subtest vcs1: SUCCESS (13.627s)
[277.921460] Subtest duration: SUCCESS (80.305s)
[278.021402] [038/131] (747s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[278.124052] Starting subtest: y-tiled-64bpp-rotate-180
[278.128510] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[278.238803] [039/131] (747s left) prime_vgem (wait)
[278.317625] Starting subtest: wait
[278.319870] Starting dynamic subtest: rcs0
[278.376230] Dynamic subtest rcs0: SUCCESS (0.058s)
[278.385870] Starting dynamic subtest: bcs0
[278.460140] Dynamic subtest bcs0: SUCCESS (0.083s)
[278.469025] Starting dynamic subtest: vcs0
[278.506228] Dynamic subtest vcs0: SUCCESS (0.045s)
[278.514817] Starting dynamic subtest: vcs1
[278.552347] Dynamic subtest vcs1: SUCCESS (0.045s)
[278.560764] Starting dynamic subtest: vecs0
[278.599654] Dynamic subtest vecs0: SUCCESS (0.046s)
[278.608169] Starting dynamic subtest: ccs0
[278.645827] Dynamic subtest ccs0: SUCCESS (0.045s)
[278.648112] Subtest wait: SUCCESS (0.329s)
[278.802583] [040/131] (746s left) gem_pipe_control_store_loop (fresh-buffer)
[278.846967] Starting subtest: fresh-buffer
[281.000497] Subtest fresh-buffer: SUCCESS (2.152s)
[281.144390] [041/131] (744s left) gem_ctx_persistence (heartbeat-many)
[281.208582] Starting subtest: heartbeat-many
[281.213320] Subtest heartbeat-many: SKIP (0.000s)
[281.335803] [042/131] (744s left) dumb_buffer (map-invalid-size)
[281.391796] Starting subtest: map-invalid-size
[281.394298] Subtest map-invalid-size: SUCCESS (0.000s)
[281.525558] [043/131] (744s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[281.627944] Starting subtest: pipe-fbc-rte
[281.634593] Starting dynamic subtest: pipe-B-eDP-1
[287.100811] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.475s)
[287.109030] Subtest pipe-fbc-rte: SUCCESS (5.478s)
[289.470954] [044/131] (736s left) gem_fence_thrash (bo-write-verify-x)
[289.503372] Starting subtest: bo-write-verify-x
[289.534674] Subtest bo-write-verify-x: SKIP (0.027s)
[289.587989] [045/131] (736s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[289.654510] Starting subtest: basic-batch-kernel-default-cmd
[289.659029] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[289.859758] [046/131] (736s left) i915_hangman (gt-engine-error)
[289.922524] Starting subtest: gt-engine-error
[289.924807] Starting dynamic subtest: rcs0
[290.978533] Dynamic subtest rcs0: SUCCESS (1.054s)
[290.988136] Starting dynamic subtest: bcs0
[292.959016] Dynamic subtest bcs0: SUCCESS (1.977s)
[292.970154] Starting dynamic subtest: vcs0
[294.943399] Dynamic subtest vcs0: SUCCESS (1.981s)
[294.954355] Starting dynamic subtest: vcs1
[296.990703] Dynamic subtest vcs1: SUCCESS (2.044s)
[297.002036] Starting dynamic subtest: vecs0
[298.974849] Dynamic subtest vecs0: SUCCESS (1.981s)
[298.986651] Starting dynamic subtest: ccs0
[300.958723] Dynamic subtest ccs0: SUCCESS (1.981s)
[300.961552] Subtest gt-engine-error: SUCCESS (11.036s)
[301.060257] [047/131] (724s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[301.166515] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[302.122621] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.956s)
[302.304887] [048/131] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[302.407783] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[302.411108] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[302.548919] [049/131] (723s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[302.641087] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[302.643036] Starting dynamic subtest: pipe-A-default-mode
[305.373610] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[305.375917] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.734s)
[306.293028] [050/131] (719s left) kms_chamelium_frames (hdmi-crc-multiple)
[306.677043] Subtest hdmi-crc-multiple: SKIP (0.000s)
[307.451659] [051/131] (718s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[307.547139] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[307.559273] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[307.676534] [052/131] (718s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[307.774206] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[314.802017] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.030s)
[314.978331] [053/131] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[315.078218] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[315.082574] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[315.200472] [054/131] (711s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[315.261933] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[315.264216] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[315.390420] [055/131] (711s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[315.489409] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[315.491566] Starting dynamic subtest: pipe-A-eDP-1
[315.513487] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.523178] Starting dynamic subtest: pipe-B-eDP-1
[315.543823] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.552443] Starting dynamic subtest: pipe-C-eDP-1
[315.573314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.581732] Starting dynamic subtest: pipe-D-eDP-1
[315.603900] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.608194] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[317.690958] [056/131] (708s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[317.793521] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[321.959140] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.168s)
[323.100717] [057/131] (703s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[323.189889] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[323.191994] Starting dynamic subtest: pipe-A
[323.208895] Dynamic subtest pipe-A: SKIP (0.016s)
[323.218028] Starting dynamic subtest: pipe-B
[323.240013] Dynamic subtest pipe-B: SKIP (0.030s)
[323.248535] Starting dynamic subtest: pipe-C
[323.268069] Dynamic subtest pipe-C: SKIP (0.030s)
[323.276529] Starting dynamic subtest: pipe-D
[323.300066] Dynamic subtest pipe-D: SKIP (0.030s)
[323.303563] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.107s)
[323.435250] [058/131] (703s left) kms_psr (fbc-psr-cursor-plane-move)
[323.528901] Starting subtest: fbc-psr-cursor-plane-move
[323.531176] Starting dynamic subtest: eDP-1
[323.535480] Dynamic subtest eDP-1: SKIP (0.000s)
[323.539902] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[323.618699] [059/131] (702s left) gem_exec_fence (syncobj-invalid-wait)
[324.055182] Starting subtest: syncobj-invalid-wait
[324.057470] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[326.086207] [060/131] (700s left) syncobj_basic (bad-create-flags)
[326.150610] Starting subtest: bad-create-flags
[326.152895] Subtest bad-create-flags: SUCCESS (0.000s)
[326.276192] [061/131] (700s left) kms_feature_discovery (display-1x)
[326.384653] Starting subtest: display-1x
[326.387013] Subtest display-1x: SUCCESS (0.000s)
[326.469562] [062/131] (700s left) kms_pm_rpm (modeset-lpsp-stress)
[328.199035] Starting subtest: modeset-lpsp-stress
[343.719213] Subtest modeset-lpsp-stress: SUCCESS (15.523s)
[343.843770] [063/131] (682s left) prime_mmap_kms (buffer-sharing)
[343.934656] Starting subtest: buffer-sharing
[344.375380] Subtest buffer-sharing: SUCCESS (0.440s)
[345.222463] [064/131] (681s left) kms_chamelium_color (degamma)
[345.318165] Subtest degamma: SKIP (0.000s)
[345.362678] [065/131] (681s left) gem_ctx_param (invalid-get-ringsize)
[345.417450] Starting subtest: invalid-get-ringsize
[345.423343] Subtest invalid-get-ringsize: SUCCESS (0.003s)
[345.552389] [066/131] (681s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[350.588022] Starting subtest: psr2-overlay-plane-update-continuous-sf
[350.590255] Starting dynamic subtest: pipe-A-eDP-1
[352.339876] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[352.349869] Starting dynamic subtest: pipe-B-eDP-1
[354.082263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.738s)
[354.084604] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.494s)
[354.917103] [067/131] (671s left) gem_exec_reloc (basic-write-read-active)
[354.983961] Subtest basic-write-read-active: SKIP (0.000s)
[355.065901] [068/131] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[355.174329] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[362.548326] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.377s)
[362.710715] [069/131] (664s left) kms_force_connector_basic (force-load-detect)
[362.784901] Starting subtest: force-load-detect
[362.789366] Subtest force-load-detect: SKIP (0.000s)
[362.908827] [070/131] (664s left) kms_pm_rpm (modeset-non-lpsp-stress)
[365.123944] Starting subtest: modeset-non-lpsp-stress
[366.281589] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[366.660125] [071/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[366.768912] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[366.772831] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[366.912807] [072/131] (660s left) gem_exec_schedule (fairslice-all)
[366.983719] Starting subtest: fairslice-all
[369.036549] Subtest fairslice-all: SUCCESS (2.059s)
[371.110119] [073/131] (656s left) kms_color (ctm-0-25)
[371.211947] Starting subtest: ctm-0-25
[371.214181] Starting dynamic subtest: pipe-A-eDP-1
[374.637628] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[374.647294] Starting dynamic subtest: pipe-B-eDP-1
[378.760874] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.121s)
[378.772359] Starting dynamic subtest: pipe-C-eDP-1
[382.712942] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.952s)
[382.723633] Starting dynamic subtest: pipe-D-eDP-1
[386.694047] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.981s)
[386.696283] Subtest ctm-0-25: SUCCESS (15.484s)
[387.568495] [074/131] (639s left) gem_flink_race (flink_close)
[387.607895] Starting subtest: flink_close
[392.709925] Subtest flink_close: SUCCESS (5.102s)
[392.799900] [075/131] (634s left) gem_exec_params (rel-constants-invalid)
[392.855796] Starting subtest: rel-constants-invalid
[392.858270] Subtest rel-constants-invalid: SUCCESS (0.000s)
[392.984742] [076/131] (634s left) gen9_exec_parse (secure-batches)
[393.047553] Subtest secure-batches: SKIP (0.000s)
[393.113524] [077/131] (634s left) drm_read (short-buffer-nonblock)
[393.275678] Starting subtest: short-buffer-nonblock
[393.278180] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[393.429021] [078/131] (633s left) kms_psr (psr2-cursor-mmap-gtt)
[393.526914] Starting subtest: psr2-cursor-mmap-gtt
[393.529193] Starting dynamic subtest: eDP-1
[395.220994] Dynamic subtest eDP-1: SUCCESS (1.693s)
[395.223313] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.694s)
[396.031415] [079/131] (631s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[396.129055] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[396.131522] Starting dynamic subtest: pipe-A
[396.238202] Dynamic subtest pipe-A: SKIP (0.106s)
[396.248051] Starting dynamic subtest: pipe-B
[397.402577] Dynamic subtest pipe-B: SKIP (1.163s)
[397.412239] Starting dynamic subtest: pipe-C
[398.624702] Dynamic subtest pipe-C: SUCCESS (1.228s)
[398.633661] Starting dynamic subtest: pipe-D
[399.851384] Dynamic subtest pipe-D: SUCCESS (1.225s)
[399.853657] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.725s)
[401.063157] [080/131] (626s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[401.156738] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[401.159189] Starting dynamic subtest: pipe-A-eDP-1
[401.179499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[401.189955] Starting dynamic subtest: pipe-B-eDP-1
[401.208770] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[401.217330] Starting dynamic subtest: pipe-C-eDP-1
[401.236162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[401.245022] Starting dynamic subtest: pipe-D-eDP-1
[401.264223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[401.266153] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[403.425017] [081/131] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[403.526056] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[403.530179] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[403.665044] [082/131] (623s left) syncobj_basic (bad-destroy-pad)
[403.712969] Starting subtest: bad-destroy-pad
[403.715251] Subtest bad-destroy-pad: SUCCESS (0.000s)
[403.818432] [083/131] (623s left) gem_userptr_blits (dmabuf-unsync)
[403.878146] Subtest dmabuf-unsync: SKIP (0.000s)
[404.024534] [084/131] (623s left) kms_rotation_crc (sprite-rotation-180)
[404.109025] Starting subtest: sprite-rotation-180
[409.091639] Subtest sprite-rotation-180: SUCCESS (4.983s)
[410.290035] [085/131] (617s left) gem_vm_create (invalid-create)
[410.347494] Starting subtest: invalid-create
[410.349918] Subtest invalid-create: SUCCESS (0.002s)
[410.456387] [086/131] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[410.550976] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[410.554943] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[410.670119] [087/131] (617s left) syncobj_wait (multi-wait-for-submit-signaled)
[410.718292] Starting subtest: multi-wait-for-submit-signaled
[410.720247] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[410.830135] [088/131] (616s left) vgem_basic (mmap)
[410.871263] Starting subtest: mmap
[410.885195] Subtest mmap: SUCCESS (0.017s)
[410.966556] [089/131] (616s left) gem_eio (in-flight-internal-10ms)
[411.206877] Starting subtest: in-flight-internal-10ms
[413.073307] Subtest in-flight-internal-10ms: SUCCESS (1.865s)
[413.236328] [090/131] (614s left) gem_partial_pwrite_pread (reads-snoop)
[413.283491] Subtest reads-snoop: SKIP (0.000s)
[413.369098] [091/131] (614s left) gem_exec_schedule (timeslicing)
[413.445212] Starting subtest: timeslicing
[413.447482] Starting dynamic subtest: rcs0
[413.457825] Dynamic subtest rcs0: SUCCESS (0.021s)
[413.468932] Starting dynamic subtest: bcs0
[413.478138] Dynamic subtest bcs0: SUCCESS (0.019s)
[413.487263] Starting dynamic subtest: vcs0
[413.498852] Dynamic subtest vcs0: SUCCESS (0.020s)
[413.507760] Starting dynamic subtest: vcs1
[413.520013] Dynamic subtest vcs1: SUCCESS (0.021s)
[413.528832] Starting dynamic subtest: vecs0
[413.541221] Dynamic subtest vecs0: SUCCESS (0.020s)
[413.550183] Starting dynamic subtest: ccs0
[413.562068] Dynamic subtest ccs0: SUCCESS (0.020s)
[413.564419] Subtest timeslicing: SUCCESS (0.126s)
[415.038215] [092/131] (612s left) kms_addfb_basic (master-rmfb)
[415.082109] Starting subtest: master-rmfb
[415.084342] Subtest master-rmfb: SUCCESS (0.001s)
[415.228958] [093/131] (612s left) gem_set_tiling_vs_gtt
[415.344943] [094/131] (612s left) gem_exec_reloc (basic-cpu-gtt)
[415.416119] Subtest basic-cpu-gtt: SKIP (0.000s)
[415.491574] [095/131] (612s left) kms_cursor_crc (cursor-onscreen-max-size)
[415.803526] Starting subtest: cursor-onscreen-max-size
[415.810247] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[415.969364] [096/131] (612s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[416.073208] Starting subtest: psr-rgb101010-draw-render
[423.371493] Subtest psr-rgb101010-draw-render: SUCCESS (7.300s)
[423.511371] [097/131] (604s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[423.612629] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[427.248101] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.639s)
[428.443340] [098/131] (599s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[428.562322] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[437.596429] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.035s)
[438.482729] [099/131] (589s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[438.578959] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[438.581242] Starting dynamic subtest: pipe-A-eDP-1
[438.590342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.600423] Starting dynamic subtest: pipe-B-eDP-1
[438.609490] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.618669] Starting dynamic subtest: pipe-C-eDP-1
[438.627187] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.636210] Starting dynamic subtest: pipe-D-eDP-1
[438.644909] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.649261] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[440.756300] [100/131] (587s left) kms_pwrite_crc
[442.391339] [101/131] (585s left) syncobj_timeline (wait-all-for-submit-snapshot)
[442.446367] Starting subtest: wait-all-for-submit-snapshot
[442.526247] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[442.602355] [102/131] (585s left) kms_psr (fbc-pr-sprite-blt)
[442.700145] Starting subtest: fbc-pr-sprite-blt
[442.704578] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[442.797213] [103/131] (585s left) kms_content_protection (dp-mst-lic-type-1)
[442.939407] Starting subtest: dp-mst-lic-type-1
[442.943829] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[443.118271] [104/131] (585s left) kms_writeback (writeback-fb-id)
[443.210525] Subtest writeback-fb-id: SKIP (0.000s)
[443.265500] [105/131] (585s left) kms_async_flips (test-cursor-atomic)
[443.356887] Starting subtest: test-cursor-atomic
[443.360477] Subtest test-cursor-atomic: SKIP (0.000s)
[444.619183] [106/131] (583s left) gem_media_fill (media-fill)
[444.685796] Subtest media-fill: SKIP (0.000s)
[444.824858] [107/131] (583s left) kms_properties (plane-properties-legacy)
[444.921036] Starting subtest: plane-properties-legacy
[444.923370] Starting dynamic subtest: pipe-A-eDP-1
[445.475798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[445.485113] Starting dynamic subtest: pipe-B-eDP-1
[446.760192] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[446.771041] Starting dynamic subtest: pipe-C-eDP-1
[448.007778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s)
[448.017523] Starting dynamic subtest: pipe-D-eDP-1
[449.228829] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[449.231105] Subtest plane-properties-legacy: SUCCESS (4.307s)
[450.049295] [108/131] (578s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[450.108005] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[450.112517] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[450.315782] [109/131] (578s left) gem_lmem_swapping (heavy-verify-random)
[450.358063] Subtest heavy-verify-random: SKIP (0.000s)
[450.399073] [110/131] (578s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[450.463495] Starting subtest: invalid-single-wait-all-unsubmitted
[450.465808] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[450.584339] [111/131] (578s left) kms_lease (lease-invalid-connector)
[450.680969] Starting subtest: lease-invalid-connector
[450.683138] Starting dynamic subtest: pipe-A-eDP-1
[450.685371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[450.694201] Starting dynamic subtest: pipe-B-eDP-1
[450.696068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[450.704985] Starting dynamic subtest: pipe-C-eDP-1
[450.707087] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[450.715817] Starting dynamic subtest: pipe-D-eDP-1
[450.717591] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[450.719510] Subtest lease-invalid-connector: SUCCESS (0.005s)
[450.779066] [112/131] (578s left) gem_eio (kms)
[451.046497] Starting subtest: kms
[471.864693] Subtest kms: SUCCESS (20.817s)
[473.070476] [113/131] (555s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[473.180001] Starting subtest: extended-pageflip-modeset-hang-oldfb
[473.182162] Starting dynamic subtest: pipe-A
[481.084297] Dynamic subtest pipe-A: SUCCESS (7.903s)
[481.095995] Starting dynamic subtest: pipe-D
[489.656450] Dynamic subtest pipe-D: SUCCESS (8.570s)
[489.658860] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.478s)
[490.523556] [114/131] (538s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[490.632031] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[491.576977] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.946s)
[491.741388] [115/131] (537s left) perf (buffer-fill)
[491.875005] Starting subtest: buffer-fill
[491.876813] Starting dynamic subtest: 0-rcs0
[494.148533] Dynamic subtest 0-rcs0: SUCCESS (2.272s)
[494.159052] Starting dynamic subtest: 1-vcs0
[498.585856] Dynamic subtest 1-vcs0: SUCCESS (4.436s)
[498.588825] Subtest buffer-fill: SUCCESS (6.711s)
[498.637516] [116/131] (530s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[498.744910] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[498.749389] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[498.887712] [117/131] (530s left) kms_vblank (query-forked-hang)
[498.974895] Starting subtest: query-forked-hang
[498.977177] Starting dynamic subtest: pipe-A-eDP-1
[526.726855] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.751s)
[526.742148] Starting dynamic subtest: pipe-D-eDP-1
[551.734380] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.002s)
[551.736608] Subtest query-forked-hang: SUCCESS (52.758s)
[552.580627] [118/131] (476s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[552.682942] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[552.685231] Starting dynamic subtest: pipe-A-eDP-1
[552.706195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[552.717134] Starting dynamic subtest: pipe-B-eDP-1
[552.735953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[552.745046] Starting dynamic subtest: pipe-C-eDP-1
[552.764141] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[552.773348] Starting dynamic subtest: pipe-D-eDP-1
[552.793712] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[552.795786] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[554.949901] [119/131] (474s left) perf_pmu (semaphore-wait-idle)
[554.989806] Starting subtest: semaphore-wait-idle
[554.992166] Starting dynamic subtest: rcs0
[555.502443] Dynamic subtest rcs0: SUCCESS (0.514s)
[555.516002] Starting dynamic subtest: bcs0
[556.016796] Dynamic subtest bcs0: SUCCESS (0.511s)
[556.030363] Starting dynamic subtest: vcs0
[556.530994] Dynamic subtest vcs0: SUCCESS (0.511s)
[556.544277] Starting dynamic subtest: vcs1
[557.044804] Dynamic subtest vcs1: SUCCESS (0.510s)
[557.057597] Starting dynamic subtest: vecs0
[557.557785] Dynamic subtest vecs0: SUCCESS (0.510s)
[557.570881] Starting dynamic subtest: ccs0
[558.074091] Dynamic subtest ccs0: SUCCESS (0.513s)
[558.076866] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[558.230885] [120/131] (470s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[558.330156] Starting subtest: psr-1p-pri-indfb-multidraw
[580.427574] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.098s)
[580.574259] [121/131] (448s left) i915_pm_rpm (sysfs-read)
[582.205443] Starting subtest: sysfs-read
[583.358371] Subtest sysfs-read: SUCCESS (1.154s)
[583.763062] [122/131] (445s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[583.826265] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[583.830701] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[584.023295] [123/131] (445s left) gem_fence_thrash (bo-write-verify-none)
[584.055649] Starting subtest: bo-write-verify-none
[584.076277] Subtest bo-write-verify-none: SKIP (0.020s)
[584.135156] [124/131] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[584.239418] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[591.206287] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.968s)
[591.359784] [125/131] (437s left) i915_pm_rps (waitboost)
[591.415725] Starting subtest: waitboost
[591.485863] Subtest waitboost: FAIL (0.018s)
[591.566134] [126/131] (437s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[591.662828] Starting subtest: compare-crc-sanitycheck-xr24
[591.665184] Starting dynamic subtest: pipe-A-eDP-1
[592.260628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[592.273001] Starting dynamic subtest: pipe-B-eDP-1
[593.504507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[593.514534] Starting dynamic subtest: pipe-C-eDP-1
[594.685453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s)
[594.696686] Starting dynamic subtest: pipe-D-eDP-1
[595.902811] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[595.905151] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.241s)
[596.790488] [127/131] (432s left) gem_exec_schedule (u-submit-late-slice)
[596.860931] Starting subtest: u-submit-late-slice
[596.862842] Starting dynamic subtest: rcs0
[596.893223] Dynamic subtest rcs0: SUCCESS (0.040s)
[596.905584] Starting dynamic subtest: bcs0
[596.928517] Dynamic subtest bcs0: SUCCESS (0.035s)
[596.940995] Starting dynamic subtest: vcs0
[596.961418] Dynamic subtest vcs0: SUCCESS (0.032s)
[596.971356] Starting dynamic subtest: vcs1
[596.994066] Dynamic subtest vcs1: SUCCESS (0.032s)
[597.004600] Starting dynamic subtest: vecs0
[597.024566] Dynamic subtest vecs0: SUCCESS (0.030s)
[597.034504] Starting dynamic subtest: ccs0
[597.060776] Dynamic subtest ccs0: SUCCESS (0.036s)
[597.062942] Subtest u-submit-late-slice: SUCCESS (0.208s)
[598.154464] [128/131] (431s left) gem_mmap_offset (close-race)
[598.202870] Starting subtest: close-race
[618.311520] Subtest close-race: SUCCESS (20.109s)
[618.463192] [129/131] (411s left) gem_exec_schedule (implicit-boths)
[618.533739] Starting subtest: implicit-boths
[618.535755] Starting dynamic subtest: rcs0
[618.701714] Dynamic subtest rcs0: SUCCESS (0.177s)
[618.714288] Starting dynamic subtest: vcs0
[618.810242] Dynamic subtest vcs0: SUCCESS (0.107s)
[618.822480] Starting dynamic subtest: vcs1
[618.920572] Dynamic subtest vcs1: SUCCESS (0.110s)
[618.936630] Starting dynamic subtest: vecs0
[619.037014] Dynamic subtest vecs0: SUCCESS (0.115s)
[619.050002] Starting dynamic subtest: ccs0
[619.200542] Dynamic subtest ccs0: SUCCESS (0.163s)
[619.203539] Subtest implicit-boths: SUCCESS (0.677s)
[620.076622] [130/131] (409s left) kms_scaling_modes (scaling-mode-full)
[620.173698] Starting subtest: scaling-mode-full
[620.175965] Starting dynamic subtest: pipe-A-eDP-1
[620.266080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[620.278876] Starting dynamic subtest: pipe-B-eDP-1
[621.389325] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[621.402014] Starting dynamic subtest: pipe-C-eDP-1
[622.504696] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[622.515218] Starting dynamic subtest: pipe-D-eDP-1
[623.636120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[623.638576] Subtest scaling-mode-full: SUCCESS (3.465s)
[624.813037] [131/131] (404s left) gem_softpin (softpin)
[624.870730] Starting subtest: softpin
[657.301139] Subtest softpin: SUCCESS (32.426s)
[657.452651] 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.