[56.047160] Initializing watchdogs [56.047284] /dev/watchdog0 [56.062806] [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.067345] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.069803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.073176] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [56.199985] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [56.204573] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [56.339105] [002/130] (960s left) kms_pm_dc (dc6-dpms) [57.442749] Starting subtest: dc6-dpms [59.485402] Subtest dc6-dpms: SUCCESS (2.021s) [59.568691] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [59.682114] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [59.686792] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [59.794869] [004/130] (956s left) gem_exec_balancer (invalid-balancer) [59.862512] Starting subtest: invalid-balancer [60.755511] Subtest invalid-balancer: SUCCESS (0.885s) [61.077451] [005/130] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [61.187269] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [61.191523] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [61.318185] [006/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd) [61.380889] Starting subtest: invalid-illegal-eventfd [61.383184] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [61.502874] [007/130] (955s left) prime_vgem (fence-write-hang) [61.599448] Subtest fence-write-hang: SKIP (0.000s) [61.705989] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [61.709255] [008/130] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [61.797719] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [61.799671] Starting dynamic subtest: pipe-A-eDP-1 [61.971378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.165s) [61.980480] Starting dynamic subtest: pipe-B-eDP-1 [62.000632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [62.007136] Starting dynamic subtest: pipe-C-eDP-1 [62.023002] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [62.029112] Starting dynamic subtest: pipe-D-eDP-1 [62.045244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [62.046801] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.171s) [64.233840] [009/130] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [64.332173] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [64.336900] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [65.482177] [010/130] (951s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [65.589413] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [65.593306] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [65.725647] [011/130] (951s left) perf (sysctl-defaults) [65.815172] Starting subtest: sysctl-defaults [65.818054] Subtest sysctl-defaults: SUCCESS (0.000s) [65.907757] [012/130] (951s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [66.006956] Starting subtest: plane-use-after-nonblocking-unbind-fencing [66.009320] Starting dynamic subtest: pipe-A-eDP-1 [66.076125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.071s) [66.376446] Starting dynamic subtest: pipe-B-eDP-1 [67.161101] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s) [67.458489] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.448s) [68.355220] [013/130] (948s left) kms_content_protection (dp-mst-type-0) [68.503997] Starting subtest: dp-mst-type-0 [68.508729] Subtest dp-mst-type-0: SKIP (0.000s) [68.656242] [014/130] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [68.759741] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [68.762117] Starting dynamic subtest: pipe-A-eDP-1 [68.782718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [68.791484] Starting dynamic subtest: pipe-B-eDP-1 [68.811107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [68.817843] Starting dynamic subtest: pipe-C-eDP-1 [68.837460] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [68.844773] Starting dynamic subtest: pipe-D-eDP-1 [68.865335] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [68.867329] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [71.002109] [015/130] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [71.298853] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [71.301481] Starting dynamic subtest: pipe-A-eDP-1 [71.362900] Dynamic subtest pipe-A-eDP-1: SKIP (0.004s) [71.371829] Starting dynamic subtest: pipe-B-eDP-1 [71.432735] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [71.441882] Starting dynamic subtest: pipe-C-eDP-1 [71.501889] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s) [71.510548] Starting dynamic subtest: pipe-D-eDP-1 [71.571512] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s) [71.576464] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.017s) [73.505183] [016/130] (943s left) gem_exec_reloc (basic-cpu) [73.568284] Subtest basic-cpu: SKIP (0.000s) [73.655196] [017/130] (943s left) kms_chamelium_hpd (dp-hpd-storm-disable) [74.045164] Subtest dp-hpd-storm-disable: SKIP (0.000s) [74.901956] [018/130] (942s left) syncobj_timeline (wait-for-submit-delayed-submit) [74.951677] Starting subtest: wait-for-submit-delayed-submit [75.055693] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [75.144058] [019/130] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [75.244335] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [75.248777] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [75.370956] [020/130] (941s left) gem_mmap_offset (bad-extensions) [75.423931] Starting subtest: bad-extensions [75.426325] Subtest bad-extensions: SUCCESS (0.000s) [75.533476] [021/130] (941s left) kms_lease (atomic-implicit-crtc) [75.629942] Starting subtest: atomic-implicit-crtc [75.632422] Starting dynamic subtest: pipe-A-eDP-1 [75.643736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [75.650872] Starting dynamic subtest: pipe-B-eDP-1 [75.661840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s) [75.670068] Starting dynamic subtest: pipe-C-eDP-1 [75.680557] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [75.687277] Starting dynamic subtest: pipe-D-eDP-1 [75.697786] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [75.699871] Subtest atomic-implicit-crtc: SUCCESS (0.031s) [75.778910] [022/130] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [75.880291] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [75.884301] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [75.987463] [023/130] (941s left) gem_partial_pwrite_pread (write) [76.049364] Subtest write: SKIP (0.000s) [76.108343] [024/130] (941s left) kms_dither (fb-8bpc-vs-panel-8bpc) [76.203569] Starting subtest: fb-8bpc-vs-panel-8bpc [76.205591] Starting dynamic subtest: pipe-A-eDP-1 [77.591552] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.384s) [77.593814] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.385s) [78.399112] [025/130] (939s left) kms_flip (basic-flip-vs-modeset) [78.486857] Starting subtest: basic-flip-vs-modeset [78.489175] Starting dynamic subtest: A-eDP1 [81.100988] Dynamic subtest A-eDP1: SUCCESS (2.613s) [81.111727] Starting dynamic subtest: B-eDP1 [83.249673] Dynamic subtest B-eDP1: SUCCESS (2.146s) [83.256881] Starting dynamic subtest: C-eDP1 [85.407998] Dynamic subtest C-eDP1: SUCCESS (2.157s) [85.415373] Starting dynamic subtest: D-eDP1 [87.578372] Dynamic subtest D-eDP1: SUCCESS (2.168s) [87.580781] Subtest basic-flip-vs-modeset: SUCCESS (9.090s) [88.385138] [026/130] (929s left) gem_bad_reloc (negative-reloc-bltcopy) [88.444851] Subtest negative-reloc-bltcopy: SKIP (0.000s) [88.534169] [027/130] (929s left) i915_drm_fdinfo (busy-check-all) [88.571660] Starting subtest: busy-check-all [88.574065] Starting dynamic subtest: rcs0 [88.578421] Dynamic subtest rcs0: SKIP (0.004s) [88.587368] Starting dynamic subtest: bcs0 [88.591786] Dynamic subtest bcs0: SKIP (0.000s) [88.599226] Starting dynamic subtest: vcs0 [88.603193] Dynamic subtest vcs0: SKIP (0.000s) [88.610175] Starting dynamic subtest: vcs1 [88.614642] Dynamic subtest vcs1: SKIP (0.000s) [88.621595] Starting dynamic subtest: vecs0 [88.625846] Dynamic subtest vecs0: SKIP (0.000s) [88.632734] Starting dynamic subtest: ccs0 [88.636870] Dynamic subtest ccs0: SKIP (0.000s) [88.641152] Subtest busy-check-all: SKIP (0.006s) [88.674977] [028/130] (928s left) gem_ccs (block-multicopy-inplace) [88.784718] Starting subtest: block-multicopy-inplace [88.789396] Subtest block-multicopy-inplace: SKIP (0.000s) [88.896755] [029/130] (928s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [88.987090] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [88.989393] Starting dynamic subtest: pipe-A [89.338943] Dynamic subtest pipe-A: SUCCESS (0.352s) [89.346655] Starting dynamic subtest: pipe-B [90.790641] Dynamic subtest pipe-B: SUCCESS (1.450s) [90.797926] Starting dynamic subtest: pipe-C [92.185934] Dynamic subtest pipe-C: SUCCESS (1.394s) [92.193288] Starting dynamic subtest: pipe-D [93.617279] Dynamic subtest pipe-D: SUCCESS (1.431s) [93.619533] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.628s) [94.811080] [030/130] (922s left) gem_exec_reloc (basic-cpu-read-noreloc) [94.874423] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [94.951466] [031/130] (922s left) syncobj_basic (bad-destroy) [95.011935] Starting subtest: bad-destroy [95.014236] Subtest bad-destroy: SUCCESS (0.000s) [95.129122] [032/130] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [95.229941] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [98.930220] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.703s) [100.119114] [033/130] (917s left) i915_pm_freq_api (freq-reset) [100.179422] Starting subtest: freq-reset [100.181822] Starting dynamic subtest: gt0 [100.353373] Dynamic subtest gt0: SUCCESS (0.172s) [100.361234] Starting dynamic subtest: gt1 [100.500203] Dynamic subtest gt1: SUCCESS (0.146s) [100.502978] Subtest freq-reset: SUCCESS (0.319s) [100.582908] [034/130] (917s left) i915_pm_rps (fence-order) [100.644389] Starting subtest: fence-order [103.519721] Subtest fence-order: SUCCESS (2.872s) [103.596257] [035/130] (914s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [103.656978] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [103.659264] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [103.763020] [036/130] (914s left) gem_readwrite (beyond-eob) [103.819074] Subtest beyond-EOB: SKIP (0.000s) [103.887817] [037/130] (914s left) gem_media_vme [104.016943] [038/130] (913s left) gem_exec_reloc (basic-wc-gtt-active) [104.086764] Subtest basic-wc-gtt-active: SKIP (0.000s) [104.166516] [039/130] (913s left) gem_mmap_wc (read) [104.217881] Subtest read: SKIP (0.000s) [104.285559] [040/130] (913s left) kms_atomic_transition (modeset-transition-nonblocking) [104.379679] Starting subtest: modeset-transition-nonblocking [104.381646] Starting dynamic subtest: 1x-outputs [114.996205] Dynamic subtest 1x-outputs: SUCCESS (10.613s) [115.273428] Subtest modeset-transition-nonblocking: SUCCESS (10.892s) [116.145084] [041/130] (901s left) gem_ctx_shared (q-out-order) [116.195306] Starting subtest: Q-out-order [116.197735] Starting dynamic subtest: rcs0 [116.293672] Dynamic subtest rcs0: SUCCESS (0.097s) [116.309973] Starting dynamic subtest: vcs0 [116.370091] Dynamic subtest vcs0: SUCCESS (0.077s) [116.386642] Starting dynamic subtest: vcs1 [116.444440] Dynamic subtest vcs1: SUCCESS (0.074s) [116.461544] Starting dynamic subtest: vecs0 [116.517961] Dynamic subtest vecs0: SUCCESS (0.073s) [116.533566] Starting dynamic subtest: ccs0 [116.594069] Dynamic subtest ccs0: SUCCESS (0.076s) [116.596849] Subtest Q-out-order: SUCCESS (0.398s) [118.032858] [042/130] (900s left) kms_flip (2x-flip-vs-panning-interruptible) [118.130993] Starting subtest: 2x-flip-vs-panning-interruptible [118.142329] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [118.229396] [043/130] (899s left) gem_exec_fence (syncobj-timeline-repeat) [118.749667] Starting subtest: syncobj-timeline-repeat [118.972885] Subtest syncobj-timeline-repeat: SUCCESS (0.223s) [119.976274] [044/130] (898s left) gem_pxp (create-regular-buffer) [120.097960] Starting subtest: create-regular-buffer [120.100021] Subtest create-regular-buffer: SUCCESS (0.000s) [120.234443] [045/130] (898s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [125.238411] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [125.242983] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [126.108491] [046/130] (892s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [131.173180] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [131.175464] Starting dynamic subtest: pipe-A-eDP-1 [131.964961] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s) [131.973988] Starting dynamic subtest: pipe-B-eDP-1 [133.096139] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [133.101136] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.922s) [134.300584] [047/130] (884s left) kms_hdr (brightness-with-hdr) [134.400798] Starting subtest: brightness-with-hdr [134.407155] Subtest brightness-with-hdr: SKIP (0.000s) [134.497016] [048/130] (883s left) kms_getfb (getfb-handle-closed) [134.598074] Starting subtest: getfb-handle-closed [134.600365] Subtest getfb-handle-closed: SUCCESS (0.000s) [134.728833] [049/130] (883s left) gem_close_race (basic-threads) [134.787641] Starting subtest: basic-threads [136.086650] Subtest basic-threads: SUCCESS (1.299s) [136.281675] [050/130] (882s left) kms_vrr (flipline) [136.375211] Starting subtest: flipline [136.381697] Subtest flipline: SKIP (0.000s) [136.458998] [051/130] (882s left) kms_plane_multiple (2x-tiling-none) [136.550854] Starting subtest: 2x-tiling-none [136.555355] Subtest 2x-tiling-none: SKIP (0.000s) [136.639668] [052/130] (881s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [136.748331] Starting subtest: fbc-1p-pri-indfb-multidraw [149.901267] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.155s) [151.088116] [053/130] (867s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [151.203205] Starting subtest: cursorB-vs-flipB-atomic-transitions [151.207853] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [151.371977] [054/130] (867s left) gem_mmap_wc (coherency) [151.430520] Subtest coherency: SKIP (0.000s) [151.486979] [055/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [151.586590] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [151.590614] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [151.692331] [056/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [151.787270] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [151.791507] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [151.881794] [057/130] (866s left) gem_exec_fence (invalid-fence-array) [152.318569] Starting subtest: invalid-fence-array [152.323937] Subtest invalid-fence-array: SUCCESS (0.003s) [154.042249] [058/130] (864s left) api_intel_bb (destroy-bb) [154.099389] Starting subtest: destroy-bb [154.104495] Subtest destroy-bb: SUCCESS (0.008s) [154.243408] [059/130] (864s left) kms_cursor_crc (cursor-rapid-movement-256x256) [154.486422] Starting subtest: cursor-rapid-movement-256x256 [154.490852] Starting dynamic subtest: pipe-A-eDP-1 [155.037271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s) [155.065591] Starting dynamic subtest: pipe-D-eDP-1 [156.283907] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s) [156.286267] Subtest cursor-rapid-movement-256x256: SUCCESS (1.798s) [157.144321] [060/130] (861s left) kms_big_fb (y-tiled-16bpp-rotate-0) [157.260312] Starting subtest: y-tiled-16bpp-rotate-0 [157.264316] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [157.383090] [061/130] (861s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [157.485812] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [157.487667] Starting dynamic subtest: A-eDP1 [166.384728] Dynamic subtest A-eDP1: SUCCESS (8.898s) [166.393506] Starting dynamic subtest: B-eDP1 [175.316635] Dynamic subtest B-eDP1: SUCCESS (8.930s) [175.325323] Starting dynamic subtest: C-eDP1 [184.281267] Dynamic subtest C-eDP1: SUCCESS (8.916s) [184.291629] Starting dynamic subtest: D-eDP1 [193.073818] Dynamic subtest D-eDP1: SUCCESS (8.836s) [193.080103] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.591s) [194.316421] [062/130] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [194.418695] Starting subtest: fbcpsr-rgb101010-draw-blt [201.145075] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.728s) [201.289494] [063/130] (817s left) kms_psr (pr-cursor-plane-move) [201.389093] Starting subtest: pr-cursor-plane-move [201.393221] Subtest pr-cursor-plane-move: SKIP (0.000s) [201.474896] [064/130] (817s left) gem_exec_schedule (out-order) [201.550374] Starting subtest: out-order [201.552789] Starting dynamic subtest: rcs0 [201.645055] Dynamic subtest rcs0: SUCCESS (0.102s) [201.656440] Starting dynamic subtest: vcs0 [201.722647] Dynamic subtest vcs0: SUCCESS (0.077s) [201.733871] Starting dynamic subtest: vcs1 [201.804821] Dynamic subtest vcs1: SUCCESS (0.082s) [201.816147] Starting dynamic subtest: vecs0 [201.888685] Dynamic subtest vecs0: SUCCESS (0.084s) [201.897937] Starting dynamic subtest: ccs0 [201.975923] Dynamic subtest ccs0: SUCCESS (0.087s) [201.978841] Subtest out-order: SUCCESS (0.434s) [203.016359] [065/130] (816s left) kms_plane_scaling (2x-scaler-multi-pipe) [203.114690] Starting subtest: 2x-scaler-multi-pipe [203.119234] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [203.223369] [066/130] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [203.324192] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [206.968282] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.648s) [208.167218] [067/130] (810s left) kms_fb_coherency (memset-crc) [208.267710] Starting subtest: memset-crc [208.270436] Starting dynamic subtest: mmap-offset-wc [208.640307] Dynamic subtest mmap-offset-wc: SUCCESS (0.375s) [208.934302] Starting dynamic subtest: mmap-offset-uc [215.030447] Dynamic subtest mmap-offset-uc: SUCCESS (6.108s) [215.315628] Subtest memset-crc: SUCCESS (7.049s) [216.201862] [068/130] (803s left) kms_chamelium_audio (dp-audio) [216.585523] Subtest dp-audio: SKIP (0.000s) [217.399556] [069/130] (801s left) gem_ctx_isolation (clean) [217.465066] Starting subtest: clean [217.467453] Starting dynamic subtest: rcs0 [217.531979] Dynamic subtest rcs0: SUCCESS (0.067s) [217.542354] Starting dynamic subtest: bcs0 [217.613165] Dynamic subtest bcs0: SUCCESS (0.080s) [217.623392] Starting dynamic subtest: vcs0 [217.708944] Dynamic subtest vcs0: SUCCESS (0.095s) [217.719844] Starting dynamic subtest: vcs1 [218.944014] Dynamic subtest vcs1: SUCCESS (1.234s) [218.952909] Starting dynamic subtest: vecs0 [220.930051] Dynamic subtest vecs0: SUCCESS (1.985s) [220.940143] Starting dynamic subtest: ccs0 [223.012190] Dynamic subtest ccs0: SUCCESS (2.052s) [223.014599] Subtest clean: SUCCESS (5.517s) [223.246557] [070/130] (796s left) kms_invalid_mode (bad-hsync-start) [223.338331] Starting subtest: bad-hsync-start [223.340697] Starting dynamic subtest: pipe-A-eDP-1 [223.621787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [223.630675] Starting dynamic subtest: pipe-B-eDP-1 [223.632650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [223.640609] Starting dynamic subtest: pipe-C-eDP-1 [223.642609] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [223.650921] Starting dynamic subtest: pipe-D-eDP-1 [223.653214] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [223.655439] Subtest bad-hsync-start: SUCCESS (0.292s) [224.465053] [071/130] (794s left) syncobj_timeline (etime-multi-wait-submitted) [224.522756] Starting subtest: etime-multi-wait-submitted [224.631977] Subtest etime-multi-wait-submitted: SUCCESS (0.108s) [224.730185] [072/130] (794s left) gem_ctx_persistence (legacy-engines-hostile) [224.786936] Starting subtest: legacy-engines-hostile [224.789353] Starting dynamic subtest: render [224.885271] Dynamic subtest render: SUCCESS (0.097s) [224.896440] Starting dynamic subtest: bsd1 [225.002710] Dynamic subtest bsd1: SUCCESS (0.116s) [225.014299] Starting dynamic subtest: bsd2 [225.124846] Dynamic subtest bsd2: SUCCESS (0.120s) [225.135615] Starting dynamic subtest: blt [225.243567] Dynamic subtest blt: SUCCESS (0.117s) [225.253950] Starting dynamic subtest: vebox [225.355467] Dynamic subtest vebox: SUCCESS (0.110s) [225.357844] Subtest legacy-engines-hostile: SUCCESS (0.569s) [225.446901] [073/130] (793s left) kms_psr (psr-primary-render) [225.546325] Starting subtest: psr-primary-render [225.548636] Starting dynamic subtest: eDP-1 [227.239873] Dynamic subtest eDP-1: SUCCESS (1.693s) [227.242276] Subtest psr-primary-render: SUCCESS (1.693s) [228.112323] [074/130] (791s left) gem_mmap_gtt (big-copy-xy) [228.169321] Subtest big-copy-XY: SKIP (0.000s) [228.237860] [075/130] (791s left) syncobj_basic (test-valid-cycle) [228.292146] Starting subtest: test-valid-cycle [228.294264] Subtest test-valid-cycle: SUCCESS (0.000s) [228.407721] [076/130] (791s left) kms_plane_alpha_blend (constant-alpha-max) [228.490471] Starting subtest: constant-alpha-max [228.784881] Starting dynamic subtest: pipe-A-eDP-1 [229.670297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.886s) [229.681137] Starting dynamic subtest: pipe-D-eDP-1 [231.296733] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.625s) [231.299339] Subtest constant-alpha-max: SUCCESS (2.809s) [232.189083] [077/130] (787s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [232.278710] Starting subtest: fbc-psr2-sprite-mmap-cpu [232.280917] Starting dynamic subtest: eDP-1 [232.285140] Dynamic subtest eDP-1: SKIP (0.000s) [232.289294] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [232.361439] [078/130] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [232.471147] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [239.068064] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.605s) [239.243539] [079/130] (780s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [239.340446] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [239.342699] Starting dynamic subtest: pipe-A [239.351703] Dynamic subtest pipe-A: SKIP (0.005s) [239.362299] Starting dynamic subtest: pipe-B [239.371438] Dynamic subtest pipe-B: SKIP (0.022s) [239.379613] Starting dynamic subtest: pipe-C [239.392480] Dynamic subtest pipe-C: SKIP (0.019s) [239.401041] Starting dynamic subtest: pipe-D [239.410468] Dynamic subtest pipe-D: SKIP (0.019s) [239.415041] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.067s) [239.535752] [080/130] (780s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [244.553251] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [244.555195] Starting dynamic subtest: pipe-A-eDP-1 [251.540368] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.987s) [251.557258] Starting dynamic subtest: pipe-B-eDP-1 [258.494637] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.951s) [258.496794] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.943s) [259.329571] [081/130] (760s left) syncobj_timeline (multi-wait-all-signaled) [259.399573] Starting subtest: multi-wait-all-signaled [259.401981] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [259.519865] [082/130] (760s left) kms_atomic (plane-invalid-params) [259.616241] Starting subtest: plane-invalid-params [259.618964] Starting dynamic subtest: pipe-A-eDP-1 [260.002481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s) [260.004807] Subtest plane-invalid-params: SUCCESS (0.389s) [260.860648] [083/130] (758s left) sriov_basic (bind-unbind-vf) [260.915594] Starting subtest: bind-unbind-vf [260.917588] Starting dynamic subtest: vf-1 [260.991733] Dynamic subtest vf-1: FAIL (0.006s) [261.002530] Starting dynamic subtest: vf-2 [261.075665] Dynamic subtest vf-2: FAIL (0.004s) [261.084316] Starting dynamic subtest: vf-3 [261.154666] Dynamic subtest vf-3: FAIL (0.003s) [261.164775] Starting dynamic subtest: vf-4 [261.238771] Dynamic subtest vf-4: FAIL (0.003s) [261.249636] Starting dynamic subtest: vf-5 [261.322747] Dynamic subtest vf-5: FAIL (0.004s) [261.332027] Starting dynamic subtest: vf-6 [261.404446] Dynamic subtest vf-6: FAIL (0.004s) [261.415078] Starting dynamic subtest: vf-7 [261.487896] Dynamic subtest vf-7: FAIL (0.003s) [261.496073] Starting dynamic subtest: vf-random [261.564880] Dynamic subtest vf-random: FAIL (0.004s) [261.574037] Starting dynamic subtest: vf-last [261.646287] Dynamic subtest vf-last: FAIL (0.509s) [261.648251] Subtest bind-unbind-vf: FAIL (0.545s) [261.685384] [084/130] (758s left) gem_exec_reloc (basic-cpu-read) [261.739425] Subtest basic-cpu-read: SKIP (0.000s) [261.812506] [085/130] (758s left) gem_render_copy (yf-tiled) [261.870115] Starting subtest: yf-tiled [261.873857] Subtest yf-tiled: SKIP (0.000s) [262.069511] [086/130] (757s left) kms_cursor_crc (cursor-random-256x256) [262.326491] Starting subtest: cursor-random-256x256 [262.328828] Starting dynamic subtest: pipe-A-eDP-1 [265.669049] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.340s) [265.697682] Starting dynamic subtest: pipe-D-eDP-1 [269.651093] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.961s) [269.653670] Subtest cursor-random-256x256: SUCCESS (7.324s) [270.536348] [087/130] (749s left) gem_mmap_gtt (basic-small-copy-xy) [270.594638] Subtest basic-small-copy-XY: SKIP (0.000s) [270.662233] [088/130] (749s left) kms_cursor_edge_walk (64x64-top-bottom) [270.742101] Starting subtest: 64x64-top-bottom [270.744278] Starting dynamic subtest: pipe-A-eDP-1 [274.187069] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s) [274.196672] Starting dynamic subtest: pipe-D-eDP-1 [277.308429] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s) [277.310638] Subtest 64x64-top-bottom: SUCCESS (6.565s) [278.134012] [089/130] (741s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [278.233638] Starting subtest: fbcpsr-stridechange [284.356836] Subtest fbcpsr-stridechange: SUCCESS (6.127s) [284.522735] [090/130] (735s left) kms_big_fb (x-tiled-64bpp-rotate-180) [284.631396] Starting subtest: x-tiled-64bpp-rotate-180 [286.254027] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.622s) [286.476946] [091/130] (733s left) kms_selftest (drm_dp_mst_helper) [286.514201] Starting subtest: drm_dp_mst_helper [286.541879] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [286.690203] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.147s) [286.700193] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [286.846277] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.156s) [286.854828] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [286.989854] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.142s) [286.991745] Subtest drm_dp_mst_helper: SUCCESS (0.474s) [287.176043] [092/130] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [287.272629] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [294.476053] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.206s) [294.625324] [093/130] (725s left) prime_vgem (basic-gtt) [294.718043] Starting subtest: basic-gtt [294.722655] Subtest basic-gtt: SKIP (0.000s) [294.844253] [094/130] (725s left) kms_rotation_crc (primary-rotation-180) [294.940066] Starting subtest: primary-rotation-180 [301.892642] Subtest primary-rotation-180: SUCCESS (6.954s) [303.140204] [095/130] (717s left) kms_vblank (ts-continuation-modeset) [303.229255] Starting subtest: ts-continuation-modeset [303.231128] Starting dynamic subtest: pipe-A-eDP-1 [304.690669] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.461s) [304.704520] Starting dynamic subtest: pipe-D-eDP-1 [306.832570] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.141s) [306.834976] Subtest ts-continuation-modeset: SUCCESS (3.606s) [307.651398] [096/130] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [307.750366] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [307.754447] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [307.879301] [097/130] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [307.976150] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [307.980155] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [308.094241] [098/130] (712s left) kms_addfb_basic (addfb25-4-tiled) [308.195328] Starting subtest: addfb25-4-tiled [308.197530] Subtest addfb25-4-tiled: SUCCESS (0.000s) [308.311444] [099/130] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [308.409637] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [308.413613] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [308.535922] [100/130] (711s left) kms_psr (pr-sprite-render) [308.633246] Starting subtest: pr-sprite-render [308.636876] Subtest pr-sprite-render: SKIP (0.000s) [308.734032] [101/130] (711s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [308.797277] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [308.867735] [102/130] (711s left) dmabuf_sync_file (import-basic) [308.908524] Starting subtest: import-basic [308.910326] Subtest import-basic: SUCCESS (0.002s) [308.987072] [103/130] (711s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [309.075380] Starting subtest: plane-all-transition-nonblocking-fencing [309.078764] Starting dynamic subtest: pipe-A-eDP-1 [311.577855] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [311.893477] Starting dynamic subtest: pipe-B-eDP-1 [315.079538] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.197s) [315.382887] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.305s) [316.208156] [104/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [316.313147] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [338.345703] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.036s) [338.516848] [105/130] (682s left) gem_exec_balancer (full-pulse) [338.587288] Starting subtest: full-pulse [342.788775] Subtest full-pulse: SUCCESS (4.201s) [343.124271] [106/130] (677s left) gem_mmap_offset (mmap-boundaries) [343.182832] Starting subtest: mmap-boundaries [343.185231] Starting dynamic subtest: smem0 [343.470227] Dynamic subtest smem0: SUCCESS (0.281s) [343.472877] Subtest mmap-boundaries: SUCCESS (0.282s) [343.619885] [107/130] (677s left) gem_madvise (dontneed-after-mmap) [343.653748] Starting subtest: dontneed-after-mmap [343.682519] Subtest dontneed-after-mmap: SUCCESS (0.028s) [343.815144] [108/130] (677s left) gem_exec_whisper (basic-fds) [343.869080] Starting subtest: basic-fds [351.861926] Subtest basic-fds: SUCCESS (7.988s) [352.069616] [109/130] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [352.175843] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [352.180016] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [352.314257] [110/130] (668s left) i915_drm_fdinfo (memory-info-idle) [352.350480] Starting subtest: memory-info-idle [352.352913] Starting dynamic subtest: smem0 [352.425584] Dynamic subtest smem0: SUCCESS (0.075s) [352.428240] Subtest memory-info-idle: SUCCESS (0.076s) [352.523907] [111/130] (668s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [352.618668] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [352.623035] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [352.750521] [112/130] (668s left) gem_sync (basic-each) [352.823441] Starting subtest: basic-each [355.114346] Subtest basic-each: SUCCESS (2.301s) [355.322325] [113/130] (665s left) kms_psr (fbc-pr-primary-page-flip) [355.435255] Starting subtest: fbc-pr-primary-page-flip [355.439868] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [355.520513] [114/130] (665s left) gem_exec_schedule (promotion) [355.589295] Starting subtest: promotion [355.591226] Starting dynamic subtest: rcs0 [355.682088] Dynamic subtest rcs0: SUCCESS (0.098s) [355.693621] Starting dynamic subtest: vcs0 [355.762788] Dynamic subtest vcs0: SUCCESS (0.079s) [355.773295] Starting dynamic subtest: vcs1 [355.851553] Dynamic subtest vcs1: SUCCESS (0.088s) [355.860454] Starting dynamic subtest: vecs0 [355.934435] Dynamic subtest vecs0: SUCCESS (0.082s) [355.945287] Starting dynamic subtest: ccs0 [356.018999] Dynamic subtest ccs0: SUCCESS (0.084s) [356.021295] Subtest promotion: SUCCESS (0.437s) [356.991993] [115/130] (664s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [357.090449] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [358.021985] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.933s) [358.179207] [116/130] (662s left) gem_userptr_blits (invalid-null-pointer) [358.251819] Starting subtest: invalid-null-pointer [358.254052] Subtest invalid-null-pointer: SUCCESS (0.001s) [358.418469] [117/130] (662s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [358.509636] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [358.511507] Starting dynamic subtest: pipe-A-default-mode [359.655646] Dynamic subtest pipe-A-default-mode: SKIP (1.143s) [359.660713] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.145s) [359.811071] [118/130] (661s left) gem_wait (wait) [359.885239] Starting subtest: wait [359.887696] Starting dynamic subtest: all-engines [361.940888] Dynamic subtest all-engines: SUCCESS (2.053s) [361.953963] Starting dynamic subtest: rcs0 [362.987431] Dynamic subtest rcs0: SUCCESS (1.046s) [362.999235] Starting dynamic subtest: bcs0 [364.034067] Dynamic subtest bcs0: SUCCESS (1.045s) [364.045396] Starting dynamic subtest: vcs0 [365.079366] Dynamic subtest vcs0: SUCCESS (1.044s) [365.090753] Starting dynamic subtest: vcs1 [366.125100] Dynamic subtest vcs1: SUCCESS (1.044s) [366.136289] Starting dynamic subtest: vecs0 [367.170282] Dynamic subtest vecs0: SUCCESS (1.043s) [367.181904] Starting dynamic subtest: ccs0 [368.217245] Dynamic subtest ccs0: SUCCESS (1.045s) [368.220533] Subtest wait: SUCCESS (8.332s) [368.428853] [119/130] (652s left) kms_big_fb (x-tiled-64bpp-rotate-90) [368.532441] Starting subtest: x-tiled-64bpp-rotate-90 [368.553069] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [368.701651] [120/130] (652s left) gem_softpin (full) [368.756368] Starting subtest: full [368.764236] Subtest full: SUCCESS (0.008s) [368.940405] [121/130] (652s left) kms_color (ctm-0-50) [369.039317] Starting subtest: ctm-0-50 [369.041526] Starting dynamic subtest: pipe-A-eDP-1 [372.451268] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s) [372.462110] Starting dynamic subtest: pipe-B-eDP-1 [376.585324] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.133s) [376.594627] Starting dynamic subtest: pipe-C-eDP-1 [380.546981] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.961s) [380.558060] Starting dynamic subtest: pipe-D-eDP-1 [384.556812] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.009s) [384.559183] Subtest ctm-0-50: SUCCESS (15.519s) [385.397920] [122/130] (636s left) vgem_basic (sysfs) [385.440576] Starting subtest: sysfs [385.442747] Subtest sysfs: SUCCESS (0.000s) [385.512668] [123/130] (635s left) core_getversion (basic) [385.544750] Starting subtest: basic [385.548689] Subtest basic: SUCCESS (0.000s) [385.633027] [124/130] (635s left) gem_eio (in-flight-internal-10ms) [385.847249] Starting subtest: in-flight-internal-10ms [386.960073] Subtest in-flight-internal-10ms: SUCCESS (1.112s) [387.108151] [125/130] (634s left) gem_spin_batch (legacy-resubmit) [387.174812] Starting subtest: legacy-resubmit [387.177024] Starting dynamic subtest: default [387.182368] Dynamic subtest default: SUCCESS (0.005s) [387.192412] Starting dynamic subtest: render [387.194587] Dynamic subtest render: SUCCESS (0.001s) [387.203166] Starting dynamic subtest: bsd [387.204946] Dynamic subtest bsd: SUCCESS (0.002s) [387.212791] Starting dynamic subtest: bsd1 [387.214610] Dynamic subtest bsd1: SUCCESS (0.001s) [387.222652] Starting dynamic subtest: bsd2 [387.224518] Dynamic subtest bsd2: SUCCESS (0.003s) [387.232385] Starting dynamic subtest: blt [387.234240] Dynamic subtest blt: SUCCESS (0.004s) [387.242073] Starting dynamic subtest: vebox [387.243919] Dynamic subtest vebox: SUCCESS (0.003s) [387.245812] Subtest legacy-resubmit: SUCCESS (0.024s) [387.469838] [126/130] (634s left) kms_chamelium_frames (dp-crc-multiple) [387.855723] Subtest dp-crc-multiple: SKIP (0.000s) [388.695194] [127/130] (632s left) perf_pmu (pmu-read) [388.736449] Starting subtest: pmu-read [388.741666] Subtest pmu-read: SUCCESS (0.003s) [388.865316] [128/130] (632s left) kms_rotation_crc (cursor-rotation-180) [388.956341] Starting subtest: cursor-rotation-180 [390.467789] Subtest cursor-rotation-180: SUCCESS (1.512s) [391.709616] [129/130] (629s left) perf_pmu (busy-hang) [391.751141] Starting subtest: busy-hang [391.753320] Starting dynamic subtest: rcs0 [393.010037] Dynamic subtest rcs0: SUCCESS (1.260s) [393.022180] Starting dynamic subtest: bcs0 [394.232066] Dynamic subtest bcs0: SUCCESS (1.220s) [394.243546] Starting dynamic subtest: vcs0 [396.442540] Dynamic subtest vcs0: SUCCESS (2.209s) [396.454030] Starting dynamic subtest: vcs1 [398.429904] Dynamic subtest vcs1: SUCCESS (1.983s) [398.439392] Starting dynamic subtest: vecs0 [400.412612] Dynamic subtest vecs0: SUCCESS (1.980s) [400.423505] Starting dynamic subtest: ccs0 [401.633079] Dynamic subtest ccs0: SUCCESS (1.218s) [401.635553] Subtest busy-hang: SUCCESS (9.880s) [401.734134] [130/130] (620s left) gem_exec_schedule (u-lateslice) [401.805574] Starting subtest: u-lateslice [401.807577] Starting dynamic subtest: rcs0 [401.820107] Dynamic subtest rcs0: SUCCESS (0.025s) [401.830560] Starting dynamic subtest: bcs0 [401.843716] Dynamic subtest bcs0: SUCCESS (0.023s) [401.854346] Starting dynamic subtest: vcs0 [401.864530] Dynamic subtest vcs0: SUCCESS (0.020s) [401.878272] Starting dynamic subtest: vcs1 [401.890940] Dynamic subtest vcs1: SUCCESS (0.024s) [401.901324] Starting dynamic subtest: vecs0 [401.910311] Dynamic subtest vecs0: SUCCESS (0.021s) [401.920111] Starting dynamic subtest: ccs0 [401.936031] Dynamic subtest ccs0: SUCCESS (0.025s) [401.938345] Subtest u-lateslice: SUCCESS (0.141s) [404.056610] 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.