[54.148212] Initializing watchdogs [54.148258] /dev/watchdog0 [54.162814] [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.167219] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.169640] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.173196] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [54.283789] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [54.288067] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [54.404431] [002/130] (960s left) kms_pm_dc (dc6-dpms) [55.504926] Starting subtest: dc6-dpms [57.566698] Subtest dc6-dpms: SUCCESS (2.062s) [57.638677] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [57.742681] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [57.747223] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [57.845505] [004/130] (956s left) gem_exec_balancer (invalid-balancer) [57.915035] Starting subtest: invalid-balancer [58.815703] Subtest invalid-balancer: SUCCESS (0.900s) [59.144215] [005/130] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [59.238207] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [59.242587] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.363607] [006/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd) [59.421396] Starting subtest: invalid-illegal-eventfd [59.423739] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [59.550718] [007/130] (955s left) prime_vgem (fence-write-hang) [59.637322] Subtest fence-write-hang: SKIP (0.000s) [59.763177] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [59.766184] [008/130] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [59.857330] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [59.859533] Starting dynamic subtest: pipe-A-eDP-1 [60.034041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.168s) [60.042991] Starting dynamic subtest: pipe-B-eDP-1 [60.060648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [60.068575] Starting dynamic subtest: pipe-C-eDP-1 [60.084105] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [60.090245] Starting dynamic subtest: pipe-D-eDP-1 [60.106422] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [60.108133] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.174s) [62.319420] [009/130] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [62.425873] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [62.430682] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [63.544783] [010/130] (951s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [63.642772] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [63.647176] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [63.774409] [011/130] (951s left) perf (sysctl-defaults) [63.866545] Starting subtest: sysctl-defaults [63.869042] Subtest sysctl-defaults: SUCCESS (0.000s) [63.957016] [012/130] (951s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [64.053191] Starting subtest: plane-use-after-nonblocking-unbind-fencing [64.055513] Starting dynamic subtest: pipe-A-eDP-1 [64.126821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.076s) [64.420133] Starting dynamic subtest: pipe-B-eDP-1 [65.230565] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.818s) [65.536635] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.485s) [66.405655] [013/130] (948s left) kms_content_protection (dp-mst-type-0) [66.541772] Starting subtest: dp-mst-type-0 [66.546993] Subtest dp-mst-type-0: SKIP (0.000s) [66.705654] [014/130] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [66.801939] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [66.804357] Starting dynamic subtest: pipe-A-eDP-1 [66.825076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [66.834180] Starting dynamic subtest: pipe-B-eDP-1 [66.852363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [66.859186] Starting dynamic subtest: pipe-C-eDP-1 [66.878654] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [66.885818] Starting dynamic subtest: pipe-D-eDP-1 [66.905800] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [66.907829] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [69.067600] [015/130] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [69.166980] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [69.169170] Starting dynamic subtest: pipe-A-eDP-1 [69.226941] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [69.233997] Starting dynamic subtest: pipe-B-eDP-1 [69.291466] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [69.299819] Starting dynamic subtest: pipe-C-eDP-1 [69.357650] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [69.365941] Starting dynamic subtest: pipe-D-eDP-1 [69.423302] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [69.427723] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s) [71.433525] [016/130] (943s left) gem_exec_reloc (basic-cpu) [71.570823] Subtest basic-cpu: SKIP (0.000s) [71.744295] [017/130] (943s left) kms_chamelium_hpd (dp-hpd-storm-disable) [72.194657] Subtest dp-hpd-storm-disable: SKIP (0.000s) [73.007163] [018/130] (942s left) syncobj_timeline (wait-for-submit-delayed-submit) [73.072603] Starting subtest: wait-for-submit-delayed-submit [73.176768] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [73.263261] [019/130] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.372741] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.377069] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.490841] [020/130] (941s left) gem_mmap_offset (bad-extensions) [73.544811] Starting subtest: bad-extensions [73.547066] Subtest bad-extensions: SUCCESS (0.000s) [73.676532] [021/130] (941s left) kms_lease (atomic-implicit-crtc) [73.766384] Starting subtest: atomic-implicit-crtc [73.768779] Starting dynamic subtest: pipe-A-eDP-1 [73.780622] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [73.789650] Starting dynamic subtest: pipe-B-eDP-1 [73.800748] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s) [73.807461] Starting dynamic subtest: pipe-C-eDP-1 [73.817973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [73.824534] Starting dynamic subtest: pipe-D-eDP-1 [73.835198] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [73.837058] Subtest atomic-implicit-crtc: SUCCESS (0.029s) [73.924874] [022/130] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [74.024275] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [74.028534] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [74.149878] [023/130] (941s left) gem_partial_pwrite_pread (write) [74.216508] Subtest write: SKIP (0.000s) [74.291787] [024/130] (941s left) kms_dither (fb-8bpc-vs-panel-8bpc) [74.382070] Starting subtest: fb-8bpc-vs-panel-8bpc [74.384060] Starting dynamic subtest: pipe-A-eDP-1 [75.791490] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.408s) [75.793862] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.409s) [76.598311] [025/130] (939s left) kms_flip (basic-flip-vs-modeset) [76.684292] Starting subtest: basic-flip-vs-modeset [76.686599] Starting dynamic subtest: A-eDP1 [79.269371] Dynamic subtest A-eDP1: SUCCESS (2.584s) [79.278281] Starting dynamic subtest: B-eDP1 [81.422917] Dynamic subtest B-eDP1: SUCCESS (2.153s) [81.430211] Starting dynamic subtest: C-eDP1 [83.581283] Dynamic subtest C-eDP1: SUCCESS (2.160s) [83.590087] Starting dynamic subtest: D-eDP1 [85.738482] Dynamic subtest D-eDP1: SUCCESS (2.157s) [85.741015] Subtest basic-flip-vs-modeset: SUCCESS (9.059s) [86.552223] [026/130] (929s left) gem_bad_reloc (negative-reloc-bltcopy) [86.613360] Subtest negative-reloc-bltcopy: SKIP (0.000s) [86.686576] [027/130] (929s left) i915_drm_fdinfo (busy-check-all) [86.721216] Starting subtest: busy-check-all [86.723620] Starting dynamic subtest: rcs0 [86.728274] Dynamic subtest rcs0: SKIP (0.006s) [86.736660] Starting dynamic subtest: bcs0 [86.740973] Dynamic subtest bcs0: SKIP (0.001s) [86.747750] Starting dynamic subtest: vcs0 [86.751919] Dynamic subtest vcs0: SKIP (0.001s) [86.758977] Starting dynamic subtest: vcs1 [86.763156] Dynamic subtest vcs1: SKIP (0.000s) [86.771445] Starting dynamic subtest: vecs0 [86.775898] Dynamic subtest vecs0: SKIP (0.000s) [86.782756] Starting dynamic subtest: ccs0 [86.787224] Dynamic subtest ccs0: SKIP (0.000s) [86.791584] Subtest busy-check-all: SKIP (0.009s) [86.826536] [028/130] (928s left) gem_ccs (block-multicopy-inplace) [86.927567] Starting subtest: block-multicopy-inplace [86.932289] Subtest block-multicopy-inplace: SKIP (0.000s) [87.053764] [029/130] (928s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [87.146160] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [87.148531] Starting dynamic subtest: pipe-A [87.486247] Dynamic subtest pipe-A: SUCCESS (0.340s) [87.493167] Starting dynamic subtest: pipe-B [88.925249] Dynamic subtest pipe-B: SUCCESS (1.438s) [88.934534] Starting dynamic subtest: pipe-C [90.365458] Dynamic subtest pipe-C: SUCCESS (1.440s) [90.375022] Starting dynamic subtest: pipe-D [91.803301] Dynamic subtest pipe-D: SUCCESS (1.437s) [91.805597] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.657s) [92.959657] [030/130] (922s left) gem_exec_reloc (basic-cpu-read-noreloc) [93.036353] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [93.116685] [031/130] (922s left) syncobj_basic (bad-destroy) [93.176840] Starting subtest: bad-destroy [93.178709] Subtest bad-destroy: SUCCESS (0.000s) [93.292925] [032/130] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [93.403953] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [97.076775] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.676s) [98.287774] [033/130] (917s left) i915_pm_freq_api (freq-reset) [98.354527] Starting subtest: freq-reset [98.356981] Starting dynamic subtest: gt0 [98.531057] Dynamic subtest gt0: SUCCESS (0.174s) [98.539676] Starting dynamic subtest: gt1 [98.680353] Dynamic subtest gt1: SUCCESS (0.146s) [98.682991] Subtest freq-reset: SUCCESS (0.321s) [98.762679] [034/130] (917s left) i915_pm_rps (fence-order) [98.829297] Starting subtest: fence-order [101.713767] Subtest fence-order: SUCCESS (2.883s) [101.796837] [035/130] (914s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [101.852791] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [101.855204] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [101.987711] [036/130] (914s left) gem_readwrite (beyond-eob) [102.041290] Subtest beyond-EOB: SKIP (0.000s) [102.101194] [037/130] (914s left) gem_media_vme [102.244948] [038/130] (913s left) gem_exec_reloc (basic-wc-gtt-active) [102.306940] Subtest basic-wc-gtt-active: SKIP (0.000s) [102.388749] [039/130] (913s left) gem_mmap_wc (read) [102.446231] Subtest read: SKIP (0.000s) [102.513309] [040/130] (913s left) kms_atomic_transition (modeset-transition-nonblocking) [102.618206] Starting subtest: modeset-transition-nonblocking [102.620601] Starting dynamic subtest: 1x-outputs [113.385956] Dynamic subtest 1x-outputs: SUCCESS (10.768s) [113.655056] Subtest modeset-transition-nonblocking: SUCCESS (11.039s) [114.523727] [041/130] (901s left) gem_ctx_shared (q-out-order) [114.579394] Starting subtest: Q-out-order [114.581710] Starting dynamic subtest: rcs0 [114.677702] Dynamic subtest rcs0: SUCCESS (0.097s) [114.693987] Starting dynamic subtest: vcs0 [114.758305] Dynamic subtest vcs0: SUCCESS (0.081s) [114.774098] Starting dynamic subtest: vcs1 [114.833307] Dynamic subtest vcs1: SUCCESS (0.075s) [114.848176] Starting dynamic subtest: vecs0 [114.905905] Dynamic subtest vecs0: SUCCESS (0.072s) [114.921853] Starting dynamic subtest: ccs0 [114.983429] Dynamic subtest ccs0: SUCCESS (0.077s) [114.985881] Subtest Q-out-order: SUCCESS (0.404s) [116.027122] [042/130] (900s left) kms_flip (2x-flip-vs-panning-interruptible) [116.124345] Starting subtest: 2x-flip-vs-panning-interruptible [116.136327] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [116.221166] [043/130] (900s left) gem_exec_fence (syncobj-timeline-repeat) [116.752842] Starting subtest: syncobj-timeline-repeat [116.990945] Subtest syncobj-timeline-repeat: SUCCESS (0.238s) [118.019836] [044/130] (898s left) gem_pxp (create-regular-buffer) [118.139887] Starting subtest: create-regular-buffer [118.144248] Subtest create-regular-buffer: SUCCESS (0.000s) [118.256594] [045/130] (898s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [123.304734] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [123.309210] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [124.165983] [046/130] (892s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [129.108980] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [129.111449] Starting dynamic subtest: pipe-A-eDP-1 [129.918114] Dynamic subtest pipe-A-eDP-1: SKIP (0.806s) [129.928810] Starting dynamic subtest: pipe-B-eDP-1 [131.053700] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s) [131.058395] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.943s) [132.265263] [047/130] (884s left) kms_hdr (brightness-with-hdr) [132.358309] Starting subtest: brightness-with-hdr [132.364795] Subtest brightness-with-hdr: SKIP (0.000s) [132.453313] [048/130] (884s left) kms_getfb (getfb-handle-closed) [132.553360] Starting subtest: getfb-handle-closed [132.555322] Subtest getfb-handle-closed: SUCCESS (0.000s) [132.668755] [049/130] (883s left) gem_close_race (basic-threads) [132.728953] Starting subtest: basic-threads [134.134867] Subtest basic-threads: SUCCESS (1.406s) [134.335271] [050/130] (882s left) kms_vrr (flipline) [134.434108] Starting subtest: flipline [134.440724] Subtest flipline: SKIP (0.000s) [134.516052] [051/130] (882s left) kms_plane_multiple (2x-tiling-none) [134.609232] Starting subtest: 2x-tiling-none [134.613563] Subtest 2x-tiling-none: SKIP (0.000s) [134.705997] [052/130] (882s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [134.800715] Starting subtest: fbc-1p-pri-indfb-multidraw [147.902102] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.105s) [149.073155] [053/130] (867s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [149.185377] Starting subtest: cursorB-vs-flipB-atomic-transitions [149.189733] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [149.343869] [054/130] (867s left) gem_mmap_wc (coherency) [149.401262] Subtest coherency: SKIP (0.000s) [149.473496] [055/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [149.568248] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [149.572203] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [149.682708] [056/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [149.773366] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [149.777389] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [149.874361] [057/130] (867s left) gem_exec_fence (invalid-fence-array) [150.305574] Starting subtest: invalid-fence-array [150.308073] Subtest invalid-fence-array: SUCCESS (0.002s) [151.973650] [058/130] (865s left) api_intel_bb (destroy-bb) [152.032605] Starting subtest: destroy-bb [152.040527] Subtest destroy-bb: SUCCESS (0.009s) [152.188780] [059/130] (864s left) kms_cursor_crc (cursor-rapid-movement-256x256) [152.420680] Starting subtest: cursor-rapid-movement-256x256 [152.425370] Starting dynamic subtest: pipe-A-eDP-1 [152.977812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [153.004599] Starting dynamic subtest: pipe-D-eDP-1 [154.178722] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.179s) [154.180776] Subtest cursor-rapid-movement-256x256: SUCCESS (1.755s) [155.033999] [060/130] (862s left) kms_big_fb (y-tiled-16bpp-rotate-0) [155.141403] Starting subtest: y-tiled-16bpp-rotate-0 [155.145309] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [155.265796] [061/130] (861s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [155.363338] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [155.365725] Starting dynamic subtest: A-eDP1 [164.265960] Dynamic subtest A-eDP1: SUCCESS (8.902s) [164.279397] Starting dynamic subtest: B-eDP1 [173.195603] Dynamic subtest B-eDP1: SUCCESS (8.927s) [173.204125] Starting dynamic subtest: C-eDP1 [182.161366] Dynamic subtest C-eDP1: SUCCESS (8.918s) [182.171249] Starting dynamic subtest: D-eDP1 [191.000545] Dynamic subtest D-eDP1: SUCCESS (8.837s) [191.002942] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.593s) [192.212930] [062/130] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [192.308608] Starting subtest: fbcpsr-rgb101010-draw-blt [199.038043] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.731s) [199.194359] [063/130] (818s left) kms_psr (pr-cursor-plane-move) [199.290075] Starting subtest: pr-cursor-plane-move [199.294396] Subtest pr-cursor-plane-move: SKIP (0.000s) [199.371976] [064/130] (817s left) gem_exec_schedule (out-order) [199.450492] Starting subtest: out-order [199.452674] Starting dynamic subtest: rcs0 [199.540950] Dynamic subtest rcs0: SUCCESS (0.099s) [199.552738] Starting dynamic subtest: vcs0 [199.621117] Dynamic subtest vcs0: SUCCESS (0.080s) [199.631629] Starting dynamic subtest: vcs1 [199.703062] Dynamic subtest vcs1: SUCCESS (0.081s) [199.711680] Starting dynamic subtest: vecs0 [199.781041] Dynamic subtest vecs0: SUCCESS (0.077s) [199.791499] Starting dynamic subtest: ccs0 [199.863133] Dynamic subtest ccs0: SUCCESS (0.081s) [199.865623] Subtest out-order: SUCCESS (0.422s) [201.030139] [065/130] (816s left) kms_plane_scaling (2x-scaler-multi-pipe) [201.125834] Starting subtest: 2x-scaler-multi-pipe [201.130441] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [201.264333] [066/130] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [201.374791] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [204.955473] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.585s) [206.139061] [067/130] (811s left) kms_fb_coherency (memset-crc) [206.235389] Starting subtest: memset-crc [206.237365] Starting dynamic subtest: mmap-offset-wc [206.611242] Dynamic subtest mmap-offset-wc: SUCCESS (0.378s) [206.917823] Starting dynamic subtest: mmap-offset-uc [212.940804] Dynamic subtest mmap-offset-uc: SUCCESS (6.033s) [213.233979] Subtest memset-crc: SUCCESS (6.997s) [214.110766] [068/130] (803s left) kms_chamelium_audio (dp-audio) [214.505073] Subtest dp-audio: SKIP (0.000s) [215.290634] [069/130] (802s left) gem_ctx_isolation (clean) [215.353726] Starting subtest: clean [215.356100] Starting dynamic subtest: rcs0 [215.404563] Dynamic subtest rcs0: SUCCESS (0.051s) [215.413015] Starting dynamic subtest: bcs0 [215.476451] Dynamic subtest bcs0: SUCCESS (0.071s) [215.485155] Starting dynamic subtest: vcs0 [215.562246] Dynamic subtest vcs0: SUCCESS (0.085s) [215.570816] Starting dynamic subtest: vcs1 [216.943679] Dynamic subtest vcs1: SUCCESS (1.381s) [216.952357] Starting dynamic subtest: vecs0 [218.957792] Dynamic subtest vecs0: SUCCESS (2.013s) [218.966544] Starting dynamic subtest: ccs0 [220.894916] Dynamic subtest ccs0: SUCCESS (1.937s) [220.897403] Subtest clean: SUCCESS (5.541s) [221.149507] [070/130] (796s left) kms_invalid_mode (bad-hsync-start) [221.256687] Starting subtest: bad-hsync-start [221.259100] Starting dynamic subtest: pipe-A-eDP-1 [221.539808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [221.549556] Starting dynamic subtest: pipe-B-eDP-1 [221.551641] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [221.559470] Starting dynamic subtest: pipe-C-eDP-1 [221.561929] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [221.570633] Starting dynamic subtest: pipe-D-eDP-1 [221.573083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [221.575474] Subtest bad-hsync-start: SUCCESS (0.288s) [222.364348] [071/130] (795s left) syncobj_timeline (etime-multi-wait-submitted) [222.424925] Starting subtest: etime-multi-wait-submitted [222.528028] Subtest etime-multi-wait-submitted: SUCCESS (0.103s) [222.631479] [072/130] (794s left) gem_ctx_persistence (legacy-engines-hostile) [222.696415] Starting subtest: legacy-engines-hostile [222.698709] Starting dynamic subtest: render [222.822786] Dynamic subtest render: SUCCESS (0.126s) [222.832634] Starting dynamic subtest: bsd1 [222.942038] Dynamic subtest bsd1: SUCCESS (0.116s) [222.954232] Starting dynamic subtest: bsd2 [223.066360] Dynamic subtest bsd2: SUCCESS (0.122s) [223.078219] Starting dynamic subtest: blt [223.187526] Dynamic subtest blt: SUCCESS (0.120s) [223.197604] Starting dynamic subtest: vebox [223.265671] Dynamic subtest vebox: SUCCESS (0.077s) [223.268082] Subtest legacy-engines-hostile: SUCCESS (0.570s) [223.418339] [073/130] (794s left) kms_psr (psr-primary-render) [223.527105] Starting subtest: psr-primary-render [223.529417] Starting dynamic subtest: eDP-1 [225.235471] Dynamic subtest eDP-1: SUCCESS (1.709s) [225.237950] Subtest psr-primary-render: SUCCESS (1.709s) [226.104611] [074/130] (791s left) gem_mmap_gtt (big-copy-xy) [226.165052] Subtest big-copy-XY: SKIP (0.000s) [226.229190] [075/130] (791s left) syncobj_basic (test-valid-cycle) [226.284765] Starting subtest: test-valid-cycle [226.286988] Subtest test-valid-cycle: SUCCESS (0.000s) [226.398530] [076/130] (791s left) kms_plane_alpha_blend (constant-alpha-max) [226.494096] Starting subtest: constant-alpha-max [226.782426] Starting dynamic subtest: pipe-A-eDP-1 [227.739747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.957s) [227.749792] Starting dynamic subtest: pipe-D-eDP-1 [229.316547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.575s) [229.318546] Subtest constant-alpha-max: SUCCESS (2.824s) [230.189811] [077/130] (787s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [230.289084] Starting subtest: fbc-psr2-sprite-mmap-cpu [230.291198] Starting dynamic subtest: eDP-1 [230.295211] Dynamic subtest eDP-1: SKIP (0.000s) [230.299171] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [230.384734] [078/130] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [230.482664] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [237.078794] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.598s) [237.250666] [079/130] (780s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [237.346197] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [237.348452] Starting dynamic subtest: pipe-A [237.357264] Dynamic subtest pipe-A: SKIP (0.005s) [237.366705] Starting dynamic subtest: pipe-B [237.375589] Dynamic subtest pipe-B: SKIP (0.018s) [237.384265] Starting dynamic subtest: pipe-C [237.393344] Dynamic subtest pipe-C: SKIP (0.019s) [237.401739] Starting dynamic subtest: pipe-D [237.411677] Dynamic subtest pipe-D: SKIP (0.019s) [237.416279] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.063s) [237.539608] [080/130] (780s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [242.610655] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [242.613079] Starting dynamic subtest: pipe-A-eDP-1 [249.602665] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.991s) [249.612556] Starting dynamic subtest: pipe-B-eDP-1 [256.789261] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.184s) [256.791517] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.180s) [257.642500] [081/130] (760s left) syncobj_timeline (multi-wait-all-signaled) [257.703746] Starting subtest: multi-wait-all-signaled [257.706201] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [257.824492] [082/130] (760s left) kms_atomic (plane-invalid-params) [257.910203] Starting subtest: plane-invalid-params [257.912491] Starting dynamic subtest: pipe-A-eDP-1 [258.300728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s) [258.303080] Subtest plane-invalid-params: SUCCESS (0.390s) [259.161592] [083/130] (758s left) sriov_basic (bind-unbind-vf) [259.220239] Starting subtest: bind-unbind-vf [259.222719] Starting dynamic subtest: vf-1 [259.296731] Dynamic subtest vf-1: FAIL (0.006s) [259.307075] Starting dynamic subtest: vf-2 [259.382074] Dynamic subtest vf-2: FAIL (0.006s) [259.391830] Starting dynamic subtest: vf-3 [259.465622] Dynamic subtest vf-3: FAIL (0.003s) [259.476080] Starting dynamic subtest: vf-4 [259.549046] Dynamic subtest vf-4: FAIL (0.003s) [259.559129] Starting dynamic subtest: vf-5 [259.632539] Dynamic subtest vf-5: FAIL (0.003s) [259.641228] Starting dynamic subtest: vf-6 [259.715102] Dynamic subtest vf-6: FAIL (0.003s) [259.725637] Starting dynamic subtest: vf-7 [259.797121] Dynamic subtest vf-7: FAIL (0.003s) [259.806099] Starting dynamic subtest: vf-random [259.877220] Dynamic subtest vf-random: FAIL (0.004s) [259.886847] Starting dynamic subtest: vf-last [259.959747] Dynamic subtest vf-last: FAIL (0.515s) [259.962037] Subtest bind-unbind-vf: FAIL (0.554s) [260.000424] [084/130] (758s left) gem_exec_reloc (basic-cpu-read) [260.059236] Subtest basic-cpu-read: SKIP (0.000s) [260.136756] [085/130] (757s left) gem_render_copy (yf-tiled) [260.196840] Starting subtest: yf-tiled [260.200743] Subtest yf-tiled: SKIP (0.000s) [260.389735] [086/130] (757s left) kms_cursor_crc (cursor-random-256x256) [260.633904] Starting subtest: cursor-random-256x256 [260.638940] Starting dynamic subtest: pipe-A-eDP-1 [263.979949] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s) [264.009486] Starting dynamic subtest: pipe-D-eDP-1 [267.952913] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.951s) [267.955631] Subtest cursor-random-256x256: SUCCESS (7.318s) [268.843884] [087/130] (749s left) gem_mmap_gtt (basic-small-copy-xy) [268.891962] Subtest basic-small-copy-XY: SKIP (0.000s) [268.947766] [088/130] (749s left) kms_cursor_edge_walk (64x64-top-bottom) [269.047213] Starting subtest: 64x64-top-bottom [269.049488] Starting dynamic subtest: pipe-A-eDP-1 [272.489082] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s) [272.498619] Starting dynamic subtest: pipe-D-eDP-1 [275.620411] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s) [275.622632] Subtest 64x64-top-bottom: SUCCESS (6.573s) [276.437449] [089/130] (741s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [276.526754] Starting subtest: fbcpsr-stridechange [282.650381] Subtest fbcpsr-stridechange: SUCCESS (6.126s) [282.811222] [090/130] (735s left) kms_big_fb (x-tiled-64bpp-rotate-180) [282.911700] Starting subtest: x-tiled-64bpp-rotate-180 [284.550408] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.639s) [284.741726] [091/130] (733s left) kms_selftest (drm_dp_mst_helper) [284.778106] Starting subtest: drm_dp_mst_helper [284.812402] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [284.942636] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.130s) [284.951310] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [285.100526] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.157s) [285.110135] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [285.259100] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.157s) [285.261380] Subtest drm_dp_mst_helper: SUCCESS (0.481s) [285.484151] [092/130] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [285.580656] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [292.794153] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.216s) [292.927474] [093/130] (725s left) prime_vgem (basic-gtt) [293.013773] Starting subtest: basic-gtt [293.018495] Subtest basic-gtt: SKIP (0.000s) [293.154611] [094/130] (725s left) kms_rotation_crc (primary-rotation-180) [293.250968] Starting subtest: primary-rotation-180 [300.258898] Subtest primary-rotation-180: SUCCESS (7.009s) [301.519164] [095/130] (716s left) kms_vblank (ts-continuation-modeset) [301.612544] Starting subtest: ts-continuation-modeset [301.614452] Starting dynamic subtest: pipe-A-eDP-1 [303.074058] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.462s) [303.088275] Starting dynamic subtest: pipe-D-eDP-1 [305.246394] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s) [305.248653] Subtest ts-continuation-modeset: SUCCESS (3.634s) [306.058948] [096/130] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [306.164633] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [306.168788] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [306.289460] [097/130] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [306.396141] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [306.400640] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [306.528092] [098/130] (712s left) kms_addfb_basic (addfb25-4-tiled) [306.622450] Starting subtest: addfb25-4-tiled [306.624371] Subtest addfb25-4-tiled: SUCCESS (0.001s) [306.739165] [099/130] (711s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [306.840916] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [306.845383] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [306.975604] [100/130] (711s left) kms_psr (pr-sprite-render) [307.070548] Starting subtest: pr-sprite-render [307.074190] Subtest pr-sprite-render: SKIP (0.000s) [307.153735] [101/130] (711s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [307.210554] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [307.275898] [102/130] (711s left) dmabuf_sync_file (import-basic) [307.312132] Starting subtest: import-basic [307.313769] Subtest import-basic: SUCCESS (0.002s) [307.375502] [103/130] (711s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [307.456574] Starting subtest: plane-all-transition-nonblocking-fencing [307.458460] Starting dynamic subtest: pipe-A-eDP-1 [309.957081] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s) [310.274576] Starting dynamic subtest: pipe-B-eDP-1 [313.485242] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s) [313.791487] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.333s) [314.626946] [104/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [314.731897] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [336.781877] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.054s) [336.977832] [105/130] (681s left) gem_exec_balancer (full-pulse) [337.051925] Starting subtest: full-pulse [341.752114] Subtest full-pulse: SUCCESS (4.699s) [342.061234] [106/130] (676s left) gem_mmap_offset (mmap-boundaries) [342.122973] Starting subtest: mmap-boundaries [342.125210] Starting dynamic subtest: smem0 [342.408117] Dynamic subtest smem0: SUCCESS (0.284s) [342.410791] Subtest mmap-boundaries: SUCCESS (0.285s) [342.571146] [107/130] (676s left) gem_madvise (dontneed-after-mmap) [342.606064] Starting subtest: dontneed-after-mmap [342.634067] Subtest dontneed-after-mmap: SUCCESS (0.028s) [342.779529] [108/130] (676s left) gem_exec_whisper (basic-fds) [342.834971] Starting subtest: basic-fds [350.901996] Subtest basic-fds: SUCCESS (8.063s) [351.108536] [109/130] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [351.208502] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [351.212532] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [351.325064] [110/130] (667s left) i915_drm_fdinfo (memory-info-idle) [351.365825] Starting subtest: memory-info-idle [351.368291] Starting dynamic subtest: smem0 [351.435355] Dynamic subtest smem0: SUCCESS (0.071s) [351.438032] Subtest memory-info-idle: SUCCESS (0.072s) [351.526928] [111/130] (667s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [351.631207] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [351.635157] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [351.770968] [112/130] (667s left) gem_sync (basic-each) [351.846755] Starting subtest: basic-each [354.100751] Subtest basic-each: SUCCESS (2.264s) [354.309369] [113/130] (664s left) kms_psr (fbc-pr-primary-page-flip) [354.401289] Starting subtest: fbc-pr-primary-page-flip [354.405707] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [354.499430] [114/130] (664s left) gem_exec_schedule (promotion) [354.575774] Starting subtest: promotion [354.577622] Starting dynamic subtest: rcs0 [354.668491] Dynamic subtest rcs0: SUCCESS (0.096s) [354.681047] Starting dynamic subtest: vcs0 [354.746567] Dynamic subtest vcs0: SUCCESS (0.079s) [354.757942] Starting dynamic subtest: vcs1 [354.828574] Dynamic subtest vcs1: SUCCESS (0.081s) [354.839790] Starting dynamic subtest: vecs0 [354.912464] Dynamic subtest vecs0: SUCCESS (0.082s) [354.923759] Starting dynamic subtest: ccs0 [354.997228] Dynamic subtest ccs0: SUCCESS (0.085s) [354.999435] Subtest promotion: SUCCESS (0.427s) [356.038678] [115/130] (663s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [356.146371] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [357.125094] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.978s) [357.291121] [116/130] (662s left) gem_userptr_blits (invalid-null-pointer) [357.360581] Starting subtest: invalid-null-pointer [357.362121] Subtest invalid-null-pointer: SUCCESS (0.001s) [357.532591] [117/130] (661s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [357.629807] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [357.631657] Starting dynamic subtest: pipe-A-default-mode [358.803637] Dynamic subtest pipe-A-default-mode: SKIP (1.168s) [358.808764] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.171s) [358.957865] [118/130] (660s left) gem_wait (wait) [359.028019] Starting subtest: wait [359.030483] Starting dynamic subtest: all-engines [360.916975] Dynamic subtest all-engines: SUCCESS (1.886s) [360.928974] Starting dynamic subtest: rcs0 [361.964373] Dynamic subtest rcs0: SUCCESS (1.047s) [361.979701] Starting dynamic subtest: bcs0 [363.011245] Dynamic subtest bcs0: SUCCESS (1.046s) [363.025479] Starting dynamic subtest: vcs0 [364.054295] Dynamic subtest vcs0: SUCCESS (1.042s) [364.065996] Starting dynamic subtest: vcs1 [365.101452] Dynamic subtest vcs1: SUCCESS (1.045s) [365.112965] Starting dynamic subtest: vecs0 [366.147804] Dynamic subtest vecs0: SUCCESS (1.044s) [366.158812] Starting dynamic subtest: ccs0 [367.196456] Dynamic subtest ccs0: SUCCESS (1.047s) [367.199074] Subtest wait: SUCCESS (8.169s) [367.409338] [119/130] (652s left) kms_big_fb (x-tiled-64bpp-rotate-90) [367.507151] Starting subtest: x-tiled-64bpp-rotate-90 [367.526435] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [367.678791] [120/130] (651s left) gem_softpin (full) [367.742789] Starting subtest: full [367.751320] Subtest full: SUCCESS (0.009s) [367.932580] [121/130] (651s left) kms_color (ctm-0-50) [368.026069] Starting subtest: ctm-0-50 [368.028312] Starting dynamic subtest: pipe-A-eDP-1 [371.354329] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.325s) [371.369210] Starting dynamic subtest: pipe-B-eDP-1 [375.476768] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.124s) [375.487303] Starting dynamic subtest: pipe-C-eDP-1 [379.430354] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.951s) [379.439388] Starting dynamic subtest: pipe-D-eDP-1 [383.434833] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.005s) [383.437256] Subtest ctm-0-50: SUCCESS (15.407s) [384.288640] [122/130] (635s left) vgem_basic (sysfs) [384.339851] Starting subtest: sysfs [384.341781] Subtest sysfs: SUCCESS (0.000s) [384.408827] [123/130] (635s left) core_getversion (basic) [384.444796] Starting subtest: basic [384.449792] Subtest basic: SUCCESS (0.000s) [384.532470] [124/130] (635s left) gem_eio (in-flight-internal-10ms) [384.746584] Starting subtest: in-flight-internal-10ms [385.995655] Subtest in-flight-internal-10ms: SUCCESS (1.250s) [386.147411] [125/130] (633s left) gem_spin_batch (legacy-resubmit) [386.203812] Starting subtest: legacy-resubmit [386.206054] Starting dynamic subtest: default [386.210408] Dynamic subtest default: SUCCESS (0.005s) [386.219661] Starting dynamic subtest: render [386.222188] Dynamic subtest render: SUCCESS (0.001s) [386.233407] Starting dynamic subtest: bsd [386.235311] Dynamic subtest bsd: SUCCESS (0.002s) [386.243545] Starting dynamic subtest: bsd1 [386.245465] Dynamic subtest bsd1: SUCCESS (0.002s) [386.253782] Starting dynamic subtest: bsd2 [386.255688] Dynamic subtest bsd2: SUCCESS (0.001s) [386.264168] Starting dynamic subtest: blt [386.266171] Dynamic subtest blt: SUCCESS (0.002s) [386.276837] Starting dynamic subtest: vebox [386.278952] Dynamic subtest vebox: SUCCESS (0.002s) [386.281056] Subtest legacy-resubmit: SUCCESS (0.020s) [386.481617] [126/130] (633s left) kms_chamelium_frames (dp-crc-multiple) [386.852732] Subtest dp-crc-multiple: SKIP (0.000s) [387.675319] [127/130] (632s left) perf_pmu (pmu-read) [387.715293] Starting subtest: pmu-read [387.717669] Subtest pmu-read: SUCCESS (0.003s) [387.827829] [128/130] (631s left) kms_rotation_crc (cursor-rotation-180) [387.926884] Starting subtest: cursor-rotation-180 [389.471061] Subtest cursor-rotation-180: SUCCESS (1.544s) [390.682312] [129/130] (629s left) perf_pmu (busy-hang) [390.722041] Starting subtest: busy-hang [390.724521] Starting dynamic subtest: rcs0 [391.991857] Dynamic subtest rcs0: SUCCESS (1.268s) [392.003390] Starting dynamic subtest: bcs0 [393.200420] Dynamic subtest bcs0: SUCCESS (1.210s) [393.210860] Starting dynamic subtest: vcs0 [395.422073] Dynamic subtest vcs0: SUCCESS (2.216s) [395.432370] Starting dynamic subtest: vcs1 [397.407137] Dynamic subtest vcs1: SUCCESS (1.986s) [397.418633] Starting dynamic subtest: vecs0 [399.448790] Dynamic subtest vecs0: SUCCESS (2.036s) [399.459861] Starting dynamic subtest: ccs0 [400.660064] Dynamic subtest ccs0: SUCCESS (1.213s) [400.662639] Subtest busy-hang: SUCCESS (9.940s) [400.803556] [130/130] (619s left) gem_exec_schedule (u-lateslice) [400.877402] Starting subtest: u-lateslice [400.879308] Starting dynamic subtest: rcs0 [400.895220] Dynamic subtest rcs0: SUCCESS (0.027s) [400.904650] Starting dynamic subtest: bcs0 [400.918102] Dynamic subtest bcs0: SUCCESS (0.022s) [400.927538] Starting dynamic subtest: vcs0 [400.941881] Dynamic subtest vcs0: SUCCESS (0.023s) [400.952502] Starting dynamic subtest: vcs1 [400.967500] Dynamic subtest vcs1: SUCCESS (0.025s) [400.976263] Starting dynamic subtest: vecs0 [400.988704] Dynamic subtest vecs0: SUCCESS (0.021s) [401.002542] Starting dynamic subtest: ccs0 [401.014930] Dynamic subtest ccs0: SUCCESS (0.026s) [401.017104] Subtest u-lateslice: SUCCESS (0.147s) [403.024754] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pm_dc results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_exec_balancer results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: syncobj_eventfd results: parsing output: 6/ for test: prime_vgem results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: perf results: parsing output: 11/ for test: kms_atomic_transition results: parsing output: 12/ for test: kms_content_protection results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: kms_chamelium_hpd results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_mmap_offset results: parsing output: 20/ for test: kms_lease results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_partial_pwrite_pread results: parsing output: 23/ for test: kms_dither results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: gem_bad_reloc results: parsing output: 26/ for test: i915_drm_fdinfo results: parsing output: 27/ for test: gem_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: gem_exec_reloc results: parsing output: 30/ for test: syncobj_basic results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: i915_pm_freq_api results: parsing output: 33/ for test: i915_pm_rps results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: gem_readwrite results: parsing output: 36/ for test: gem_media_vme results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: gem_mmap_wc results: parsing output: 39/ for test: kms_atomic_transition results: parsing output: 40/ for test: gem_ctx_shared results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: gem_exec_fence results: parsing output: 43/ for test: gem_pxp results: parsing output: 44/ for test: kms_psr2_sf results: parsing output: 45/ for test: kms_psr2_sf results: parsing output: 46/ for test: kms_hdr results: parsing output: 47/ for test: kms_getfb results: parsing output: 48/ for test: gem_close_race results: parsing output: 49/ for test: kms_vrr results: parsing output: 50/ for test: kms_plane_multiple results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_cursor_legacy results: parsing output: 53/ for test: gem_mmap_wc results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: api_intel_bb results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_flip results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: gem_exec_schedule results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_fb_coherency results: parsing output: 67/ for test: kms_chamelium_audio results: parsing output: 68/ for test: gem_ctx_isolation results: parsing output: 69/ for test: kms_invalid_mode results: parsing output: 70/ for test: syncobj_timeline results: parsing output: 71/ for test: gem_ctx_persistence results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: syncobj_basic results: parsing output: 75/ for test: kms_plane_alpha_blend results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_plane_scaling results: parsing output: 79/ for test: kms_psr2_sf results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: kms_atomic results: parsing output: 82/ for test: sriov_basic results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: gem_render_copy results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: gem_mmap_gtt results: parsing output: 87/ for test: kms_cursor_edge_walk results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: kms_selftest results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: prime_vgem results: parsing output: 93/ for test: kms_rotation_crc results: parsing output: 94/ for test: kms_vblank 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_addfb_basic results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_pipe_b_c_ivb results: parsing output: 101/ for test: dmabuf_sync_file results: parsing output: 102/ for test: kms_atomic_transition results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_balancer results: parsing output: 105/ for test: gem_mmap_offset results: parsing output: 106/ for test: gem_madvise results: parsing output: 107/ for test: gem_exec_whisper results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: i915_drm_fdinfo results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_sync results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: gem_exec_schedule results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: gem_userptr_blits results: parsing output: 116/ for test: kms_flip_scaled_crc results: parsing output: 117/ for test: gem_wait results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gem_softpin results: parsing output: 120/ for test: kms_color results: parsing output: 121/ for test: vgem_basic results: parsing output: 122/ for test: core_getversion results: parsing output: 123/ for test: gem_eio results: parsing output: 124/ for test: gem_spin_batch results: parsing output: 125/ for test: kms_chamelium_frames results: parsing output: 126/ for test: perf_pmu results: parsing output: 127/ for test: kms_rotation_crc results: parsing output: 128/ for test: perf_pmu results: parsing output: 129/ for test: gem_exec_schedule Done.