[54.443317] Initializing watchdogs [54.443518] /dev/watchdog0 [54.459463] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [54.463799] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.466060] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.469286] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [54.591635] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [54.595987] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [54.709620] [002/130] (960s left) kms_pm_dc (dc6-dpms) [55.805103] Starting subtest: dc6-dpms [57.845644] Subtest dc6-dpms: SUCCESS (2.023s) [57.943061] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [58.055460] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [58.059926] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [58.166789] [004/130] (956s left) gem_exec_balancer (invalid-balancer) [58.226606] Starting subtest: invalid-balancer [59.090524] Subtest invalid-balancer: SUCCESS (0.858s) [59.412904] [005/130] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [59.502333] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [59.506503] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.614605] [006/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd) [59.676967] Starting subtest: invalid-illegal-eventfd [59.679269] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [59.799845] [007/130] (955s left) prime_vgem (fence-write-hang) [59.909719] Subtest fence-write-hang: SKIP (0.000s) [60.013817] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [60.016897] [008/130] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [60.111764] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [60.114074] Starting dynamic subtest: pipe-A-eDP-1 [60.281029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.160s) [60.287734] Starting dynamic subtest: pipe-B-eDP-1 [60.308253] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s) [60.317087] Starting dynamic subtest: pipe-C-eDP-1 [60.332691] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [60.338983] Starting dynamic subtest: pipe-D-eDP-1 [60.354927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [60.357231] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.172s) [62.604913] [009/130] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [62.702751] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [62.707253] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [63.831198] [010/130] (951s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [63.926244] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [63.930153] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [64.038698] [011/130] (951s left) perf (sysctl-defaults) [64.135389] Starting subtest: sysctl-defaults [64.138395] Subtest sysctl-defaults: SUCCESS (0.000s) [64.224998] [012/130] (951s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [64.328154] Starting subtest: plane-use-after-nonblocking-unbind-fencing [64.330662] Starting dynamic subtest: pipe-A-eDP-1 [64.400277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.073s) [64.705834] Starting dynamic subtest: pipe-B-eDP-1 [65.544596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.842s) [65.850625] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.519s) [66.739176] [013/130] (948s left) kms_content_protection (dp-mst-type-0) [66.885342] Starting subtest: dp-mst-type-0 [66.890102] Subtest dp-mst-type-0: SKIP (0.000s) [67.033281] [014/130] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [67.116900] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [67.119302] Starting dynamic subtest: pipe-A-eDP-1 [67.140360] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [67.148597] Starting dynamic subtest: pipe-B-eDP-1 [67.168422] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [67.176085] Starting dynamic subtest: pipe-C-eDP-1 [67.195748] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [67.202885] Starting dynamic subtest: pipe-D-eDP-1 [67.222480] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [67.224697] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [69.311825] [015/130] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [69.400341] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [69.402666] Starting dynamic subtest: pipe-A-eDP-1 [69.462880] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [69.471847] Starting dynamic subtest: pipe-B-eDP-1 [69.527671] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [69.535939] Starting dynamic subtest: pipe-C-eDP-1 [69.594384] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [69.602993] Starting dynamic subtest: pipe-D-eDP-1 [69.661972] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [69.666598] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [71.601563] [016/130] (943s left) gem_exec_reloc (basic-cpu) [71.705867] Subtest basic-cpu: SKIP (0.000s) [71.798566] [017/130] (943s left) kms_chamelium_hpd (dp-hpd-storm-disable) [72.251541] Subtest dp-hpd-storm-disable: SKIP (0.000s) [73.071024] [018/130] (942s left) syncobj_timeline (wait-for-submit-delayed-submit) [73.130637] Starting subtest: wait-for-submit-delayed-submit [73.235764] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [73.333767] [019/130] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.419024] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.423170] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.546301] [020/130] (942s left) gem_mmap_offset (bad-extensions) [73.601914] Starting subtest: bad-extensions [73.604508] Subtest bad-extensions: SUCCESS (0.000s) [73.706031] [021/130] (942s left) kms_lease (atomic-implicit-crtc) [73.798629] Starting subtest: atomic-implicit-crtc [73.801076] Starting dynamic subtest: pipe-A-eDP-1 [73.812595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [73.820392] Starting dynamic subtest: pipe-B-eDP-1 [73.831260] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s) [73.838093] Starting dynamic subtest: pipe-C-eDP-1 [73.848593] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [73.855351] Starting dynamic subtest: pipe-D-eDP-1 [73.866028] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [73.868148] Subtest atomic-implicit-crtc: SUCCESS (0.027s) [73.961087] [022/130] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [74.061065] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [74.065428] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [74.162040] [023/130] (941s left) gem_partial_pwrite_pread (write) [74.226586] Subtest write: SKIP (0.000s) [74.279298] [024/130] (941s left) kms_dither (fb-8bpc-vs-panel-8bpc) [74.372790] Starting subtest: fb-8bpc-vs-panel-8bpc [74.374784] Starting dynamic subtest: pipe-A-eDP-1 [75.762542] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.385s) [75.764846] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.386s) [76.569690] [025/130] (939s left) kms_flip (basic-flip-vs-modeset) [76.674316] Starting subtest: basic-flip-vs-modeset [76.676612] Starting dynamic subtest: A-eDP1 [79.246076] Dynamic subtest A-eDP1: SUCCESS (2.572s) [79.254310] Starting dynamic subtest: B-eDP1 [81.419566] Dynamic subtest B-eDP1: SUCCESS (2.169s) [81.428253] Starting dynamic subtest: C-eDP1 [83.599920] Dynamic subtest C-eDP1: SUCCESS (2.182s) [83.607246] Starting dynamic subtest: D-eDP1 [85.680725] Dynamic subtest D-eDP1: SUCCESS (2.081s) [85.682976] Subtest basic-flip-vs-modeset: SUCCESS (9.008s) [86.506556] [026/130] (929s left) gem_bad_reloc (negative-reloc-bltcopy) [86.567823] Subtest negative-reloc-bltcopy: SKIP (0.000s) [86.663075] [027/130] (929s left) i915_drm_fdinfo (busy-check-all) [86.700330] Starting subtest: busy-check-all [86.702521] Starting dynamic subtest: rcs0 [86.707064] Dynamic subtest rcs0: SKIP (0.004s) [86.714038] Starting dynamic subtest: bcs0 [86.718446] Dynamic subtest bcs0: SKIP (0.000s) [86.725097] Starting dynamic subtest: vcs0 [86.729476] Dynamic subtest vcs0: SKIP (0.000s) [86.735772] Starting dynamic subtest: vcs1 [86.739878] Dynamic subtest vcs1: SKIP (0.000s) [86.746179] Starting dynamic subtest: vecs0 [86.750252] Dynamic subtest vecs0: SKIP (0.000s) [86.756547] Starting dynamic subtest: ccs0 [86.760659] Dynamic subtest ccs0: SKIP (0.000s) [86.764839] Subtest busy-check-all: SKIP (0.006s) [86.797669] [028/130] (929s left) gem_ccs (block-multicopy-inplace) [86.867298] Starting subtest: block-multicopy-inplace [86.872126] Subtest block-multicopy-inplace: SKIP (0.000s) [86.980980] [029/130] (929s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [87.067948] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [87.070468] Starting dynamic subtest: pipe-A [87.405940] Dynamic subtest pipe-A: SUCCESS (0.340s) [87.413758] Starting dynamic subtest: pipe-B [88.778760] Dynamic subtest pipe-B: SUCCESS (1.372s) [88.785704] Starting dynamic subtest: pipe-C [90.203359] Dynamic subtest pipe-C: SUCCESS (1.424s) [90.211032] Starting dynamic subtest: pipe-D [91.633447] Dynamic subtest pipe-D: SUCCESS (1.429s) [91.635732] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.567s) [92.825530] [030/130] (923s left) gem_exec_reloc (basic-cpu-read-noreloc) [92.895120] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [92.971631] [031/130] (923s left) syncobj_basic (bad-destroy) [93.031163] Starting subtest: bad-destroy [93.033126] Subtest bad-destroy: SUCCESS (0.000s) [93.140387] [032/130] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [93.237709] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [96.908117] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.674s) [98.142261] [033/130] (918s left) i915_pm_freq_api (freq-reset) [98.206480] Starting subtest: freq-reset [98.208873] Starting dynamic subtest: gt0 [98.379086] Dynamic subtest gt0: SUCCESS (0.171s) [98.385856] Starting dynamic subtest: gt1 [98.528880] Dynamic subtest gt1: SUCCESS (0.145s) [98.530992] Subtest freq-reset: SUCCESS (0.318s) [98.623846] [034/130] (917s left) i915_pm_rps (fence-order) [98.687449] Starting subtest: fence-order [101.698272] Subtest fence-order: SUCCESS (3.008s) [101.778618] [035/130] (914s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [101.834508] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [101.836772] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [101.973634] [036/130] (914s left) gem_readwrite (beyond-eob) [102.037368] Subtest beyond-EOB: SKIP (0.000s) [102.098622] [037/130] (914s left) gem_media_vme [102.252151] [038/130] (914s left) gem_exec_reloc (basic-wc-gtt-active) [102.311927] Subtest basic-wc-gtt-active: SKIP (0.000s) [102.409413] [039/130] (914s left) gem_mmap_wc (read) [102.468703] Subtest read: SKIP (0.000s) [102.535660] [040/130] (913s left) kms_atomic_transition (modeset-transition-nonblocking) [102.637908] Starting subtest: modeset-transition-nonblocking [102.640186] Starting dynamic subtest: 1x-outputs [113.163571] Dynamic subtest 1x-outputs: SUCCESS (10.525s) [113.439539] Subtest modeset-transition-nonblocking: SUCCESS (10.802s) [114.323677] [041/130] (902s left) gem_ctx_shared (q-out-order) [114.387595] Starting subtest: Q-out-order [114.390113] Starting dynamic subtest: rcs0 [114.488439] Dynamic subtest rcs0: SUCCESS (0.100s) [114.504633] Starting dynamic subtest: vcs0 [114.565081] Dynamic subtest vcs0: SUCCESS (0.077s) [114.583074] Starting dynamic subtest: vcs1 [114.644069] Dynamic subtest vcs1: SUCCESS (0.078s) [114.659918] Starting dynamic subtest: vecs0 [114.720682] Dynamic subtest vecs0: SUCCESS (0.076s) [114.735591] Starting dynamic subtest: ccs0 [114.793839] Dynamic subtest ccs0: SUCCESS (0.074s) [114.796275] Subtest Q-out-order: SUCCESS (0.406s) [116.066584] [042/130] (900s left) kms_flip (2x-flip-vs-panning-interruptible) [116.165248] Starting subtest: 2x-flip-vs-panning-interruptible [116.177195] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s) [116.259944] [043/130] (900s left) gem_exec_fence (syncobj-timeline-repeat) [116.776338] Starting subtest: syncobj-timeline-repeat [116.991076] Subtest syncobj-timeline-repeat: SUCCESS (0.215s) [117.993547] [044/130] (898s left) gem_pxp (create-regular-buffer) [118.124515] Starting subtest: create-regular-buffer [118.126801] Subtest create-regular-buffer: SUCCESS (0.000s) [118.246977] [045/130] (898s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [123.167397] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [123.172072] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [124.030453] [046/130] (892s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [128.994279] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [128.996588] Starting dynamic subtest: pipe-A-eDP-1 [129.795815] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s) [129.805872] Starting dynamic subtest: pipe-B-eDP-1 [130.924183] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s) [130.928465] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.927s) [132.131520] [047/130] (884s left) kms_hdr (brightness-with-hdr) [132.233066] Starting subtest: brightness-with-hdr [132.239957] Subtest brightness-with-hdr: SKIP (0.000s) [132.333693] [048/130] (884s left) kms_getfb (getfb-handle-closed) [132.429209] Starting subtest: getfb-handle-closed [132.431598] Subtest getfb-handle-closed: SUCCESS (0.000s) [132.567590] [049/130] (884s left) gem_close_race (basic-threads) [132.632501] Starting subtest: basic-threads [133.977541] Subtest basic-threads: SUCCESS (1.345s) [134.172483] [050/130] (882s left) kms_vrr (flipline) [134.258196] Starting subtest: flipline [134.264683] Subtest flipline: SKIP (0.000s) [134.340102] [051/130] (882s left) kms_plane_multiple (2x-tiling-none) [134.440781] Starting subtest: 2x-tiling-none [134.444880] Subtest 2x-tiling-none: SKIP (0.000s) [134.521381] [052/130] (882s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [134.619056] Starting subtest: fbc-1p-pri-indfb-multidraw [147.660178] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.046s) [148.850328] [053/130] (868s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [148.967282] Starting subtest: cursorB-vs-flipB-atomic-transitions [148.971677] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [149.129948] [054/130] (867s left) gem_mmap_wc (coherency) [149.171730] Subtest coherency: SKIP (0.000s) [149.231774] [055/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [149.337818] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [149.342291] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [149.476561] [056/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [149.569243] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [149.573538] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [149.699917] [057/130] (867s left) gem_exec_fence (invalid-fence-array) [150.118508] Starting subtest: invalid-fence-array [150.120907] Subtest invalid-fence-array: SUCCESS (0.002s) [152.005649] [058/130] (865s left) api_intel_bb (destroy-bb) [152.058145] Starting subtest: destroy-bb [152.066779] Subtest destroy-bb: SUCCESS (0.009s) [152.241474] [059/130] (865s left) kms_cursor_crc (cursor-rapid-movement-256x256) [152.476402] Starting subtest: cursor-rapid-movement-256x256 [152.481233] Starting dynamic subtest: pipe-A-eDP-1 [153.019273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s) [153.045951] Starting dynamic subtest: pipe-D-eDP-1 [154.220628] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s) [154.222901] Subtest cursor-rapid-movement-256x256: SUCCESS (1.744s) [155.095395] [060/130] (862s left) kms_big_fb (y-tiled-16bpp-rotate-0) [155.198675] Starting subtest: y-tiled-16bpp-rotate-0 [155.203204] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [155.318818] [061/130] (862s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [155.408791] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [155.411147] Starting dynamic subtest: A-eDP1 [164.325771] Dynamic subtest A-eDP1: SUCCESS (8.916s) [164.338121] Starting dynamic subtest: B-eDP1 [173.256116] Dynamic subtest B-eDP1: SUCCESS (8.929s) [173.266564] Starting dynamic subtest: C-eDP1 [182.173234] Dynamic subtest C-eDP1: SUCCESS (8.915s) [182.181727] Starting dynamic subtest: D-eDP1 [191.016289] Dynamic subtest D-eDP1: SUCCESS (8.842s) [191.022019] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.611s) [192.254779] [062/130] (825s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [192.353408] Starting subtest: fbcpsr-rgb101010-draw-blt [199.075348] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.725s) [199.219989] [063/130] (818s left) kms_psr (pr-cursor-plane-move) [199.323084] Starting subtest: pr-cursor-plane-move [199.327168] Subtest pr-cursor-plane-move: SKIP (0.000s) [199.419050] [064/130] (818s left) gem_exec_schedule (out-order) [199.486603] Starting subtest: out-order [199.488905] Starting dynamic subtest: rcs0 [199.577393] Dynamic subtest rcs0: SUCCESS (0.100s) [199.587907] Starting dynamic subtest: vcs0 [199.655835] Dynamic subtest vcs0: SUCCESS (0.078s) [199.667771] Starting dynamic subtest: vcs1 [199.737647] Dynamic subtest vcs1: SUCCESS (0.081s) [199.749099] Starting dynamic subtest: vecs0 [199.814490] Dynamic subtest vecs0: SUCCESS (0.076s) [199.826062] Starting dynamic subtest: ccs0 [199.892701] Dynamic subtest ccs0: SUCCESS (0.078s) [199.895252] Subtest out-order: SUCCESS (0.415s) [201.047302] [065/130] (816s left) kms_plane_scaling (2x-scaler-multi-pipe) [201.138054] Starting subtest: 2x-scaler-multi-pipe [201.142633] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [201.270758] [066/130] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [201.372662] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [204.971185] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.605s) [206.182898] [067/130] (811s left) kms_fb_coherency (memset-crc) [206.278182] Starting subtest: memset-crc [206.280513] Starting dynamic subtest: mmap-offset-wc [206.639169] Dynamic subtest mmap-offset-wc: SUCCESS (0.362s) [206.926515] Starting dynamic subtest: mmap-offset-uc [212.973474] Dynamic subtest mmap-offset-uc: SUCCESS (6.055s) [213.263280] Subtest memset-crc: SUCCESS (6.987s) [214.116190] [068/130] (803s left) kms_chamelium_audio (dp-audio) [214.489293] Subtest dp-audio: SKIP (0.000s) [215.315998] [069/130] (802s left) gem_ctx_isolation (clean) [215.382494] Starting subtest: clean [215.384779] Starting dynamic subtest: rcs0 [215.441933] Dynamic subtest rcs0: SUCCESS (0.059s) [215.452583] Starting dynamic subtest: bcs0 [215.539334] Dynamic subtest bcs0: SUCCESS (0.097s) [215.549756] Starting dynamic subtest: vcs0 [215.613024] Dynamic subtest vcs0: SUCCESS (0.073s) [215.623708] Starting dynamic subtest: vcs1 [216.961737] Dynamic subtest vcs1: SUCCESS (1.348s) [216.972438] Starting dynamic subtest: vecs0 [218.955576] Dynamic subtest vecs0: SUCCESS (1.993s) [218.963932] Starting dynamic subtest: ccs0 [220.939031] Dynamic subtest ccs0: SUCCESS (1.983s) [220.941415] Subtest clean: SUCCESS (5.556s) [221.205274] [070/130] (796s left) kms_invalid_mode (bad-hsync-start) [221.307272] Starting subtest: bad-hsync-start [221.309572] Starting dynamic subtest: pipe-A-eDP-1 [221.590345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [221.598824] Starting dynamic subtest: pipe-B-eDP-1 [221.601115] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [221.608768] Starting dynamic subtest: pipe-C-eDP-1 [221.611029] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [221.618924] Starting dynamic subtest: pipe-D-eDP-1 [221.621296] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [221.623549] Subtest bad-hsync-start: SUCCESS (0.291s) [222.473391] [071/130] (795s left) syncobj_timeline (etime-multi-wait-submitted) [222.536501] Starting subtest: etime-multi-wait-submitted [222.640055] Subtest etime-multi-wait-submitted: SUCCESS (0.103s) [222.735358] [072/130] (795s left) gem_ctx_persistence (legacy-engines-hostile) [222.794903] Starting subtest: legacy-engines-hostile [222.797214] Starting dynamic subtest: render [222.921279] Dynamic subtest render: SUCCESS (0.125s) [222.931133] Starting dynamic subtest: bsd1 [223.030552] Dynamic subtest bsd1: SUCCESS (0.108s) [223.041668] Starting dynamic subtest: bsd2 [223.111595] Dynamic subtest bsd2: SUCCESS (0.079s) [223.122320] Starting dynamic subtest: blt [223.279955] Dynamic subtest blt: SUCCESS (0.166s) [223.291801] Starting dynamic subtest: vebox [223.393268] Dynamic subtest vebox: SUCCESS (0.111s) [223.395908] Subtest legacy-engines-hostile: SUCCESS (0.599s) [223.495315] [073/130] (794s left) kms_psr (psr-primary-render) [223.593347] Starting subtest: psr-primary-render [223.595622] Starting dynamic subtest: eDP-1 [225.368429] Dynamic subtest eDP-1: SUCCESS (1.773s) [225.370720] Subtest psr-primary-render: SUCCESS (1.774s) [226.258477] [074/130] (791s left) gem_mmap_gtt (big-copy-xy) [226.319166] Subtest big-copy-XY: SKIP (0.000s) [226.380708] [075/130] (791s left) syncobj_basic (test-valid-cycle) [226.431481] Starting subtest: test-valid-cycle [226.433710] Subtest test-valid-cycle: SUCCESS (0.000s) [226.537636] [076/130] (791s left) kms_plane_alpha_blend (constant-alpha-max) [226.629430] Starting subtest: constant-alpha-max [226.910976] Starting dynamic subtest: pipe-A-eDP-1 [227.810444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s) [227.820057] Starting dynamic subtest: pipe-D-eDP-1 [229.437446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.624s) [229.439777] Subtest constant-alpha-max: SUCCESS (2.808s) [230.324218] [077/130] (787s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [230.424111] Starting subtest: fbc-psr2-sprite-mmap-cpu [230.426479] Starting dynamic subtest: eDP-1 [230.430431] Dynamic subtest eDP-1: SKIP (0.000s) [230.434455] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [230.510969] [078/130] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [230.617740] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [237.099080] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.484s) [237.269747] [079/130] (780s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [237.372938] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [237.375105] Starting dynamic subtest: pipe-A [237.385228] Dynamic subtest pipe-A: SKIP (0.007s) [237.393893] Starting dynamic subtest: pipe-B [237.402621] Dynamic subtest pipe-B: SKIP (0.017s) [237.411281] Starting dynamic subtest: pipe-C [237.420111] Dynamic subtest pipe-C: SKIP (0.017s) [237.428453] Starting dynamic subtest: pipe-D [237.436862] Dynamic subtest pipe-D: SKIP (0.017s) [237.440623] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.062s) [237.580030] [080/130] (780s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [242.579044] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [242.581384] Starting dynamic subtest: pipe-A-eDP-1 [249.723592] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.144s) [249.740454] Starting dynamic subtest: pipe-B-eDP-1 [256.667525] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.942s) [256.669781] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.090s) [257.539098] [081/130] (760s left) syncobj_timeline (multi-wait-all-signaled) [257.602626] Starting subtest: multi-wait-all-signaled [257.605057] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [257.719288] [082/130] (760s left) kms_atomic (plane-invalid-params) [257.806125] Starting subtest: plane-invalid-params [257.808348] Starting dynamic subtest: pipe-A-eDP-1 [258.192402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s) [258.194798] Subtest plane-invalid-params: SUCCESS (0.386s) [259.044204] [083/130] (759s left) sriov_basic (bind-unbind-vf) [259.098500] Starting subtest: bind-unbind-vf [259.100878] Starting dynamic subtest: vf-1 [259.176062] Dynamic subtest vf-1: FAIL (0.005s) [259.184783] Starting dynamic subtest: vf-2 [259.258022] Dynamic subtest vf-2: FAIL (0.004s) [259.268056] Starting dynamic subtest: vf-3 [259.341728] Dynamic subtest vf-3: FAIL (0.004s) [259.352377] Starting dynamic subtest: vf-4 [259.425294] Dynamic subtest vf-4: FAIL (0.004s) [259.435681] Starting dynamic subtest: vf-5 [259.511323] Dynamic subtest vf-5: FAIL (0.004s) [259.521380] Starting dynamic subtest: vf-6 [259.594729] Dynamic subtest vf-6: FAIL (0.003s) [259.604626] Starting dynamic subtest: vf-7 [259.678195] Dynamic subtest vf-7: FAIL (0.003s) [259.686685] Starting dynamic subtest: vf-random [259.751974] Dynamic subtest vf-random: FAIL (0.003s) [259.764692] Starting dynamic subtest: vf-last [259.827514] Dynamic subtest vf-last: FAIL (0.515s) [259.829449] Subtest bind-unbind-vf: FAIL (0.551s) [259.866143] [084/130] (758s left) gem_exec_reloc (basic-cpu-read) [259.928747] Subtest basic-cpu-read: SKIP (0.000s) [260.004576] [085/130] (758s left) gem_render_copy (yf-tiled) [260.056877] Starting subtest: yf-tiled [260.060466] Subtest yf-tiled: SKIP (0.000s) [260.249062] [086/130] (758s left) kms_cursor_crc (cursor-random-256x256) [260.492537] Starting subtest: cursor-random-256x256 [260.497845] Starting dynamic subtest: pipe-A-eDP-1 [263.806073] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.309s) [263.829816] Starting dynamic subtest: pipe-D-eDP-1 [267.821520] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s) [267.823890] Subtest cursor-random-256x256: SUCCESS (7.329s) [268.725230] [087/130] (749s left) gem_mmap_gtt (basic-small-copy-xy) [268.788900] Subtest basic-small-copy-XY: SKIP (0.000s) [268.862558] [088/130] (749s left) kms_cursor_edge_walk (64x64-top-bottom) [268.955158] Starting subtest: 64x64-top-bottom [268.957524] Starting dynamic subtest: pipe-A-eDP-1 [272.386646] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s) [272.396195] Starting dynamic subtest: pipe-D-eDP-1 [275.512161] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [275.514073] Subtest 64x64-top-bottom: SUCCESS (6.556s) [276.346847] [089/130] (742s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [276.453666] Starting subtest: fbcpsr-stridechange [282.526774] Subtest fbcpsr-stridechange: SUCCESS (6.075s) [282.682344] [090/130] (735s left) kms_big_fb (x-tiled-64bpp-rotate-180) [282.778915] Starting subtest: x-tiled-64bpp-rotate-180 [284.400311] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.623s) [284.592791] [091/130] (733s left) kms_selftest (drm_dp_mst_helper) [284.631502] Starting subtest: drm_dp_mst_helper [284.658631] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [284.760080] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.102s) [284.769204] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [284.901276] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.141s) [284.911674] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [285.058822] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.157s) [285.061245] Subtest drm_dp_mst_helper: SUCCESS (0.432s) [285.268355] [092/130] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [285.363078] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [292.492747] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.132s) [292.651473] [093/130] (725s left) prime_vgem (basic-gtt) [292.725326] Starting subtest: basic-gtt [292.730047] Subtest basic-gtt: SKIP (0.000s) [292.867206] [094/130] (725s left) kms_rotation_crc (primary-rotation-180) [292.956163] Starting subtest: primary-rotation-180 [299.951427] Subtest primary-rotation-180: SUCCESS (6.996s) [301.151413] [095/130] (717s left) kms_vblank (ts-continuation-modeset) [301.244102] Starting subtest: ts-continuation-modeset [301.245962] Starting dynamic subtest: pipe-A-eDP-1 [302.697746] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.454s) [302.712046] Starting dynamic subtest: pipe-D-eDP-1 [304.862041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s) [304.864405] Subtest ts-continuation-modeset: SUCCESS (3.619s) [305.691151] [096/130] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [305.783419] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [305.787710] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [305.909848] [097/130] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [306.004890] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [306.009084] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [306.128072] [098/130] (712s left) kms_addfb_basic (addfb25-4-tiled) [306.214177] Starting subtest: addfb25-4-tiled [306.216038] Subtest addfb25-4-tiled: SUCCESS (0.000s) [306.334625] [099/130] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [306.443264] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [306.447891] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [306.560841] [100/130] (712s left) kms_psr (pr-sprite-render) [306.649705] Starting subtest: pr-sprite-render [306.653455] Subtest pr-sprite-render: SKIP (0.000s) [306.734971] [101/130] (712s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [306.782798] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [306.840697] [102/130] (712s left) dmabuf_sync_file (import-basic) [306.878485] Starting subtest: import-basic [306.880485] Subtest import-basic: SUCCESS (0.001s) [306.945206] [103/130] (712s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [307.041609] Starting subtest: plane-all-transition-nonblocking-fencing [307.043543] Starting dynamic subtest: pipe-A-eDP-1 [309.542735] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [309.845895] Starting dynamic subtest: pipe-B-eDP-1 [313.102242] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.265s) [313.397319] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.357s) [314.235934] [104/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [314.337227] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [336.263334] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.929s) [336.429375] [105/130] (682s left) gem_exec_balancer (full-pulse) [336.495719] Starting subtest: full-pulse [340.783069] Subtest full-pulse: SUCCESS (4.286s) [341.151583] [106/130] (677s left) gem_mmap_offset (mmap-boundaries) [341.208973] Starting subtest: mmap-boundaries [341.211386] Starting dynamic subtest: smem0 [341.484536] Dynamic subtest smem0: SUCCESS (0.277s) [341.487161] Subtest mmap-boundaries: SUCCESS (0.278s) [341.619251] [107/130] (677s left) gem_madvise (dontneed-after-mmap) [341.652476] Starting subtest: dontneed-after-mmap [341.677736] Subtest dontneed-after-mmap: SUCCESS (0.027s) [341.812136] [108/130] (677s left) gem_exec_whisper (basic-fds) [341.871306] Starting subtest: basic-fds [348.977239] Subtest basic-fds: SUCCESS (7.106s) [349.181970] [109/130] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [349.285536] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [349.289758] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [349.388425] [110/130] (669s left) i915_drm_fdinfo (memory-info-idle) [349.428790] Starting subtest: memory-info-idle [349.431018] Starting dynamic subtest: smem0 [349.495836] Dynamic subtest smem0: SUCCESS (0.067s) [349.498237] Subtest memory-info-idle: SUCCESS (0.068s) [349.576974] [111/130] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [349.677679] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [349.682076] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [349.808220] [112/130] (669s left) gem_sync (basic-each) [349.887805] Starting subtest: basic-each [352.461064] Subtest basic-each: SUCCESS (2.584s) [352.659229] [113/130] (666s left) kms_psr (fbc-pr-primary-page-flip) [352.749018] Starting subtest: fbc-pr-primary-page-flip [352.753346] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [352.830628] [114/130] (666s left) gem_exec_schedule (promotion) [352.889719] Starting subtest: promotion [352.891574] Starting dynamic subtest: rcs0 [352.985663] Dynamic subtest rcs0: SUCCESS (0.101s) [352.998423] Starting dynamic subtest: vcs0 [353.067590] Dynamic subtest vcs0: SUCCESS (0.082s) [353.079652] Starting dynamic subtest: vcs1 [353.149690] Dynamic subtest vcs1: SUCCESS (0.082s) [353.162757] Starting dynamic subtest: vecs0 [353.235393] Dynamic subtest vecs0: SUCCESS (0.085s) [353.246828] Starting dynamic subtest: ccs0 [353.323518] Dynamic subtest ccs0: SUCCESS (0.086s) [353.326091] Subtest promotion: SUCCESS (0.440s) [355.006851] [115/130] (664s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [355.101243] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [356.025039] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.925s) [356.154388] [116/130] (663s left) gem_userptr_blits (invalid-null-pointer) [356.213260] Starting subtest: invalid-null-pointer [356.215241] Subtest invalid-null-pointer: SUCCESS (0.001s) [356.364906] [117/130] (663s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [356.453830] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [356.455368] Starting dynamic subtest: pipe-A-default-mode [357.614323] Dynamic subtest pipe-A-default-mode: SKIP (1.156s) [357.618719] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.157s) [357.783110] [118/130] (661s left) gem_wait (wait) [357.856436] Starting subtest: wait [357.858688] Starting dynamic subtest: all-engines [359.891245] Dynamic subtest all-engines: SUCCESS (2.033s) [359.904026] Starting dynamic subtest: rcs0 [360.937092] Dynamic subtest rcs0: SUCCESS (1.045s) [360.948168] Starting dynamic subtest: bcs0 [361.984937] Dynamic subtest bcs0: SUCCESS (1.046s) [361.996271] Starting dynamic subtest: vcs0 [363.030156] Dynamic subtest vcs0: SUCCESS (1.043s) [363.041447] Starting dynamic subtest: vcs1 [364.076044] Dynamic subtest vcs1: SUCCESS (1.044s) [364.086825] Starting dynamic subtest: vecs0 [365.121111] Dynamic subtest vecs0: SUCCESS (1.043s) [365.132077] Starting dynamic subtest: ccs0 [366.168154] Dynamic subtest ccs0: SUCCESS (1.045s) [366.170588] Subtest wait: SUCCESS (8.312s) [366.393089] [119/130] (653s left) kms_big_fb (x-tiled-64bpp-rotate-90) [366.488708] Starting subtest: x-tiled-64bpp-rotate-90 [366.508080] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [366.668068] [120/130] (653s left) gem_softpin (full) [366.721848] Starting subtest: full [366.728415] Subtest full: SUCCESS (0.007s) [366.888607] [121/130] (652s left) kms_color (ctm-0-50) [366.984957] Starting subtest: ctm-0-50 [366.987204] Starting dynamic subtest: pipe-A-eDP-1 [370.361279] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.376s) [370.372323] Starting dynamic subtest: pipe-B-eDP-1 [374.477684] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.115s) [374.487274] Starting dynamic subtest: pipe-C-eDP-1 [378.423341] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.946s) [378.433063] Starting dynamic subtest: pipe-D-eDP-1 [382.401339] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.976s) [382.403795] Subtest ctm-0-50: SUCCESS (15.415s) [383.277195] [122/130] (636s left) vgem_basic (sysfs) [383.320025] Starting subtest: sysfs [383.321901] Subtest sysfs: SUCCESS (0.000s) [383.386891] [123/130] (636s left) core_getversion (basic) [383.422871] Starting subtest: basic [383.426765] Subtest basic: SUCCESS (0.000s) [383.498737] [124/130] (636s left) gem_eio (in-flight-internal-10ms) [383.703670] Starting subtest: in-flight-internal-10ms [384.976968] Subtest in-flight-internal-10ms: SUCCESS (1.273s) [385.111549] [125/130] (634s left) gem_spin_batch (legacy-resubmit) [385.171717] Starting subtest: legacy-resubmit [385.174071] Starting dynamic subtest: default [385.178839] Dynamic subtest default: SUCCESS (0.007s) [385.187435] Starting dynamic subtest: render [385.189900] Dynamic subtest render: SUCCESS (0.001s) [385.198837] Starting dynamic subtest: bsd [385.200883] Dynamic subtest bsd: SUCCESS (0.003s) [385.208977] Starting dynamic subtest: bsd1 [385.210859] Dynamic subtest bsd1: SUCCESS (0.002s) [385.218992] Starting dynamic subtest: bsd2 [385.220967] Dynamic subtest bsd2: SUCCESS (0.001s) [385.229113] Starting dynamic subtest: blt [385.231084] Dynamic subtest blt: SUCCESS (0.003s) [385.238976] Starting dynamic subtest: vebox [385.240914] Dynamic subtest vebox: SUCCESS (0.002s) [385.242820] Subtest legacy-resubmit: SUCCESS (0.023s) [385.440501] [126/130] (634s left) kms_chamelium_frames (dp-crc-multiple) [385.837453] Subtest dp-crc-multiple: SKIP (0.000s) [386.680228] [127/130] (633s left) perf_pmu (pmu-read) [386.727791] Starting subtest: pmu-read [386.729808] Subtest pmu-read: SUCCESS (0.002s) [386.846271] [128/130] (633s left) kms_rotation_crc (cursor-rotation-180) [386.937707] Starting subtest: cursor-rotation-180 [388.450099] Subtest cursor-rotation-180: SUCCESS (1.513s) [389.705450] [129/130] (630s left) perf_pmu (busy-hang) [389.747441] Starting subtest: busy-hang [389.749698] Starting dynamic subtest: rcs0 [391.016074] Dynamic subtest rcs0: SUCCESS (1.266s) [391.026824] Starting dynamic subtest: bcs0 [392.228227] Dynamic subtest bcs0: SUCCESS (1.211s) [392.238121] Starting dynamic subtest: vcs0 [394.388132] Dynamic subtest vcs0: SUCCESS (2.161s) [394.397476] Starting dynamic subtest: vcs1 [396.435281] Dynamic subtest vcs1: SUCCESS (2.045s) [396.446508] Starting dynamic subtest: vecs0 [398.422965] Dynamic subtest vecs0: SUCCESS (1.987s) [398.434410] Starting dynamic subtest: ccs0 [399.654088] Dynamic subtest ccs0: SUCCESS (1.226s) [399.656524] Subtest busy-hang: SUCCESS (9.904s) [399.766775] [130/130] (620s left) gem_exec_schedule (u-lateslice) [399.842143] Starting subtest: u-lateslice [399.844027] Starting dynamic subtest: rcs0 [399.860174] Dynamic subtest rcs0: SUCCESS (0.027s) [399.873272] Starting dynamic subtest: bcs0 [399.883283] Dynamic subtest bcs0: SUCCESS (0.022s) [399.895744] Starting dynamic subtest: vcs0 [399.907023] Dynamic subtest vcs0: SUCCESS (0.024s) [399.919227] Starting dynamic subtest: vcs1 [399.928960] Dynamic subtest vcs1: SUCCESS (0.021s) [399.938503] Starting dynamic subtest: vecs0 [399.949888] Dynamic subtest vecs0: SUCCESS (0.021s) [399.958860] Starting dynamic subtest: ccs0 [399.972874] Dynamic subtest ccs0: SUCCESS (0.022s) [399.975117] Subtest u-lateslice: SUCCESS (0.140s) [401.997513] 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.