[56.756388] Initializing watchdogs
[56.756435]   /dev/watchdog0
[56.771476] [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.775957] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.778286] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.781560] [001/133] (960s left) kms_cursor_edge_walk (128x128-top-bottom)
[56.910850] Starting subtest: 128x128-top-bottom
[56.913202] Starting dynamic subtest: pipe-A-eDP-1
[60.358795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[60.367697] Starting dynamic subtest: pipe-D-eDP-1
[63.473050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[63.475388] Subtest 128x128-top-bottom: SUCCESS (6.583s)
[64.284780] [002/133] (953s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[64.385424] Starting subtest: plane-lut1d-pre-ctm3x4
[64.570733] Starting dynamic subtest: pipe-A-plane-0
[64.737730] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[64.745743] Starting dynamic subtest: pipe-A-plane-1
[64.903627] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[64.912171] Starting dynamic subtest: pipe-A-plane-2
[65.070119] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[66.319682] Starting dynamic subtest: pipe-B-plane-0
[66.513534] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[66.525469] Starting dynamic subtest: pipe-B-plane-1
[66.680090] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[66.690294] Starting dynamic subtest: pipe-B-plane-2
[66.848930] Dynamic subtest pipe-B-plane-2: SUCCESS (0.167s)
[68.050831] Starting dynamic subtest: pipe-C-plane-0
[68.188340] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[68.198548] Starting dynamic subtest: pipe-C-plane-1
[68.343439] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[68.351047] Starting dynamic subtest: pipe-C-plane-2
[68.488285] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[69.641137] Starting dynamic subtest: pipe-D-plane-0
[69.790250] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[69.799622] Starting dynamic subtest: pipe-D-plane-1
[69.945837] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[69.953352] Starting dynamic subtest: pipe-D-plane-2
[70.089615] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[70.379698] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.999s)
[71.209081] [003/133] (946s left) gem_softpin (allocator-fork)
[71.269242] Starting subtest: allocator-fork
[73.479776] Subtest allocator-fork: SUCCESS (2.210s)
[73.602775] [004/133] (943s left) gem_exec_reloc (basic-wc-cpu-active)
[73.664427] Subtest basic-wc-cpu-active: SKIP (0.000s)
[73.733924] [005/133] (943s left) i915_fb_tiling (basic-x-tiling)
[73.784775] Subtest basic-x-tiling: SKIP (0.000s)
[73.839929] [006/133] (943s left) i915_suspend (basic-s2idle-without-i915)
[73.880458] Starting subtest: basic-s2idle-without-i915
[96.152504] Subtest basic-s2idle-without-i915: SUCCESS (7.024s)
[101.261121] [007/133] (921s left) i915_pm_rpm (system-suspend-devices)
[103.319625] Starting subtest: system-suspend-devices
[110.989954] Subtest system-suspend-devices: SUCCESS (7.754s)
[120.381441] [008/133] (911s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[120.520999] Starting subtest: short-flip-after-cursor-atomic-transitions
[121.510068] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.991s)
[122.359270] [009/133] (909s left) gem_exec_whisper (basic-contexts)
[122.432587] Starting subtest: basic-contexts
[128.172199] Subtest basic-contexts: SUCCESS (5.744s)
[128.365007] [010/133] (903s left) gem_ctx_param (invalid-size-get)
[128.409358] Starting subtest: invalid-size-get
[128.412201] Subtest invalid-size-get: SUCCESS (0.001s)
[128.501089] [011/133] (903s left) kms_big_fb (linear-8bpp-rotate-0)
[128.611110] Starting subtest: linear-8bpp-rotate-0
[129.912992] Subtest linear-8bpp-rotate-0: SUCCESS (1.303s)
[130.031494] [012/133] (901s left) kms_addfb_basic (invalid-get-prop-any)
[130.086058] Starting subtest: invalid-get-prop-any
[130.088519] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[130.259665] [013/133] (901s left) gen9_exec_parse (bb-start-param)
[130.346141] Subtest bb-start-param: SKIP (0.000s)
[130.412390] [014/133] (901s left) kms_chamelium_color (degamma)
[130.509193] Subtest degamma: SKIP (0.000s)
[130.554380] [015/133] (901s left) gem_ctx_persistence (engines-hostile-preempt)
[130.616647] Starting subtest: engines-hostile-preempt
[130.619108] Starting dynamic subtest: rcs0
[130.692105] Dynamic subtest rcs0: SUCCESS (0.076s)
[130.702793] Starting dynamic subtest: bcs0
[130.723088] Dynamic subtest bcs0: SUCCESS (0.030s)
[130.732030] Starting dynamic subtest: vcs0
[132.131156] Dynamic subtest vcs0: SUCCESS (1.407s)
[132.143209] Starting dynamic subtest: vcs1
[134.094205] Dynamic subtest vcs1: SUCCESS (1.964s)
[134.106383] Starting dynamic subtest: vecs0
[136.162842] Dynamic subtest vecs0: SUCCESS (2.070s)
[136.174718] Starting dynamic subtest: ccs0
[136.210183] Dynamic subtest ccs0: SUCCESS (0.048s)
[136.213034] Subtest engines-hostile-preempt: SUCCESS (5.601s)
[136.300679] [016/133] (895s left) kms_joiner (basic-big-joiner)
[136.399064] Starting subtest: basic-big-joiner
[136.403016] Subtest basic-big-joiner: SKIP (0.000s)
[136.462122] [017/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[136.557922] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[137.709637] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.152s)
[137.842262] [018/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[137.945024] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[137.949937] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[138.042508] [019/133] (894s left) kms_async_flips (invalid-async-flip)
[138.145672] Starting subtest: invalid-async-flip
[138.530076] Starting dynamic subtest: pipe-A-eDP-1
[139.344014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[139.704234] Starting dynamic subtest: pipe-B-eDP-1
[140.484136] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[140.847196] Starting dynamic subtest: pipe-C-eDP-1
[141.617761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[141.980856] Starting dynamic subtest: pipe-D-eDP-1
[142.742935] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[142.745842] Subtest invalid-async-flip: SUCCESS (4.605s)
[143.899440] [020/133] (888s left) gem_exec_gttfill (multigpu-basic)
[144.076020] Starting subtest: multigpu-basic
[156.252566] Subtest multigpu-basic: SUCCESS (12.182s)
[156.309075] [021/133] (875s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[156.453894] Starting subtest: fbc-rgb565-draw-mmap-cpu
[160.523023] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.073s)
[161.707011] [022/133] (870s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[161.809961] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[161.814454] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[161.911383] [023/133] (870s left) kms_properties (invalid-properties-legacy)
[162.005770] Starting subtest: invalid-properties-legacy
[162.109201] Subtest invalid-properties-legacy: SUCCESS (0.104s)
[162.180890] [024/133] (870s left) kms_flip (nonexisting-fb-interruptible)
[162.279850] Starting subtest: nonexisting-fb-interruptible
[162.282245] Starting dynamic subtest: A-eDP1
[163.485069] Dynamic subtest A-eDP1: SUCCESS (1.204s)
[163.495708] Starting dynamic subtest: B-eDP1
[164.620995] Dynamic subtest B-eDP1: SUCCESS (1.135s)
[164.631801] Starting dynamic subtest: C-eDP1
[165.762232] Dynamic subtest C-eDP1: SUCCESS (1.140s)
[165.772003] Starting dynamic subtest: D-eDP1
[166.896530] Dynamic subtest D-eDP1: SUCCESS (1.132s)
[166.902523] Subtest nonexisting-fb-interruptible: SUCCESS (4.622s)
[168.074627] [025/133] (864s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[168.172459] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[168.174763] Starting dynamic subtest: pipe-A-eDP-1
[170.377043] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.206s)
[170.387091] Starting dynamic subtest: pipe-B-eDP-1
[172.737853] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.360s)
[172.746786] Starting dynamic subtest: pipe-C-eDP-1
[174.836499] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.096s)
[174.855084] Starting dynamic subtest: pipe-D-eDP-1
[177.006568] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[177.008707] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.838s)
[178.258562] [026/133] (854s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[178.325927] Starting subtest: invalid-bsd2-flag-on-vebox
[178.328714] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[178.410974] [027/133] (853s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[178.480140] Subtest tiled-to-untiled: SKIP (0.000s)
[178.552377] [028/133] (853s left) kms_psr (fbc-psr2-cursor-plane-move)
[178.654955] Starting subtest: fbc-psr2-cursor-plane-move
[178.657673] Starting dynamic subtest: eDP-1
[178.663026] Dynamic subtest eDP-1: SKIP (0.000s)
[178.668212] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[178.739669] [029/133] (853s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[178.841671] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[178.853461] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[178.930099] [030/133] (853s left) syncobj_eventfd (timeline-wait)
[178.988125] Starting subtest: timeline-wait
[178.998908] Subtest timeline-wait: SUCCESS (0.011s)
[179.076364] [031/133] (853s left) prime_self_import (basic-llseek-size)
[179.111745] Starting subtest: basic-llseek-size
[179.127527] Subtest basic-llseek-size: SUCCESS (0.015s)
[179.215414] [032/133] (853s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[179.327467] Starting subtest: y-tiled-8bpp-rotate-90
[179.331351] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[179.407245] [033/133] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[179.506987] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[179.511084] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[179.594969] [034/133] (853s left) gem_exec_reloc (basic-write-read)
[179.659913] Subtest basic-write-read: SKIP (0.000s)
[179.728546] [035/133] (853s left) syncobj_timeline (multi-wait-signaled)
[179.782036] Starting subtest: multi-wait-signaled
[179.784619] Subtest multi-wait-signaled: SUCCESS (0.000s)
[179.875289] [036/133] (852s left) kms_pm_backlight (bad-brightness)
[179.964251] Starting subtest: bad-brightness
[180.016183] Starting dynamic subtest: eDP-1
[180.341825] Dynamic subtest eDP-1: SUCCESS (0.325s)
[180.344371] Subtest bad-brightness: SUCCESS (0.380s)
[181.180942] [037/133] (851s left) kms_properties (colorop-properties-legacy)
[181.275222] Starting subtest: colorop-properties-legacy
[181.278055] Starting dynamic subtest: pipe-A-eDP-1
[181.660349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[181.670220] Starting dynamic subtest: pipe-B-eDP-1
[182.763684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s)
[182.773193] Starting dynamic subtest: pipe-C-eDP-1
[183.803501] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.038s)
[183.814001] Starting dynamic subtest: pipe-D-eDP-1
[184.830921] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.026s)
[184.832993] Subtest colorop-properties-legacy: SUCCESS (3.556s)
[185.632946] [038/133] (847s left) kms_pm_rpm (legacy-planes)
[187.360481] Starting subtest: legacy-planes
[187.363352] Starting dynamic subtest: plane-65
[195.643691] Dynamic subtest plane-65: SUCCESS (8.286s)
[195.656996] Starting dynamic subtest: plane-95
[203.928237] Dynamic subtest plane-95: SUCCESS (8.283s)
[203.939810] Starting dynamic subtest: plane-125
[212.243192] Dynamic subtest plane-125: SUCCESS (8.313s)
[212.255942] Starting dynamic subtest: plane-135
[220.539367] Dynamic subtest plane-135: SUCCESS (8.296s)
[220.542360] Subtest legacy-planes: SUCCESS (33.191s)
[220.927526] [039/133] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[221.028736] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[225.056580] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.034s)
[226.200733] [040/133] (806s left) kms_psr (fbc-psr2-sprite-plane-move)
[226.294949] Starting subtest: fbc-psr2-sprite-plane-move
[226.297793] Starting dynamic subtest: eDP-1
[226.303017] Dynamic subtest eDP-1: SKIP (0.000s)
[226.308424] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[226.379124] [041/133] (806s left) kms_pipe_stress (stress-xrgb8888-untiled)
[226.474651] Starting subtest: stress-xrgb8888-untiled
[232.426636] Subtest stress-xrgb8888-untiled: SUCCESS (5.954s)
[232.475264] [042/133] (800s left) prime_vgem (wait)
[232.618089] Starting subtest: wait
[232.620803] Starting dynamic subtest: rcs0
[232.659487] Dynamic subtest rcs0: SUCCESS (0.045s)
[232.668980] Starting dynamic subtest: bcs0
[232.715889] Dynamic subtest bcs0: SUCCESS (0.055s)
[232.725843] Starting dynamic subtest: vcs0
[232.764770] Dynamic subtest vcs0: SUCCESS (0.048s)
[232.774737] Starting dynamic subtest: vcs1
[232.810149] Dynamic subtest vcs1: SUCCESS (0.045s)
[232.819922] Starting dynamic subtest: vecs0
[232.856871] Dynamic subtest vecs0: SUCCESS (0.046s)
[232.866562] Starting dynamic subtest: ccs0
[232.905881] Dynamic subtest ccs0: SUCCESS (0.048s)
[232.908000] Subtest wait: SUCCESS (0.292s)
[233.025063] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[233.028274] [043/133] (800s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[233.142619] Starting subtest: cursor-vs-flip-atomic
[262.885340] Subtest cursor-vs-flip-atomic: SUCCESS (29.750s)
[263.720756] [044/133] (769s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[263.772484] Starting subtest: single-wait-for-submit-available-submitted
[263.775119] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[263.859899] [045/133] (769s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[263.958220] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[263.960643] Starting dynamic subtest: pipe-A-eDP-1
[264.054238] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[264.065206] Starting dynamic subtest: pipe-B-eDP-1
[265.188199] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[265.193211] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.234s)
[266.385124] [046/133] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[266.479966] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[273.558481] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.086s)
[273.672877] [047/133] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[273.772010] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[273.777113] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[273.854730] [048/133] (759s left) gem_mmap (pf-nonblock)
[273.918857] Subtest pf-nonblock: SKIP (0.000s)
[273.979547] [049/133] (759s left) gem_fence_thrash (bo-write-verify-x)
[274.015768] Starting subtest: bo-write-verify-x
[274.038121] Subtest bo-write-verify-x: SKIP (0.017s)
[274.102640] [050/133] (759s left) gem_mmap (bad-offset)
[274.157796] Subtest bad-offset: SKIP (0.000s)
[274.216589] [051/133] (759s left) i915_drm_fdinfo (busy)
[274.268066] Starting subtest: busy
[274.270451] Starting dynamic subtest: rcs0
[274.285765] Dynamic subtest rcs0: SKIP (0.017s)
[274.296192] Starting dynamic subtest: bcs0
[274.301626] Dynamic subtest bcs0: SKIP (0.008s)
[274.310973] Starting dynamic subtest: vcs0
[274.316111] Dynamic subtest vcs0: SKIP (0.001s)
[274.325988] Starting dynamic subtest: vcs1
[274.331126] Dynamic subtest vcs1: SKIP (0.000s)
[274.340694] Starting dynamic subtest: vecs0
[274.345911] Dynamic subtest vecs0: SKIP (0.000s)
[274.355471] Starting dynamic subtest: ccs0
[274.360664] Dynamic subtest ccs0: SKIP (0.000s)
[274.365782] Subtest busy: SKIP (0.033s)
[274.407768] [052/133] (759s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[274.799951] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[275.622910] [053/133] (757s left) kms_lease (multimaster-lease)
[275.715733] Starting subtest: multimaster-lease
[275.718237] Subtest multimaster-lease: SUCCESS (0.004s)
[275.822082] [054/133] (757s left) kms_pm_backlight (basic-brightness)
[275.916469] Starting subtest: basic-brightness
[275.965011] Starting dynamic subtest: eDP-1
[276.296746] Dynamic subtest eDP-1: SUCCESS (0.332s)
[276.299231] Subtest basic-brightness: SUCCESS (0.384s)
[277.168322] [055/133] (756s left) gem_exec_fence (nb-await)
[277.347144] Starting subtest: nb-await
[277.349965] Starting dynamic subtest: rcs0
[277.420194] Dynamic subtest rcs0: SUCCESS (0.072s)
[277.432889] Starting dynamic subtest: bcs0
[277.479195] Dynamic subtest bcs0: SUCCESS (0.057s)
[277.491827] Starting dynamic subtest: vcs0
[277.539221] Dynamic subtest vcs0: SUCCESS (0.057s)
[277.552073] Starting dynamic subtest: vcs1
[277.601633] Dynamic subtest vcs1: SUCCESS (0.059s)
[277.614185] Starting dynamic subtest: vecs0
[277.660669] Dynamic subtest vecs0: SUCCESS (0.057s)
[277.673134] Starting dynamic subtest: ccs0
[277.721074] Dynamic subtest ccs0: SUCCESS (0.057s)
[277.724192] Subtest nb-await: SUCCESS (0.375s)
[279.230591] [056/133] (754s left) gem_ctx_shared (q-independent)
[279.311155] Starting subtest: Q-independent
[279.314323] Starting dynamic subtest: rcs0
[279.379551] Dynamic subtest rcs0: SUCCESS (0.068s)
[279.391731] Starting dynamic subtest: vcs0
[279.431799] Dynamic subtest vcs0: SUCCESS (0.051s)
[279.442182] Starting dynamic subtest: vcs1
[279.472599] Dynamic subtest vcs1: SUCCESS (0.040s)
[279.482282] Starting dynamic subtest: vecs0
[279.509225] Dynamic subtest vecs0: SUCCESS (0.036s)
[279.520866] Starting dynamic subtest: ccs0
[279.553946] Dynamic subtest ccs0: SUCCESS (0.044s)
[279.556549] Subtest Q-independent: SUCCESS (0.244s)
[281.216055] [057/133] (752s left) kms_scaling_modes (scaling-mode-center)
[281.313003] Starting subtest: scaling-mode-center
[281.315758] Starting dynamic subtest: pipe-A-eDP-1
[281.407554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[281.418284] Starting dynamic subtest: pipe-B-eDP-1
[282.588231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[282.601188] Starting dynamic subtest: pipe-C-eDP-1
[283.707639] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[283.725930] Starting dynamic subtest: pipe-D-eDP-1
[284.830031] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[284.833192] Subtest scaling-mode-center: SUCCESS (3.521s)
[286.009874] [058/133] (747s left) kms_busy (extended-modeset-hang-newfb)
[286.110992] Starting subtest: extended-modeset-hang-newfb
[286.113954] Starting dynamic subtest: pipe-A
[322.879965] Dynamic subtest pipe-A: SUCCESS (36.783s)
[322.891399] Starting dynamic subtest: pipe-D
[343.084728] Dynamic subtest pipe-D: SUCCESS (20.212s)
[343.087569] Subtest extended-modeset-hang-newfb: SUCCESS (56.999s)
[343.886888] [059/133] (689s left) gem_exec_reloc (basic-wc-noreloc)
[343.948841] Subtest basic-wc-noreloc: SKIP (0.000s)
[344.021912] [060/133] (689s left) kms_cursor_legacy (single-move)
[344.150716] Starting subtest: single-move
[344.153112] Starting dynamic subtest: pipe-A
[349.532052] Dynamic subtest pipe-A: SUCCESS (5.381s)
[349.544766] Starting dynamic subtest: pipe-B
[354.912461] Dynamic subtest pipe-B: SUCCESS (5.380s)
[354.924855] Starting dynamic subtest: pipe-C
[360.292829] Dynamic subtest pipe-C: SUCCESS (5.380s)
[360.305852] Starting dynamic subtest: pipe-D
[365.672225] Dynamic subtest pipe-D: SUCCESS (5.379s)
[365.682933] Starting dynamic subtest: all-pipes
[371.083692] Dynamic subtest all-pipes: SUCCESS (5.386s)
[371.087915] Subtest single-move: SUCCESS (26.919s)
[371.207138] [061/133] (662s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[371.316455] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[378.062026] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.751s)
[378.191122] [062/133] (655s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[378.309684] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[382.462603] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.160s)
[383.595781] [063/133] (650s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[383.715192] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[383.720832] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[383.864580] [064/133] (650s left) kms_chamelium_audio (dp-audio)
[384.244098] Subtest dp-audio: SKIP (0.000s)
[385.097493] [065/133] (648s left) kms_addfb_basic (master-rmfb)
[385.146958] Starting subtest: master-rmfb
[385.149586] Subtest master-rmfb: SUCCESS (0.001s)
[385.273849] [066/133] (648s left) gem_exec_reloc (basic-wc-cpu)
[385.340871] Subtest basic-wc-cpu: SKIP (0.000s)
[385.414883] [067/133] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[385.522912] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[385.527665] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[385.619866] [068/133] (648s left) gem_mmap_offset (bad-object)
[385.676616] Starting subtest: bad-object
[385.679051] Subtest bad-object: SUCCESS (0.001s)
[385.787823] [069/133] (648s left) kms_fence_pin_leak
[385.944706] [070/133] (648s left) perf (gen12-unprivileged-single-ctx-counters)
[386.096437] Starting subtest: gen12-unprivileged-single-ctx-counters
[386.098477] Starting dynamic subtest: rcs0
[386.137988] Dynamic subtest rcs0: SUCCESS (0.043s)
[386.140498] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.044s)
[386.194003] [071/133] (648s left) gem_exec_parallel (basic)
[386.248966] Starting subtest: basic
[386.251196] Starting dynamic subtest: rcs0
[388.134453] Dynamic subtest rcs0: SUCCESS (1.885s)
[388.147077] Starting dynamic subtest: bcs0
[389.841121] Dynamic subtest bcs0: SUCCESS (1.706s)
[389.854074] Starting dynamic subtest: vcs0
[393.128954] Dynamic subtest vcs0: SUCCESS (3.285s)
[393.142370] Starting dynamic subtest: vcs1
[395.176250] Dynamic subtest vcs1: SUCCESS (2.045s)
[395.189805] Starting dynamic subtest: vecs0
[397.159674] Dynamic subtest vecs0: SUCCESS (1.982s)
[397.170372] Starting dynamic subtest: ccs0
[398.980545] Dynamic subtest ccs0: SUCCESS (1.820s)
[398.983638] Subtest basic: SUCCESS (12.737s)
[399.171968] [072/133] (635s left) drm_read (empty-block)
[399.318425] Starting subtest: empty-block
[400.320790] Subtest empty-block: SUCCESS (1.001s)
[400.446082] [073/133] (633s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[400.545066] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[400.549884] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.643302] [074/133] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[400.735106] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[400.741488] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[400.822492] [075/133] (633s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[400.904152] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[400.906928] Starting dynamic subtest: pipe-A
[402.200092] Dynamic subtest pipe-A: SUCCESS (1.299s)
[402.210996] Starting dynamic subtest: pipe-B
[404.490738] Dynamic subtest pipe-B: SUCCESS (2.291s)
[404.500940] Starting dynamic subtest: pipe-C
[405.708151] Dynamic subtest pipe-C: SUCCESS (1.216s)
[405.718471] Starting dynamic subtest: pipe-D
[406.953640] Dynamic subtest pipe-D: SUCCESS (1.245s)
[406.956100] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.056s)
[408.147877] [076/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[408.248087] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[408.253141] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[408.351450] [077/133] (626s left) gem_ctx_persistence (legacy-engines-queued)
[408.409821] Starting subtest: legacy-engines-queued
[408.412580] Starting dynamic subtest: render
[408.479095] Dynamic subtest render: SUCCESS (0.070s)
[408.492258] Starting dynamic subtest: bsd1
[410.120369] Dynamic subtest bsd1: SUCCESS (1.638s)
[410.134108] Starting dynamic subtest: bsd2
[412.101831] Dynamic subtest bsd2: SUCCESS (1.979s)
[412.120220] Starting dynamic subtest: blt
[412.136991] Dynamic subtest blt: SUCCESS (0.034s)
[412.147240] Starting dynamic subtest: vebox
[414.151832] Dynamic subtest vebox: SUCCESS (2.012s)
[414.154820] Subtest legacy-engines-queued: SUCCESS (5.746s)
[414.248442] [078/133] (620s left) syncobj_timeline (etime-single-wait-all-submitted)
[414.304199] Starting subtest: etime-single-wait-all-submitted
[414.412267] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[414.506646] [079/133] (620s left) perf_pmu (event-wait)
[414.562900] Starting subtest: event-wait
[414.565815] Starting dynamic subtest: rcs0
[414.571751] Dynamic subtest rcs0: SKIP (0.000s)
[414.577122] Subtest event-wait: SKIP (0.001s)
[414.684943] [080/133] (620s left) kms_addfb_basic (no-handle)
[414.747380] Starting subtest: no-handle
[414.750198] Subtest no-handle: SUCCESS (0.000s)
[414.891636] [081/133] (619s left) gem_lmem_swapping (basic)
[414.944003] Subtest basic: SKIP (0.000s)
[414.995281] [082/133] (619s left) kms_vblank (wait-forked)
[415.085964] Starting subtest: wait-forked
[415.088821] Starting dynamic subtest: pipe-A-eDP-1
[416.898706] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s)
[416.913055] Starting dynamic subtest: pipe-D-eDP-1
[419.450366] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[419.453113] Subtest wait-forked: SUCCESS (4.369s)
[420.315780] [083/133] (614s left) gem_exec_schedule (promotion)
[420.393723] Starting subtest: promotion
[420.396369] Starting dynamic subtest: rcs0
[420.496968] Dynamic subtest rcs0: SUCCESS (0.115s)
[420.510159] Starting dynamic subtest: vcs0
[420.590343] Dynamic subtest vcs0: SUCCESS (0.092s)
[420.603277] Starting dynamic subtest: vcs1
[420.682939] Dynamic subtest vcs1: SUCCESS (0.092s)
[420.694544] Starting dynamic subtest: vecs0
[420.765998] Dynamic subtest vecs0: SUCCESS (0.081s)
[420.778662] Starting dynamic subtest: ccs0
[420.855047] Dynamic subtest ccs0: SUCCESS (0.088s)
[420.857942] Subtest promotion: SUCCESS (0.475s)
[422.271140] [084/133] (612s left) kms_cursor_crc (cursor-offscreen-64x64)
[422.468101] Starting subtest: cursor-offscreen-64x64
[422.473649] Starting dynamic subtest: pipe-A-eDP-1
[424.444794] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.971s)
[424.471251] Starting dynamic subtest: pipe-D-eDP-1
[427.031024] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[427.033467] Subtest cursor-offscreen-64x64: SUCCESS (4.564s)
[427.891598] [085/133] (607s left) syncobj_wait (single-wait-signaled)
[427.948475] Starting subtest: single-wait-signaled
[427.951071] Subtest single-wait-signaled: SUCCESS (0.000s)
[428.043233] [086/133] (606s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[428.133379] Starting subtest: x-tiled-8bpp-rotate-0
[429.359208] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.228s)
[429.471345] [087/133] (605s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[429.577688] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[429.579622] Starting dynamic subtest: pipe-A-eDP-1
[429.587094] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.601510] Starting dynamic subtest: pipe-B-eDP-1
[429.609251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.619617] Starting dynamic subtest: pipe-C-eDP-1
[429.628875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.638791] Starting dynamic subtest: pipe-D-eDP-1
[429.646905] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.650940] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[431.846780] [088/133] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[431.949235] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[436.203854] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.260s)
[437.349767] [089/133] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[437.453057] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[437.457971] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[437.546517] [090/133] (597s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[437.664450] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[448.840512] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.181s)
[449.668305] [091/133] (585s left) gem_close_race (multigpu-basic-threads)
[449.739491] Starting subtest: multigpu-basic-threads
[449.745016] Subtest multigpu-basic-threads: SKIP (0.000s)
[449.966841] [092/133] (585s left) syncobj_wait (single-wait-submitted)
[450.031225] Starting subtest: single-wait-submitted
[450.131374] Subtest single-wait-submitted: SUCCESS (0.102s)
[450.214748] [093/133] (585s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[450.448756] Starting subtest: cursor-rapid-movement-256x256
[450.454987] Starting dynamic subtest: pipe-A-eDP-1
[451.011436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[451.044782] Starting dynamic subtest: pipe-D-eDP-1
[452.198909] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[452.201572] Subtest cursor-rapid-movement-256x256: SUCCESS (1.750s)
[453.046602] [094/133] (582s left) gem_render_copy (yf-tiled-to-vebox-linear)
[453.109726] Starting subtest: yf-tiled-to-vebox-linear
[453.115011] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[453.304791] [095/133] (582s left) dumb_buffer (create-valid-dumb)
[453.365038] Starting subtest: create-valid-dumb
[453.367941] Subtest create-valid-dumb: SUCCESS (0.000s)
[453.464785] [096/133] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[453.576498] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[453.582006] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[453.675815] [097/133] (581s left) sysfs_defaults (readonly)
[453.727986] Starting subtest: readonly
[453.730635] Starting dynamic subtest: vecs0
[453.733213] Dynamic subtest vecs0: SUCCESS (0.000s)
[453.748633] Starting dynamic subtest: ccs0
[453.751134] Dynamic subtest ccs0: SUCCESS (0.000s)
[453.764625] Starting dynamic subtest: vcs0
[453.767119] Dynamic subtest vcs0: SUCCESS (0.000s)
[453.777359] Starting dynamic subtest: bcs0
[453.780118] Dynamic subtest bcs0: SUCCESS (0.000s)
[453.790996] Starting dynamic subtest: rcs0
[453.793187] Dynamic subtest rcs0: SUCCESS (0.000s)
[453.803017] Starting dynamic subtest: vcs1
[453.805377] Dynamic subtest vcs1: SUCCESS (0.000s)
[453.807655] Subtest readonly: SUCCESS (0.006s)
[453.851185] [098/133] (581s left) kms_selftest (drm_damage_helper)
[453.902512] Starting subtest: drm_damage_helper
[453.958404] Starting dynamic subtest: drm_test_damage_iter_no_damage
[454.060448] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.102s)
[454.072433] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[454.154038] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.092s)
[454.165977] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[454.237681] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.083s)
[454.249375] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[454.321682] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.082s)
[454.332223] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[454.411601] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.091s)
[454.423001] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[454.489132] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.075s)
[454.499711] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[454.579216] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.091s)
[454.590878] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[454.662593] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.082s)
[454.674024] Starting dynamic subtest: drm_test_damage_iter_single_damage
[454.743018] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.080s)
[454.752917] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[454.816786] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.073s)
[454.828133] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[454.895965] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.079s)
[454.905897] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[454.982997] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.086s)
[454.993957] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[455.072043] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.088s)
[455.083567] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[455.145880] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.073s)
[455.158011] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[455.231203] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.084s)
[455.247377] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[455.312068] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.079s)
[455.326930] Starting dynamic subtest: drm_test_damage_iter_damage
[455.400967] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.087s)
[455.412085] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[455.492940] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.091s)
[455.504143] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[455.580198] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.087s)
[455.592432] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[455.665154] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.084s)
[455.677182] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[455.758346] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.090s)
[455.760436] Subtest drm_damage_helper: SUCCESS (1.858s)
[455.903748] [099/133] (579s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[455.998420] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[456.000721] Starting dynamic subtest: pipe-A-eDP-1
[456.020691] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.032031] Starting dynamic subtest: pipe-B-eDP-1
[456.053492] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.064218] Starting dynamic subtest: pipe-C-eDP-1
[456.086400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.096104] Starting dynamic subtest: pipe-D-eDP-1
[456.119643] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.123738] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[458.222261] [100/133] (577s left) kms_flip (plain-flip-ts-check-interruptible)
[458.308915] Starting subtest: plain-flip-ts-check-interruptible
[458.311676] Starting dynamic subtest: A-eDP1
[467.124054] Dynamic subtest A-eDP1: SUCCESS (8.819s)
[467.136745] Starting dynamic subtest: B-eDP1
[475.952105] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[475.963380] Starting dynamic subtest: C-eDP1
[484.770479] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[484.781008] Starting dynamic subtest: D-eDP1
[493.602198] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[493.607822] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.316s)
[494.772753] [101/133] (540s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[494.873972] Starting subtest: primary-yf-tiled-reflect-x-0
[494.933722] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[495.042577] [102/133] (540s left) gem_wait (busy)
[495.115755] Starting subtest: busy
[495.118381] Starting dynamic subtest: all-engines
[497.192109] Dynamic subtest all-engines: SUCCESS (2.079s)
[497.205956] Starting dynamic subtest: rcs0
[497.734860] Dynamic subtest rcs0: SUCCESS (0.541s)
[497.748655] Starting dynamic subtest: bcs0
[498.275552] Dynamic subtest bcs0: SUCCESS (0.540s)
[498.288245] Starting dynamic subtest: vcs0
[500.136007] Dynamic subtest vcs0: SUCCESS (1.859s)
[500.149351] Starting dynamic subtest: vcs1
[502.183877] Dynamic subtest vcs1: SUCCESS (2.046s)
[502.197152] Starting dynamic subtest: vecs0
[504.167983] Dynamic subtest vecs0: SUCCESS (1.982s)
[504.181591] Starting dynamic subtest: ccs0
[504.710869] Dynamic subtest ccs0: SUCCESS (0.541s)
[504.713930] Subtest busy: SUCCESS (9.604s)
[504.918630] [103/133] (530s left) gem_exec_flush (basic-uc-prw-default)
[504.986912] Starting subtest: basic-uc-prw-default
[510.456652] Subtest basic-uc-prw-default: SUCCESS (5.473s)
[510.648013] [104/133] (525s left) syncobj_basic (bad-flags-fd-to-handle)
[510.702066] Starting subtest: bad-flags-fd-to-handle
[510.705072] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[510.797121] [105/133] (525s left) gem_exec_schedule (manyslice)
[510.864604] Starting subtest: manyslice
[510.866960] Starting dynamic subtest: rcs0
[518.584888] Dynamic subtest rcs0: SUCCESS (7.735s)
[518.598810] Starting dynamic subtest: bcs0
[525.236480] Dynamic subtest bcs0: SUCCESS (6.652s)
[525.249299] Starting dynamic subtest: vcs0
[530.839186] Dynamic subtest vcs0: SUCCESS (5.604s)
[530.850727] Starting dynamic subtest: vcs1
[537.047514] Dynamic subtest vcs1: SUCCESS (6.099s)
[537.059985] Starting dynamic subtest: vecs0
[543.221295] Dynamic subtest vecs0: SUCCESS (6.089s)
[543.236269] Starting dynamic subtest: ccs0
[549.954897] Dynamic subtest ccs0: SUCCESS (6.692s)
[549.957687] Subtest manyslice: SUCCESS (38.884s)
[550.276583] [106/133] (485s left) api_intel_bb (lot-of-buffers)
[550.334677] Starting subtest: lot-of-buffers
[551.384056] Subtest lot-of-buffers: SUCCESS (1.047s)
[552.246600] [107/133] (483s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[552.294069] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[552.296802] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[552.388340] [108/133] (483s left) vgem_basic (create)
[552.428215] Starting subtest: create
[552.430916] Subtest create: SUCCESS (0.000s)
[552.485845] [109/133] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[552.593105] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[552.598099] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[552.685673] [110/133] (483s left) kms_flip (2x-plain-flip-ts-check)
[552.769119] Starting subtest: 2x-plain-flip-ts-check
[552.781071] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[552.863780] [111/133] (483s left) gem_exec_fence (expired-history)
[553.298493] Starting subtest: expired-history
[560.871002] Subtest expired-history: SUCCESS (7.559s)
[561.409901] [112/133] (474s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[561.522445] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[562.645619] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.124s)
[562.768621] [113/133] (473s left) api_intel_allocator (two-level-inception)
[562.822127] Starting subtest: two-level-inception
[568.224671] Subtest two-level-inception: SUCCESS (5.400s)
[568.343126] [114/133] (467s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[568.451914] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[568.456866] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[568.574488] [115/133] (467s left) kms_plane_multiple (2x-tiling-y)
[568.672339] Starting subtest: 2x-tiling-y
[568.677304] Subtest 2x-tiling-y: SKIP (0.000s)
[568.751403] [116/133] (467s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[568.854950] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[568.857487] Starting dynamic subtest: pipe-A-eDP-1
[568.918817] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[568.930040] Starting dynamic subtest: pipe-B-eDP-1
[568.994643] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[569.006857] Starting dynamic subtest: pipe-C-eDP-1
[569.071841] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[569.083649] Starting dynamic subtest: pipe-D-eDP-1
[569.148304] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[569.153481] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.010s)
[571.075124] [117/133] (465s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[571.186204] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[571.191124] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[571.263285] [118/133] (465s left) syncobj_timeline (invalid-signal-illegal-point)
[571.334205] Starting subtest: invalid-signal-illegal-point
[571.337016] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[571.428933] [119/133] (465s left) gem_pxp (protected-raw-src-copy-not-readible)
[571.547769] Starting subtest: protected-raw-src-copy-not-readible
[571.606629] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.062s)
[571.721079] [120/133] (464s left) kms_psr (fbc-pr-cursor-plane-onoff)
[571.807053] Starting subtest: fbc-pr-cursor-plane-onoff
[571.812016] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[571.880337] [121/133] (464s left) kms_content_protection (atomic-dpms)
[572.021618] Starting subtest: atomic-dpms
[572.025876] Subtest atomic-dpms: SKIP (0.000s)
[572.133726] [122/133] (464s left) kms_plane (pixel-format-linear-modifier)
[572.230998] Starting subtest: pixel-format-linear-modifier
[572.257918] Starting dynamic subtest: pipe-A-plane-0
[576.216528] Dynamic subtest pipe-A-plane-0: SUCCESS (3.955s)
[576.228890] Starting dynamic subtest: pipe-A-plane-3
[578.127546] Dynamic subtest pipe-A-plane-3: SUCCESS (1.910s)
[578.137694] Starting dynamic subtest: pipe-A-plane-5
[578.338092] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[579.454240] Starting dynamic subtest: pipe-B-plane-0
[583.370396] Dynamic subtest pipe-B-plane-0: SUCCESS (3.922s)
[583.380703] Starting dynamic subtest: pipe-B-plane-3
[585.350701] Dynamic subtest pipe-B-plane-3: SUCCESS (1.977s)
[585.361640] Starting dynamic subtest: pipe-B-plane-5
[585.582066] Dynamic subtest pipe-B-plane-5: SUCCESS (0.231s)
[585.902444] Subtest pixel-format-linear-modifier: SUCCESS (13.665s)
[586.743694] [123/133] (449s left) kms_psr (psr2-primary-mmap-gtt)
[586.848042] Starting subtest: psr2-primary-mmap-gtt
[586.850876] Starting dynamic subtest: eDP-1
[588.341867] Dynamic subtest eDP-1: SKIP (1.489s)
[588.346816] Subtest psr2-primary-mmap-gtt: SKIP (1.492s)
[588.478588] [124/133] (448s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[588.568201] Starting subtest: plane-all-modeset-transition-fencing
[588.573762] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[588.640938] [125/133] (448s left) perf (invalid-oa-format-id)
[588.745977] Starting subtest: invalid-oa-format-id
[588.759204] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[588.808648] [126/133] (447s left) gem_workarounds (suspend-resume-fd)
[588.880030] Starting subtest: suspend-resume-fd
[605.801747] Subtest suspend-resume-fd: SUCCESS (2.333s)
[615.965344] [127/133] (430s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[616.099014] Starting subtest: cursorB-vs-flipB-atomic-transitions
[616.103782] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[616.248835] [128/133] (430s left) gem_ccs (ctrl-surf-copy-new-ctx)
[616.307807] Starting subtest: ctrl-surf-copy-new-ctx
[616.312323] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[616.415610] [129/133] (430s left) perf (non-sampling-read-error)
[616.492907] Starting subtest: non-sampling-read-error
[616.502401] Subtest non-sampling-read-error: SUCCESS (0.007s)
[616.543121] [130/133] (430s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[616.641941] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[623.662727] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.109s)
[623.769536] [131/133] (423s left) gem_exec_balancer (hog)
[623.837064] Starting subtest: hog
[623.841520] Subtest hog: SKIP (0.000s)
[624.153015] [132/133] (422s left) kms_psr (pr-sprite-mmap-cpu)
[624.252578] Starting subtest: pr-sprite-mmap-cpu
[624.257106] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[624.327889] [133/133] (422s left) kms_feature_discovery (dp-mst)
[624.410960] Starting subtest: dp-mst
[624.415039] Subtest dp-mst: SKIP (0.000s)
[624.481209] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_color_pipeline
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: i915_fb_tiling
results: parsing output: 5/ for test: i915_suspend
results: parsing output: 6/ for test: i915_pm_rpm
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: gem_ctx_param
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: gem_exec_gttfill
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_properties
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: gem_set_tiling_vs_blt
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: prime_self_import
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_properties
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_pipe_stress
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_mmap
results: parsing output: 48/ for test: gem_fence_thrash
results: parsing output: 49/ for test: gem_mmap
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_pm_backlight
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: kms_scaling_modes
results: parsing output: 57/ for test: kms_busy
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_chamelium_audio
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: kms_fence_pin_leak
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: drm_read
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_close_race
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: sysfs_defaults
results: parsing output: 97/ for test: kms_selftest
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: gem_wait
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: api_intel_allocator
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_atomic_transition
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: gem_workarounds
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_ccs
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_feature_discovery
Done.