[55.183295] Initializing watchdogs [55.183342] /dev/watchdog0 [55.196913] [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] [55.201067] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.203165] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.206293] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [55.334428] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [55.338471] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [55.455896] [002/130] (960s left) kms_pm_dc (dc6-dpms) [56.554281] Starting subtest: dc6-dpms [58.574975] Subtest dc6-dpms: SUCCESS (2.058s) [58.654687] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [58.752243] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [58.756592] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [58.861894] [004/130] (956s left) gem_exec_balancer (invalid-balancer) [58.929407] Starting subtest: invalid-balancer [59.782827] Subtest invalid-balancer: SUCCESS (0.866s) [60.092631] [005/130] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [60.190226] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [60.194505] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.292495] [006/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd) [60.343589] Starting subtest: invalid-illegal-eventfd [60.345783] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [60.451275] [007/130] (955s left) prime_vgem (fence-write-hang) [60.551417] Subtest fence-write-hang: SKIP (0.000s) [60.669023] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [60.672089] [008/130] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [60.765053] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [60.767022] Starting dynamic subtest: pipe-A-eDP-1 [60.930332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.160s) [60.937231] Starting dynamic subtest: pipe-B-eDP-1 [60.957077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [60.964569] Starting dynamic subtest: pipe-C-eDP-1 [60.981086] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [60.987034] Starting dynamic subtest: pipe-D-eDP-1 [61.002188] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [61.004015] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.169s) [63.233393] [009/130] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [63.330775] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [63.335415] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [64.458715] [010/130] (951s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [64.559856] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [64.564422] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [64.659808] [011/130] (951s left) perf (sysctl-defaults) [64.726621] Starting subtest: sysctl-defaults [64.728908] Subtest sysctl-defaults: SUCCESS (0.000s) [64.822970] [012/130] (951s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [64.918022] Starting subtest: plane-use-after-nonblocking-unbind-fencing [64.920290] Starting dynamic subtest: pipe-A-eDP-1 [64.989135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.071s) [65.279834] Starting dynamic subtest: pipe-B-eDP-1 [66.043382] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s) [66.343185] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.433s) [67.223482] [013/130] (948s left) kms_content_protection (dp-mst-type-0) [67.381091] Starting subtest: dp-mst-type-0 [67.385213] Subtest dp-mst-type-0: SKIP (0.000s) [67.523407] [014/130] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [67.620948] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [67.623349] Starting dynamic subtest: pipe-A-eDP-1 [67.644336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [67.653940] Starting dynamic subtest: pipe-B-eDP-1 [67.673290] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [67.679614] Starting dynamic subtest: pipe-C-eDP-1 [67.699287] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [67.705522] Starting dynamic subtest: pipe-D-eDP-1 [67.724772] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [67.726603] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [69.773786] [015/130] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [69.860165] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [69.862470] Starting dynamic subtest: pipe-A-eDP-1 [69.919741] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [69.927991] Starting dynamic subtest: pipe-B-eDP-1 [69.985696] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [69.994111] Starting dynamic subtest: pipe-C-eDP-1 [70.050930] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [70.059656] Starting dynamic subtest: pipe-D-eDP-1 [70.117212] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [70.121274] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s) [72.043553] [016/130] (944s left) gem_exec_reloc (basic-cpu) [72.109940] Subtest basic-cpu: SKIP (0.000s) [72.187162] [017/130] (944s left) kms_chamelium_hpd (dp-hpd-storm-disable) [72.566184] Subtest dp-hpd-storm-disable: SKIP (0.000s) [73.344692] [018/130] (943s left) syncobj_timeline (wait-for-submit-delayed-submit) [73.401996] Starting subtest: wait-for-submit-delayed-submit [73.505696] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [73.607448] [019/130] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.709208] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.713454] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.838232] [020/130] (942s left) gem_mmap_offset (bad-extensions) [73.893844] Starting subtest: bad-extensions [73.895828] Subtest bad-extensions: SUCCESS (0.000s) [73.992599] [021/130] (942s left) kms_lease (atomic-implicit-crtc) [74.080852] Starting subtest: atomic-implicit-crtc [74.083584] Starting dynamic subtest: pipe-A-eDP-1 [74.095061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [74.104419] Starting dynamic subtest: pipe-B-eDP-1 [74.114917] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s) [74.121474] Starting dynamic subtest: pipe-C-eDP-1 [74.131890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [74.138776] Starting dynamic subtest: pipe-D-eDP-1 [74.149399] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [74.151701] Subtest atomic-implicit-crtc: SUCCESS (0.026s) [74.236271] [022/130] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [74.339469] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [74.343981] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [74.464789] [023/130] (942s left) gem_partial_pwrite_pread (write) [74.526739] Subtest write: SKIP (0.000s) [74.601211] [024/130] (941s left) kms_dither (fb-8bpc-vs-panel-8bpc) [74.703495] Starting subtest: fb-8bpc-vs-panel-8bpc [74.705541] Starting dynamic subtest: pipe-A-eDP-1 [76.120353] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.420s) [76.122685] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.421s) [76.927543] [025/130] (939s left) kms_flip (basic-flip-vs-modeset) [77.020239] Starting subtest: basic-flip-vs-modeset [77.022455] Starting dynamic subtest: A-eDP1 [79.618568] Dynamic subtest A-eDP1: SUCCESS (2.603s) [79.628078] Starting dynamic subtest: B-eDP1 [81.786630] Dynamic subtest B-eDP1: SUCCESS (2.168s) [81.794315] Starting dynamic subtest: C-eDP1 [83.954313] Dynamic subtest C-eDP1: SUCCESS (2.169s) [83.963901] Starting dynamic subtest: D-eDP1 [86.120497] Dynamic subtest D-eDP1: SUCCESS (2.165s) [86.122915] Subtest basic-flip-vs-modeset: SUCCESS (9.109s) [86.938858] [026/130] (929s left) gem_bad_reloc (negative-reloc-bltcopy) [87.004951] Subtest negative-reloc-bltcopy: SKIP (0.000s) [87.079338] [027/130] (929s left) i915_drm_fdinfo (busy-check-all) [87.112553] Starting subtest: busy-check-all [87.114901] Starting dynamic subtest: rcs0 [87.119501] Dynamic subtest rcs0: SKIP (0.003s) [87.127503] Starting dynamic subtest: bcs0 [87.132065] Dynamic subtest bcs0: SKIP (0.000s) [87.138905] Starting dynamic subtest: vcs0 [87.143112] Dynamic subtest vcs0: SKIP (0.000s) [87.149436] Starting dynamic subtest: vcs1 [87.153596] Dynamic subtest vcs1: SKIP (0.000s) [87.159987] Starting dynamic subtest: vecs0 [87.164476] Dynamic subtest vecs0: SKIP (0.000s) [87.170802] Starting dynamic subtest: ccs0 [87.174977] Dynamic subtest ccs0: SKIP (0.000s) [87.179096] Subtest busy-check-all: SKIP (0.006s) [87.212513] [028/130] (929s left) gem_ccs (block-multicopy-inplace) [87.302177] Starting subtest: block-multicopy-inplace [87.306596] Subtest block-multicopy-inplace: SKIP (0.000s) [87.427908] [029/130] (929s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [87.517399] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [87.519796] Starting dynamic subtest: pipe-A [87.855618] Dynamic subtest pipe-A: SUCCESS (0.341s) [87.867424] Starting dynamic subtest: pipe-B [89.229086] Dynamic subtest pipe-B: SUCCESS (1.373s) [89.237910] Starting dynamic subtest: pipe-C [90.664671] Dynamic subtest pipe-C: SUCCESS (1.435s) [90.671767] Starting dynamic subtest: pipe-D [92.116278] Dynamic subtest pipe-D: SUCCESS (1.451s) [92.118572] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.601s) [93.271697] [030/130] (923s left) gem_exec_reloc (basic-cpu-read-noreloc) [93.346922] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [93.417765] [031/130] (923s left) syncobj_basic (bad-destroy) [93.473036] Starting subtest: bad-destroy [93.475310] Subtest bad-destroy: SUCCESS (0.000s) [93.591895] [032/130] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [93.697912] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [97.365622] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.673s) [98.589956] [033/130] (918s left) i915_pm_freq_api (freq-reset) [98.649885] Starting subtest: freq-reset [98.652201] Starting dynamic subtest: gt0 [98.823601] Dynamic subtest gt0: SUCCESS (0.171s) [98.830543] Starting dynamic subtest: gt1 [98.968801] Dynamic subtest gt1: SUCCESS (0.145s) [98.971626] Subtest freq-reset: SUCCESS (0.317s) [99.068638] [034/130] (917s left) i915_pm_rps (fence-order) [99.134019] Starting subtest: fence-order [102.082712] Subtest fence-order: SUCCESS (2.946s) [102.165191] [035/130] (914s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [102.214825] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [102.217215] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [102.358777] [036/130] (914s left) gem_readwrite (beyond-eob) [102.421923] Subtest beyond-EOB: SKIP (0.000s) [102.486723] [037/130] (914s left) gem_media_vme [102.634083] [038/130] (914s left) gem_exec_reloc (basic-wc-gtt-active) [102.703371] Subtest basic-wc-gtt-active: SKIP (0.000s) [102.773739] [039/130] (914s left) gem_mmap_wc (read) [102.828032] Subtest read: SKIP (0.000s) [102.884873] [040/130] (914s left) kms_atomic_transition (modeset-transition-nonblocking) [102.975725] Starting subtest: modeset-transition-nonblocking [102.977907] Starting dynamic subtest: 1x-outputs [113.547920] Dynamic subtest 1x-outputs: SUCCESS (10.571s) [113.812667] Subtest modeset-transition-nonblocking: SUCCESS (10.837s) [114.697497] [041/130] (902s left) gem_ctx_shared (q-out-order) [114.767907] Starting subtest: Q-out-order [114.770385] Starting dynamic subtest: rcs0 [114.864341] Dynamic subtest rcs0: SUCCESS (0.096s) [114.880908] Starting dynamic subtest: vcs0 [114.942267] Dynamic subtest vcs0: SUCCESS (0.077s) [114.956123] Starting dynamic subtest: vcs1 [115.019428] Dynamic subtest vcs1: SUCCESS (0.077s) [115.034758] Starting dynamic subtest: vecs0 [115.092276] Dynamic subtest vecs0: SUCCESS (0.073s) [115.106364] Starting dynamic subtest: ccs0 [115.169215] Dynamic subtest ccs0: SUCCESS (0.076s) [115.171738] Subtest Q-out-order: SUCCESS (0.400s) [117.025789] [042/130] (900s left) kms_flip (2x-flip-vs-panning-interruptible) [117.124483] Starting subtest: 2x-flip-vs-panning-interruptible [117.135135] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s) [117.221331] [043/130] (900s left) gem_exec_fence (syncobj-timeline-repeat) [117.742442] Starting subtest: syncobj-timeline-repeat [117.958495] Subtest syncobj-timeline-repeat: SUCCESS (0.217s) [119.002168] [044/130] (898s left) gem_pxp (create-regular-buffer) [119.124631] Starting subtest: create-regular-buffer [119.127208] Subtest create-regular-buffer: SUCCESS (0.000s) [119.256178] [045/130] (898s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [124.243433] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [124.248063] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [125.124933] [046/130] (892s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [130.099276] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [130.101699] Starting dynamic subtest: pipe-A-eDP-1 [130.896925] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s) [130.907482] Starting dynamic subtest: pipe-B-eDP-1 [132.020629] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [132.024954] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.921s) [133.217280] [047/130] (884s left) kms_hdr (brightness-with-hdr) [133.305374] Starting subtest: brightness-with-hdr [133.311669] Subtest brightness-with-hdr: SKIP (0.000s) [133.389529] [048/130] (884s left) kms_getfb (getfb-handle-closed) [133.486936] Starting subtest: getfb-handle-closed [133.489225] Subtest getfb-handle-closed: SUCCESS (0.000s) [133.623865] [049/130] (883s left) gem_close_race (basic-threads) [133.690390] Starting subtest: basic-threads [135.037760] Subtest basic-threads: SUCCESS (1.347s) [135.230192] [050/130] (882s left) kms_vrr (flipline) [135.324088] Starting subtest: flipline [135.330669] Subtest flipline: SKIP (0.000s) [135.405534] [051/130] (882s left) kms_plane_multiple (2x-tiling-none) [135.501204] Starting subtest: 2x-tiling-none [135.505271] Subtest 2x-tiling-none: SKIP (0.000s) [135.582333] [052/130] (882s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [135.681604] Starting subtest: fbc-1p-pri-indfb-multidraw [148.721260] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.044s) [149.923909] [053/130] (867s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [150.044445] Starting subtest: cursorB-vs-flipB-atomic-transitions [150.049077] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [150.211161] [054/130] (867s left) gem_mmap_wc (coherency) [150.263726] Subtest coherency: SKIP (0.000s) [150.327728] [055/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [150.425414] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [150.429700] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [150.545200] [056/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [150.632569] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [150.637087] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [150.761677] [057/130] (867s left) gem_exec_fence (invalid-fence-array) [151.175538] Starting subtest: invalid-fence-array [151.177853] Subtest invalid-fence-array: SUCCESS (0.002s) [153.005264] [058/130] (864s left) api_intel_bb (destroy-bb) [153.060123] Starting subtest: destroy-bb [153.067500] Subtest destroy-bb: SUCCESS (0.008s) [153.220990] [059/130] (864s left) kms_cursor_crc (cursor-rapid-movement-256x256) [153.462252] Starting subtest: cursor-rapid-movement-256x256 [153.464603] Starting dynamic subtest: pipe-A-eDP-1 [154.028857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s) [154.046784] Starting dynamic subtest: pipe-D-eDP-1 [155.213491] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.171s) [155.215763] Subtest cursor-rapid-movement-256x256: SUCCESS (1.749s) [156.103356] [060/130] (861s left) kms_big_fb (y-tiled-16bpp-rotate-0) [156.204393] Starting subtest: y-tiled-16bpp-rotate-0 [156.208886] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [156.313593] [061/130] (861s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [156.411347] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [156.413646] Starting dynamic subtest: A-eDP1 [165.313240] Dynamic subtest A-eDP1: SUCCESS (8.900s) [165.322867] Starting dynamic subtest: B-eDP1 [174.246549] Dynamic subtest B-eDP1: SUCCESS (8.930s) [174.254560] Starting dynamic subtest: C-eDP1 [183.168100] Dynamic subtest C-eDP1: SUCCESS (8.920s) [183.178169] Starting dynamic subtest: D-eDP1 [192.009437] Dynamic subtest D-eDP1: SUCCESS (8.838s) [192.011798] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.596s) [193.236786] [062/130] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [193.341947] Starting subtest: fbcpsr-rgb101010-draw-blt [200.084435] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.745s) [200.267497] [063/130] (817s left) kms_psr (pr-cursor-plane-move) [200.358295] Starting subtest: pr-cursor-plane-move [200.362655] Subtest pr-cursor-plane-move: SKIP (0.000s) [200.454087] [064/130] (817s left) gem_exec_schedule (out-order) [200.519179] Starting subtest: out-order [200.521043] Starting dynamic subtest: rcs0 [200.615313] Dynamic subtest rcs0: SUCCESS (0.102s) [200.626880] Starting dynamic subtest: vcs0 [200.692848] Dynamic subtest vcs0: SUCCESS (0.078s) [200.703600] Starting dynamic subtest: vcs1 [200.772911] Dynamic subtest vcs1: SUCCESS (0.080s) [200.780715] Starting dynamic subtest: vecs0 [200.854529] Dynamic subtest vecs0: SUCCESS (0.081s) [200.868516] Starting dynamic subtest: ccs0 [200.933729] Dynamic subtest ccs0: SUCCESS (0.079s) [200.936223] Subtest out-order: SUCCESS (0.421s) [202.063698] [065/130] (816s left) kms_plane_scaling (2x-scaler-multi-pipe) [202.149752] Starting subtest: 2x-scaler-multi-pipe [202.154472] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [202.275621] [066/130] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [202.373278] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [205.961604] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.592s) [207.174889] [067/130] (811s left) kms_fb_coherency (memset-crc) [207.269986] Starting subtest: memset-crc [207.272305] Starting dynamic subtest: mmap-offset-wc [207.634524] Dynamic subtest mmap-offset-wc: SUCCESS (0.366s) [207.924773] Starting dynamic subtest: mmap-offset-uc [213.946413] Dynamic subtest mmap-offset-uc: SUCCESS (6.029s) [214.230360] Subtest memset-crc: SUCCESS (6.960s) [215.113720] [068/130] (803s left) kms_chamelium_audio (dp-audio) [215.494812] Subtest dp-audio: SKIP (0.000s) [216.297630] [069/130] (802s left) gem_ctx_isolation (clean) [216.362783] Starting subtest: clean [216.365498] Starting dynamic subtest: rcs0 [216.406587] Dynamic subtest rcs0: SUCCESS (0.044s) [216.417158] Starting dynamic subtest: bcs0 [216.476587] Dynamic subtest bcs0: SUCCESS (0.068s) [216.485212] Starting dynamic subtest: vcs0 [216.510327] Dynamic subtest vcs0: SUCCESS (0.033s) [216.518983] Starting dynamic subtest: vcs1 [217.943992] Dynamic subtest vcs1: SUCCESS (1.434s) [217.952493] Starting dynamic subtest: vecs0 [219.964910] Dynamic subtest vecs0: SUCCESS (2.019s) [219.973277] Starting dynamic subtest: ccs0 [221.917421] Dynamic subtest ccs0: SUCCESS (1.953s) [221.919865] Subtest clean: SUCCESS (5.555s) [222.179437] [070/130] (796s left) kms_invalid_mode (bad-hsync-start) [222.277419] Starting subtest: bad-hsync-start [222.279768] Starting dynamic subtest: pipe-A-eDP-1 [222.573525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s) [222.583933] Starting dynamic subtest: pipe-B-eDP-1 [222.585777] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [222.593589] Starting dynamic subtest: pipe-C-eDP-1 [222.595689] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [222.603612] Starting dynamic subtest: pipe-D-eDP-1 [222.605754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [222.607818] Subtest bad-hsync-start: SUCCESS (0.300s) [223.459834] [071/130] (795s left) syncobj_timeline (etime-multi-wait-submitted) [223.517347] Starting subtest: etime-multi-wait-submitted [223.624909] Subtest etime-multi-wait-submitted: SUCCESS (0.106s) [223.708813] [072/130] (794s left) gem_ctx_persistence (legacy-engines-hostile) [223.759080] Starting subtest: legacy-engines-hostile [223.761523] Starting dynamic subtest: render [223.888101] Dynamic subtest render: SUCCESS (0.128s) [223.898570] Starting dynamic subtest: bsd1 [224.012887] Dynamic subtest bsd1: SUCCESS (0.123s) [224.022836] Starting dynamic subtest: bsd2 [224.136703] Dynamic subtest bsd2: SUCCESS (0.121s) [224.151446] Starting dynamic subtest: blt [224.218543] Dynamic subtest blt: SUCCESS (0.079s) [224.228613] Starting dynamic subtest: vebox [224.363802] Dynamic subtest vebox: SUCCESS (0.143s) [224.366449] Subtest legacy-engines-hostile: SUCCESS (0.606s) [224.468405] [073/130] (794s left) kms_psr (psr-primary-render) [224.554238] Starting subtest: psr-primary-render [224.556504] Starting dynamic subtest: eDP-1 [226.243347] Dynamic subtest eDP-1: SUCCESS (1.687s) [226.245294] Subtest psr-primary-render: SUCCESS (1.688s) [227.108342] [074/130] (791s left) gem_mmap_gtt (big-copy-xy) [227.170764] Subtest big-copy-XY: SKIP (0.000s) [227.237861] [075/130] (791s left) syncobj_basic (test-valid-cycle) [227.299522] Starting subtest: test-valid-cycle [227.301959] Subtest test-valid-cycle: SUCCESS (0.000s) [227.421210] [076/130] (791s left) kms_plane_alpha_blend (constant-alpha-max) [227.523304] Starting subtest: constant-alpha-max [227.799665] Starting dynamic subtest: pipe-A-eDP-1 [228.718908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s) [228.729955] Starting dynamic subtest: pipe-D-eDP-1 [230.320057] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.597s) [230.322841] Subtest constant-alpha-max: SUCCESS (2.797s) [231.176899] [077/130] (787s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [231.274954] Starting subtest: fbc-psr2-sprite-mmap-cpu [231.277136] Starting dynamic subtest: eDP-1 [231.281133] Dynamic subtest eDP-1: SKIP (0.000s) [231.285075] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [231.372353] [078/130] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [231.470774] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [238.040067] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.571s) [238.199061] [079/130] (780s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [238.303154] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [238.305398] Starting dynamic subtest: pipe-A [238.314547] Dynamic subtest pipe-A: SKIP (0.005s) [238.323754] Starting dynamic subtest: pipe-B [238.332942] Dynamic subtest pipe-B: SKIP (0.017s) [238.341379] Starting dynamic subtest: pipe-C [238.350178] Dynamic subtest pipe-C: SKIP (0.017s) [238.358434] Starting dynamic subtest: pipe-D [238.367156] Dynamic subtest pipe-D: SKIP (0.017s) [238.371467] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.058s) [238.488406] [080/130] (780s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [243.435571] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [243.437827] Starting dynamic subtest: pipe-A-eDP-1 [250.373252] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.936s) [250.383518] Starting dynamic subtest: pipe-B-eDP-1 [257.250311] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.875s) [257.252611] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.815s) [258.130835] [081/130] (760s left) syncobj_timeline (multi-wait-all-signaled) [258.174913] Starting subtest: multi-wait-all-signaled [258.177274] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [258.297478] [082/130] (760s left) kms_atomic (plane-invalid-params) [258.383083] Starting subtest: plane-invalid-params [258.385228] Starting dynamic subtest: pipe-A-eDP-1 [258.781865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s) [258.784026] Subtest plane-invalid-params: SUCCESS (0.399s) [259.657506] [083/130] (759s left) sriov_basic (bind-unbind-vf) [259.711601] Starting subtest: bind-unbind-vf [259.713806] Starting dynamic subtest: vf-1 [259.784523] Dynamic subtest vf-1: FAIL (0.006s) [259.794238] Starting dynamic subtest: vf-2 [259.867432] Dynamic subtest vf-2: FAIL (0.003s) [259.877027] Starting dynamic subtest: vf-3 [259.947609] Dynamic subtest vf-3: FAIL (0.003s) [259.956061] Starting dynamic subtest: vf-4 [260.024966] Dynamic subtest vf-4: FAIL (0.003s) [260.033760] Starting dynamic subtest: vf-5 [260.102889] Dynamic subtest vf-5: FAIL (0.003s) [260.110737] Starting dynamic subtest: vf-6 [260.179987] Dynamic subtest vf-6: FAIL (0.003s) [260.189093] Starting dynamic subtest: vf-7 [260.260141] Dynamic subtest vf-7: FAIL (0.003s) [260.267719] Starting dynamic subtest: vf-random [260.339862] Dynamic subtest vf-random: FAIL (0.003s) [260.349547] Starting dynamic subtest: vf-last [260.422803] Dynamic subtest vf-last: FAIL (0.488s) [260.425128] Subtest bind-unbind-vf: FAIL (0.522s) [260.462604] [084/130] (758s left) gem_exec_reloc (basic-cpu-read) [260.511559] Subtest basic-cpu-read: SKIP (0.000s) [260.582458] [085/130] (758s left) gem_render_copy (yf-tiled) [260.643736] Starting subtest: yf-tiled [260.647526] Subtest yf-tiled: SKIP (0.000s) [260.850118] [086/130] (758s left) kms_cursor_crc (cursor-random-256x256) [261.082411] Starting subtest: cursor-random-256x256 [261.087660] Starting dynamic subtest: pipe-A-eDP-1 [264.395964] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.309s) [264.419541] Starting dynamic subtest: pipe-D-eDP-1 [268.439331] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.026s) [268.441899] Subtest cursor-random-256x256: SUCCESS (7.356s) [269.322308] [087/130] (749s left) gem_mmap_gtt (basic-small-copy-xy) [269.370777] Subtest basic-small-copy-XY: SKIP (0.000s) [269.436314] [088/130] (749s left) kms_cursor_edge_walk (64x64-top-bottom) [269.523386] Starting subtest: 64x64-top-bottom [269.525682] Starting dynamic subtest: pipe-A-eDP-1 [272.970607] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s) [272.982123] Starting dynamic subtest: pipe-D-eDP-1 [276.100325] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s) [276.102660] Subtest 64x64-top-bottom: SUCCESS (6.578s) [276.923100] [089/130] (742s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [277.016811] Starting subtest: fbcpsr-stridechange [283.215912] Subtest fbcpsr-stridechange: SUCCESS (6.201s) [283.376235] [090/130] (735s left) kms_big_fb (x-tiled-64bpp-rotate-180) [283.474674] Starting subtest: x-tiled-64bpp-rotate-180 [285.044586] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.570s) [285.265809] [091/130] (733s left) kms_selftest (drm_dp_mst_helper) [285.302735] Starting subtest: drm_dp_mst_helper [285.331330] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [285.474509] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.143s) [285.482602] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [285.638607] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.164s) [285.649078] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [285.788422] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.149s) [285.790559] Subtest drm_dp_mst_helper: SUCCESS (0.484s) [285.990108] [092/130] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [286.102665] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [293.279212] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.181s) [293.431415] [093/130] (725s left) prime_vgem (basic-gtt) [293.515404] Starting subtest: basic-gtt [293.520134] Subtest basic-gtt: SKIP (0.000s) [293.636402] [094/130] (725s left) kms_rotation_crc (primary-rotation-180) [293.723170] Starting subtest: primary-rotation-180 [300.614903] Subtest primary-rotation-180: SUCCESS (6.893s) [301.850098] [095/130] (717s left) kms_vblank (ts-continuation-modeset) [301.949353] Starting subtest: ts-continuation-modeset [301.951289] Starting dynamic subtest: pipe-A-eDP-1 [303.408633] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.458s) [303.423904] Starting dynamic subtest: pipe-D-eDP-1 [305.568881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s) [305.570761] Subtest ts-continuation-modeset: SUCCESS (3.620s) [306.392856] [096/130] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [306.499792] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [306.503787] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [306.629781] [097/130] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [306.732617] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [306.736671] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [306.851116] [098/130] (712s left) kms_addfb_basic (addfb25-4-tiled) [306.947613] Starting subtest: addfb25-4-tiled [306.949527] Subtest addfb25-4-tiled: SUCCESS (0.000s) [307.071280] [099/130] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [307.174216] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [307.178635] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [307.291284] [100/130] (712s left) kms_psr (pr-sprite-render) [307.385853] Starting subtest: pr-sprite-render [307.389582] Subtest pr-sprite-render: SKIP (0.000s) [307.466994] [101/130] (712s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [307.524416] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [307.592671] [102/130] (712s left) dmabuf_sync_file (import-basic) [307.626461] Starting subtest: import-basic [307.628260] Subtest import-basic: SUCCESS (0.002s) [307.704073] [103/130] (712s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [307.792519] Starting subtest: plane-all-transition-nonblocking-fencing [307.794406] Starting dynamic subtest: pipe-A-eDP-1 [310.294784] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [310.620658] Starting dynamic subtest: pipe-B-eDP-1 [313.800663] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.195s) [314.101100] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.307s) [314.931928] [104/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [315.039892] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [336.928876] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.892s) [337.098996] [105/130] (682s left) gem_exec_balancer (full-pulse) [337.168916] Starting subtest: full-pulse [341.739818] Subtest full-pulse: SUCCESS (4.572s) [342.080238] [106/130] (677s left) gem_mmap_offset (mmap-boundaries) [342.130092] Starting subtest: mmap-boundaries [342.131936] Starting dynamic subtest: smem0 [342.409458] Dynamic subtest smem0: SUCCESS (0.280s) [342.411968] Subtest mmap-boundaries: SUCCESS (0.280s) [342.563639] [107/130] (677s left) gem_madvise (dontneed-after-mmap) [342.594063] Starting subtest: dontneed-after-mmap [342.620936] Subtest dontneed-after-mmap: SUCCESS (0.029s) [342.744391] [108/130] (677s left) gem_exec_whisper (basic-fds) [342.803110] Starting subtest: basic-fds [350.900806] Subtest basic-fds: SUCCESS (8.093s) [351.105774] [109/130] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [351.202943] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [351.207033] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [351.333223] [110/130] (668s left) i915_drm_fdinfo (memory-info-idle) [351.372368] Starting subtest: memory-info-idle [351.374718] Starting dynamic subtest: smem0 [351.435429] Dynamic subtest smem0: SUCCESS (0.064s) [351.438086] Subtest memory-info-idle: SUCCESS (0.065s) [351.533177] [111/130] (668s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [351.626183] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [351.630571] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [351.749341] [112/130] (668s left) gem_sync (basic-each) [351.813681] Starting subtest: basic-each [354.109041] Subtest basic-each: SUCCESS (2.306s) [354.315199] [113/130] (665s left) kms_psr (fbc-pr-primary-page-flip) [354.420884] Starting subtest: fbc-pr-primary-page-flip [354.425269] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [354.504139] [114/130] (665s left) gem_exec_schedule (promotion) [354.582735] Starting subtest: promotion [354.585101] Starting dynamic subtest: rcs0 [354.679844] Dynamic subtest rcs0: SUCCESS (0.106s) [354.692404] Starting dynamic subtest: vcs0 [354.758773] Dynamic subtest vcs0: SUCCESS (0.079s) [354.770529] Starting dynamic subtest: vcs1 [354.839886] Dynamic subtest vcs1: SUCCESS (0.080s) [354.849762] Starting dynamic subtest: vecs0 [354.917733] Dynamic subtest vecs0: SUCCESS (0.078s) [354.928236] Starting dynamic subtest: ccs0 [355.000621] Dynamic subtest ccs0: SUCCESS (0.082s) [355.002860] Subtest promotion: SUCCESS (0.427s) [356.043124] [115/130] (664s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [356.136989] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [357.102988] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.968s) [357.272312] [116/130] (662s left) gem_userptr_blits (invalid-null-pointer) [357.338225] Starting subtest: invalid-null-pointer [357.339781] Subtest invalid-null-pointer: SUCCESS (0.001s) [357.488330] [117/130] (662s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [357.574500] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [357.576394] Starting dynamic subtest: pipe-A-default-mode [358.678395] Dynamic subtest pipe-A-default-mode: SKIP (1.100s) [358.682383] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.102s) [358.846345] [118/130] (661s left) gem_wait (wait) [358.910380] Starting subtest: wait [358.912733] Starting dynamic subtest: all-engines [360.916507] Dynamic subtest all-engines: SUCCESS (2.004s) [360.931089] Starting dynamic subtest: rcs0 [361.963639] Dynamic subtest rcs0: SUCCESS (1.046s) [361.975876] Starting dynamic subtest: bcs0 [363.011465] Dynamic subtest bcs0: SUCCESS (1.046s) [363.022891] Starting dynamic subtest: vcs0 [364.057530] Dynamic subtest vcs0: SUCCESS (1.044s) [364.068563] Starting dynamic subtest: vcs1 [365.103403] Dynamic subtest vcs1: SUCCESS (1.044s) [365.115092] Starting dynamic subtest: vecs0 [366.149106] Dynamic subtest vecs0: SUCCESS (1.044s) [366.159662] Starting dynamic subtest: ccs0 [367.196871] Dynamic subtest ccs0: SUCCESS (1.046s) [367.199362] Subtest wait: SUCCESS (8.287s) [367.414180] [119/130] (652s left) kms_big_fb (x-tiled-64bpp-rotate-90) [367.507160] Starting subtest: x-tiled-64bpp-rotate-90 [367.525906] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s) [367.660926] [120/130] (652s left) gem_softpin (full) [367.723583] Starting subtest: full [367.729628] Subtest full: SUCCESS (0.007s) [367.878677] [121/130] (652s left) kms_color (ctm-0-50) [367.968274] Starting subtest: ctm-0-50 [367.970503] Starting dynamic subtest: pipe-A-eDP-1 [371.334096] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.367s) [371.343599] Starting dynamic subtest: pipe-B-eDP-1 [375.417722] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.082s) [375.427787] Starting dynamic subtest: pipe-C-eDP-1 [379.344658] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.925s) [379.355583] Starting dynamic subtest: pipe-D-eDP-1 [383.360082] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.016s) [383.362451] Subtest ctm-0-50: SUCCESS (15.393s) [384.221136] [122/130] (636s left) vgem_basic (sysfs) [384.259740] Starting subtest: sysfs [384.261612] Subtest sysfs: SUCCESS (0.000s) [384.337431] [123/130] (636s left) core_getversion (basic) [384.373304] Starting subtest: basic [384.377636] Subtest basic: SUCCESS (0.000s) [384.465940] [124/130] (636s left) gem_eio (in-flight-internal-10ms) [384.665837] Starting subtest: in-flight-internal-10ms [385.999050] Subtest in-flight-internal-10ms: SUCCESS (1.333s) [386.181211] [125/130] (634s left) gem_spin_batch (legacy-resubmit) [386.246877] Starting subtest: legacy-resubmit [386.249241] Starting dynamic subtest: default [386.254036] Dynamic subtest default: SUCCESS (0.005s) [386.262870] Starting dynamic subtest: render [386.265289] Dynamic subtest render: SUCCESS (0.001s) [386.273593] Starting dynamic subtest: bsd [386.275815] Dynamic subtest bsd: SUCCESS (0.002s) [386.283964] Starting dynamic subtest: bsd1 [386.286190] Dynamic subtest bsd1: SUCCESS (0.001s) [386.294294] Starting dynamic subtest: bsd2 [386.296487] Dynamic subtest bsd2: SUCCESS (0.002s) [386.304556] Starting dynamic subtest: blt [386.306757] Dynamic subtest blt: SUCCESS (0.002s) [386.315091] Starting dynamic subtest: vebox [386.317282] Dynamic subtest vebox: SUCCESS (0.002s) [386.319491] Subtest legacy-resubmit: SUCCESS (0.019s) [386.506708] [126/130] (634s left) kms_chamelium_frames (dp-crc-multiple) [386.880738] Subtest dp-crc-multiple: SKIP (0.000s) [387.721938] [127/130] (632s left) perf_pmu (pmu-read) [387.769414] Starting subtest: pmu-read [387.771748] Subtest pmu-read: SUCCESS (0.002s) [387.918949] [128/130] (632s left) kms_rotation_crc (cursor-rotation-180) [388.007127] Starting subtest: cursor-rotation-180 [389.484222] Subtest cursor-rotation-180: SUCCESS (1.477s) [390.722102] [129/130] (630s left) perf_pmu (busy-hang) [390.756390] Starting subtest: busy-hang [390.758637] Starting dynamic subtest: rcs0 [392.039202] Dynamic subtest rcs0: SUCCESS (1.280s) [392.049544] Starting dynamic subtest: bcs0 [393.264851] Dynamic subtest bcs0: SUCCESS (1.225s) [393.275524] Starting dynamic subtest: vcs0 [395.419339] Dynamic subtest vcs0: SUCCESS (2.152s) [395.428038] Starting dynamic subtest: vcs1 [397.408558] Dynamic subtest vcs1: SUCCESS (1.987s) [397.418516] Starting dynamic subtest: vecs0 [399.453937] Dynamic subtest vecs0: SUCCESS (2.047s) [399.465061] Starting dynamic subtest: ccs0 [400.693918] Dynamic subtest ccs0: SUCCESS (1.235s) [400.696303] Subtest busy-hang: SUCCESS (9.936s) [400.805289] [130/130] (619s left) gem_exec_schedule (u-lateslice) [400.887348] Starting subtest: u-lateslice [400.889607] Starting dynamic subtest: rcs0 [400.907092] Dynamic subtest rcs0: SUCCESS (0.028s) [400.918630] Starting dynamic subtest: bcs0 [400.929220] Dynamic subtest bcs0: SUCCESS (0.022s) [400.937662] Starting dynamic subtest: vcs0 [400.950861] Dynamic subtest vcs0: SUCCESS (0.021s) [400.959205] Starting dynamic subtest: vcs1 [400.971926] Dynamic subtest vcs1: SUCCESS (0.020s) [400.980402] Starting dynamic subtest: vecs0 [400.993779] Dynamic subtest vecs0: SUCCESS (0.021s) [401.002281] Starting dynamic subtest: ccs0 [401.018855] Dynamic subtest ccs0: SUCCESS (0.025s) [401.021081] Subtest u-lateslice: SUCCESS (0.141s) [403.016224] 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.