[54.935323] Initializing watchdogs [54.935445] /dev/watchdog0 [54.952820] [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.957273] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.959236] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.960979] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [55.064938] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [55.066950] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [55.172337] [002/130] (960s left) kms_pm_dc (dc6-dpms) [56.272117] Starting subtest: dc6-dpms [58.357874] Subtest dc6-dpms: SUCCESS (2.075s) [58.421946] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [58.518354] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [58.520078] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [58.622882] [004/130] (956s left) gem_exec_balancer (invalid-balancer) [58.686836] Starting subtest: invalid-balancer [59.577191] Subtest invalid-balancer: SUCCESS (0.887s) [59.871194] [005/130] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [59.967679] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [59.969639] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.073288] [006/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd) [60.122292] Starting subtest: invalid-illegal-eventfd [60.123386] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [60.235809] [007/130] (955s left) prime_vgem (fence-write-hang) [60.324204] Subtest fence-write-hang: SKIP (0.000s) [60.419484] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [60.421167] [008/130] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [60.512623] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [60.513649] Starting dynamic subtest: pipe-A-eDP-1 [60.675093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.158s) [60.682318] Starting dynamic subtest: pipe-B-eDP-1 [60.690843] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [60.697542] Starting dynamic subtest: pipe-C-eDP-1 [60.705468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [60.710812] Starting dynamic subtest: pipe-D-eDP-1 [60.718550] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [60.719478] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.166s) [63.000727] [009/130] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [63.091622] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [63.093566] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [64.220040] [010/130] (951s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [64.305585] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [64.307313] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [64.425965] [011/130] (951s left) perf (sysctl-defaults) [64.492231] Starting subtest: sysctl-defaults [64.493201] Subtest sysctl-defaults: SUCCESS (0.000s) [64.565787] [012/130] (951s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [64.655097] Starting subtest: plane-use-after-nonblocking-unbind-fencing [64.656039] Starting dynamic subtest: pipe-A-eDP-1 [64.721975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s) [65.021413] Starting dynamic subtest: pipe-B-eDP-1 [65.821977] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.805s) [66.109158] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.452s) [66.986680] [013/130] (948s left) kms_content_protection (dp-mst-type-0) [67.124115] Starting subtest: dp-mst-type-0 [67.126139] Subtest dp-mst-type-0: SKIP (0.000s) [67.278331] [014/130] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [67.372313] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [67.373242] Starting dynamic subtest: pipe-A-eDP-1 [67.381070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [67.387794] Starting dynamic subtest: pipe-B-eDP-1 [67.395237] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [67.400765] Starting dynamic subtest: pipe-C-eDP-1 [67.408022] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [67.413502] Starting dynamic subtest: pipe-D-eDP-1 [67.420800] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [67.421661] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [69.582540] [015/130] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [69.663320] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [69.664243] Starting dynamic subtest: pipe-A-eDP-1 [69.686325] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [69.693576] Starting dynamic subtest: pipe-B-eDP-1 [69.714809] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [69.719965] Starting dynamic subtest: pipe-C-eDP-1 [69.740584] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [69.745806] Starting dynamic subtest: pipe-D-eDP-1 [69.766668] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [69.768289] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s) [71.883394] [016/130] (944s left) gem_exec_reloc (basic-cpu) [71.958893] Subtest basic-cpu: SKIP (0.000s) [72.044029] [017/130] (943s left) kms_chamelium_hpd (dp-hpd-storm-disable) [72.495856] Subtest dp-hpd-storm-disable: SKIP (0.000s) [73.265361] [018/130] (942s left) syncobj_timeline (wait-for-submit-delayed-submit) [73.314340] Starting subtest: wait-for-submit-delayed-submit [73.420054] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [73.508899] [019/130] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.602093] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.603829] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.717192] [020/130] (942s left) gem_mmap_offset (bad-extensions) [73.776145] Starting subtest: bad-extensions [73.777037] Subtest bad-extensions: SUCCESS (0.000s) [73.878714] [021/130] (942s left) kms_lease (atomic-implicit-crtc) [73.956567] Starting subtest: atomic-implicit-crtc [73.957626] Starting dynamic subtest: pipe-A-eDP-1 [73.962507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [73.968925] Starting dynamic subtest: pipe-B-eDP-1 [73.973460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s) [73.978791] Starting dynamic subtest: pipe-C-eDP-1 [73.983245] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [73.988792] Starting dynamic subtest: pipe-D-eDP-1 [73.992812] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [73.993677] Subtest atomic-implicit-crtc: SUCCESS (0.026s) [74.100789] [022/130] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [74.180062] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [74.181874] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [74.302726] [023/130] (941s left) gem_partial_pwrite_pread (write) [74.350745] Subtest write: SKIP (0.000s) [74.430745] [024/130] (941s left) kms_dither (fb-8bpc-vs-panel-8bpc) [74.514451] Starting subtest: fb-8bpc-vs-panel-8bpc [74.515475] Starting dynamic subtest: pipe-A-eDP-1 [75.853525] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.338s) [75.854451] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.339s) [76.677564] [025/130] (939s left) kms_flip (basic-flip-vs-modeset) [76.773669] Starting subtest: basic-flip-vs-modeset [76.775502] Starting dynamic subtest: A-eDP1 [79.355203] Dynamic subtest A-eDP1: SUCCESS (2.579s) [79.362726] Starting dynamic subtest: B-eDP1 [81.523035] Dynamic subtest B-eDP1: SUCCESS (2.165s) [81.529731] Starting dynamic subtest: C-eDP1 [83.610426] Dynamic subtest C-eDP1: SUCCESS (2.087s) [83.616985] Starting dynamic subtest: D-eDP1 [85.681918] Dynamic subtest D-eDP1: SUCCESS (2.071s) [85.683880] Subtest basic-flip-vs-modeset: SUCCESS (8.908s) [86.506148] [026/130] (929s left) gem_bad_reloc (negative-reloc-bltcopy) [86.565850] Subtest negative-reloc-bltcopy: SKIP (0.000s) [86.626528] [027/130] (929s left) i915_drm_fdinfo (busy-check-all) [86.656419] Starting subtest: busy-check-all [86.657527] Starting dynamic subtest: rcs0 [86.661945] Dynamic subtest rcs0: SKIP (0.004s) [86.669097] Starting dynamic subtest: bcs0 [86.670946] Dynamic subtest bcs0: SKIP (0.000s) [86.676446] Starting dynamic subtest: vcs0 [86.678282] Dynamic subtest vcs0: SKIP (0.000s) [86.683746] Starting dynamic subtest: vcs1 [86.685426] Dynamic subtest vcs1: SKIP (0.000s) [86.691601] Starting dynamic subtest: vecs0 [86.693218] Dynamic subtest vecs0: SKIP (0.000s) [86.698514] Starting dynamic subtest: ccs0 [86.700098] Dynamic subtest ccs0: SKIP (0.000s) [86.701663] Subtest busy-check-all: SKIP (0.006s) [86.729315] [028/130] (929s left) gem_ccs (block-multicopy-inplace) [86.812321] Starting subtest: block-multicopy-inplace [86.814339] Subtest block-multicopy-inplace: SKIP (0.000s) [86.935539] [029/130] (929s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [87.018182] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [87.019068] Starting dynamic subtest: pipe-A [87.357615] Dynamic subtest pipe-A: SUCCESS (0.340s) [87.365061] Starting dynamic subtest: pipe-B [88.781613] Dynamic subtest pipe-B: SUCCESS (1.424s) [88.787518] Starting dynamic subtest: pipe-C [90.217904] Dynamic subtest pipe-C: SUCCESS (1.436s) [90.225383] Starting dynamic subtest: pipe-D [91.676255] Dynamic subtest pipe-D: SUCCESS (1.458s) [91.677238] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.659s) [92.838411] [030/130] (923s left) gem_exec_reloc (basic-cpu-read-noreloc) [92.885064] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [92.955180] [031/130] (923s left) syncobj_basic (bad-destroy) [93.003753] Starting subtest: bad-destroy [93.004761] Subtest bad-destroy: SUCCESS (0.000s) [93.112175] [032/130] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [93.210454] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [96.955381] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.745s) [98.167284] [033/130] (918s left) i915_pm_freq_api (freq-reset) [98.225132] Starting subtest: freq-reset [98.226283] Starting dynamic subtest: gt0 [98.399173] Dynamic subtest gt0: SUCCESS (0.173s) [98.406152] Starting dynamic subtest: gt1 [98.547062] Dynamic subtest gt1: SUCCESS (0.145s) [98.548760] Subtest freq-reset: SUCCESS (0.319s) [98.640535] [034/130] (917s left) i915_pm_rps (fence-order) [98.686916] Starting subtest: fence-order [102.172564] Subtest fence-order: SUCCESS (3.485s) [102.234131] [035/130] (914s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [102.281682] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [102.282774] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [102.385331] [036/130] (914s left) gem_readwrite (beyond-eob) [102.434110] Subtest beyond-EOB: SKIP (0.000s) [102.495084] [037/130] (914s left) gem_media_vme [102.623786] [038/130] (913s left) gem_exec_reloc (basic-wc-gtt-active) [102.678435] Subtest basic-wc-gtt-active: SKIP (0.000s) [102.759496] [039/130] (913s left) gem_mmap_wc (read) [102.812864] Subtest read: SKIP (0.000s) [102.872455] [040/130] (913s left) kms_atomic_transition (modeset-transition-nonblocking) [102.966022] Starting subtest: modeset-transition-nonblocking [102.966931] Starting dynamic subtest: 1x-outputs [113.628567] Dynamic subtest 1x-outputs: SUCCESS (10.660s) [113.892831] Subtest modeset-transition-nonblocking: SUCCESS (10.926s) [114.758039] [041/130] (901s left) gem_ctx_shared (q-out-order) [114.816767] Starting subtest: Q-out-order [114.817954] Starting dynamic subtest: rcs0 [114.921934] Dynamic subtest rcs0: SUCCESS (0.104s) [114.938224] Starting dynamic subtest: vcs0 [114.997588] Dynamic subtest vcs0: SUCCESS (0.076s) [115.011628] Starting dynamic subtest: vcs1 [115.075487] Dynamic subtest vcs1: SUCCESS (0.078s) [115.089569] Starting dynamic subtest: vecs0 [115.148482] Dynamic subtest vecs0: SUCCESS (0.073s) [115.162474] Starting dynamic subtest: ccs0 [115.224746] Dynamic subtest ccs0: SUCCESS (0.075s) [115.226066] Subtest Q-out-order: SUCCESS (0.407s) [117.013440] [042/130] (899s left) kms_flip (2x-flip-vs-panning-interruptible) [117.105482] Starting subtest: 2x-flip-vs-panning-interruptible [117.117712] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [117.248432] [043/130] (899s left) gem_exec_fence (syncobj-timeline-repeat) [117.758482] Starting subtest: syncobj-timeline-repeat [117.983742] Subtest syncobj-timeline-repeat: SUCCESS (0.226s) [118.993829] [044/130] (897s left) gem_pxp (create-regular-buffer) [119.109408] Starting subtest: create-regular-buffer [119.110551] Subtest create-regular-buffer: SUCCESS (0.000s) [119.255596] [045/130] (897s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [124.243154] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [124.246735] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [125.098429] [046/130] (891s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [130.070283] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [130.071638] Starting dynamic subtest: pipe-A-eDP-1 [130.854370] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s) [130.863404] Starting dynamic subtest: pipe-B-eDP-1 [131.983020] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s) [131.984987] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.913s) [133.179534] [047/130] (883s left) kms_hdr (brightness-with-hdr) [133.276661] Starting subtest: brightness-with-hdr [133.279242] Subtest brightness-with-hdr: SKIP (0.001s) [133.370819] [048/130] (883s left) kms_getfb (getfb-handle-closed) [133.468148] Starting subtest: getfb-handle-closed [133.469071] Subtest getfb-handle-closed: SUCCESS (0.000s) [133.606553] [049/130] (883s left) gem_close_race (basic-threads) [133.659843] Starting subtest: basic-threads [135.014840] Subtest basic-threads: SUCCESS (1.355s) [135.218123] [050/130] (881s left) kms_vrr (flipline) [135.307037] Starting subtest: flipline [135.309657] Subtest flipline: SKIP (0.000s) [135.384340] [051/130] (881s left) kms_plane_multiple (2x-tiling-none) [135.470273] Starting subtest: 2x-tiling-none [135.471980] Subtest 2x-tiling-none: SKIP (0.000s) [135.550155] [052/130] (881s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [135.631946] Starting subtest: fbc-1p-pri-indfb-multidraw [148.816918] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.185s) [150.003469] [053/130] (867s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [150.112047] Starting subtest: cursorB-vs-flipB-atomic-transitions [150.114564] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [150.234773] [054/130] (866s left) gem_mmap_wc (coherency) [150.285870] Subtest coherency: SKIP (0.000s) [150.336221] [055/130] (866s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [150.423338] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [150.425098] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [150.534998] [056/130] (866s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [150.622228] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [150.623914] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [150.752059] [057/130] (866s left) gem_exec_fence (invalid-fence-array) [151.169714] Starting subtest: invalid-fence-array [151.174372] Subtest invalid-fence-array: SUCCESS (0.004s) [153.031287] [058/130] (864s left) api_intel_bb (destroy-bb) [153.081125] Starting subtest: destroy-bb [153.093206] Subtest destroy-bb: SUCCESS (0.011s) [153.219137] [059/130] (864s left) kms_cursor_crc (cursor-rapid-movement-256x256) [153.455549] Starting subtest: cursor-rapid-movement-256x256 [153.458884] Starting dynamic subtest: pipe-A-eDP-1 [153.986540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s) [154.011500] Starting dynamic subtest: pipe-D-eDP-1 [155.187846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s) [155.188963] Subtest cursor-rapid-movement-256x256: SUCCESS (1.730s) [156.065368] [060/130] (861s left) kms_big_fb (y-tiled-16bpp-rotate-0) [156.162725] Starting subtest: y-tiled-16bpp-rotate-0 [156.164458] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [156.296140] [061/130] (861s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [156.377194] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [156.379362] Starting dynamic subtest: A-eDP1 [165.293312] Dynamic subtest A-eDP1: SUCCESS (8.913s) [165.303470] Starting dynamic subtest: B-eDP1 [174.228251] Dynamic subtest B-eDP1: SUCCESS (8.933s) [174.236561] Starting dynamic subtest: C-eDP1 [183.151315] Dynamic subtest C-eDP1: SUCCESS (8.921s) [183.159942] Starting dynamic subtest: D-eDP1 [191.993939] Dynamic subtest D-eDP1: SUCCESS (8.841s) [191.997450] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.617s) [193.227733] [062/130] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [193.320052] Starting subtest: fbcpsr-rgb101010-draw-blt [200.063220] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.745s) [200.228189] [063/130] (817s left) kms_psr (pr-cursor-plane-move) [200.319450] Starting subtest: pr-cursor-plane-move [200.321244] Subtest pr-cursor-plane-move: SKIP (0.000s) [200.412442] [064/130] (817s left) gem_exec_schedule (out-order) [200.476452] Starting subtest: out-order [200.477481] Starting dynamic subtest: rcs0 [200.572276] Dynamic subtest rcs0: SUCCESS (0.095s) [200.581888] Starting dynamic subtest: vcs0 [200.649830] Dynamic subtest vcs0: SUCCESS (0.077s) [200.658235] Starting dynamic subtest: vcs1 [200.726717] Dynamic subtest vcs1: SUCCESS (0.076s) [200.735993] Starting dynamic subtest: vecs0 [200.801022] Dynamic subtest vecs0: SUCCESS (0.074s) [200.810390] Starting dynamic subtest: ccs0 [200.882629] Dynamic subtest ccs0: SUCCESS (0.081s) [200.883948] Subtest out-order: SUCCESS (0.406s) [202.049625] [065/130] (815s left) kms_plane_scaling (2x-scaler-multi-pipe) [202.147510] Starting subtest: 2x-scaler-multi-pipe [202.149402] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [202.269800] [066/130] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [202.367435] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [205.996996] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.630s) [207.177822] [067/130] (810s left) kms_fb_coherency (memset-crc) [207.270319] Starting subtest: memset-crc [207.271371] Starting dynamic subtest: mmap-offset-wc [207.623891] Dynamic subtest mmap-offset-wc: SUCCESS (0.354s) [207.912487] Starting dynamic subtest: mmap-offset-uc [214.010375] Dynamic subtest mmap-offset-uc: SUCCESS (6.105s) [214.297242] Subtest memset-crc: SUCCESS (7.026s) [215.098913] [068/130] (802s left) kms_chamelium_audio (dp-audio) [215.471631] Subtest dp-audio: SKIP (0.000s) [216.305530] [069/130] (801s left) gem_ctx_isolation (clean) [216.365762] Starting subtest: clean [216.366705] Starting dynamic subtest: rcs0 [216.425422] Dynamic subtest rcs0: SUCCESS (0.059s) [216.433976] Starting dynamic subtest: bcs0 [216.505908] Dynamic subtest bcs0: SUCCESS (0.080s) [216.514310] Starting dynamic subtest: vcs0 [216.576978] Dynamic subtest vcs0: SUCCESS (0.070s) [216.585048] Starting dynamic subtest: vcs1 [217.897314] Dynamic subtest vcs1: SUCCESS (1.320s) [217.904566] Starting dynamic subtest: vecs0 [219.975845] Dynamic subtest vecs0: SUCCESS (2.077s) [219.983773] Starting dynamic subtest: ccs0 [221.957481] Dynamic subtest ccs0: SUCCESS (1.982s) [221.958879] Subtest clean: SUCCESS (5.592s) [222.210685] [070/130] (795s left) kms_invalid_mode (bad-hsync-start) [222.313496] Starting subtest: bad-hsync-start [222.314393] Starting dynamic subtest: pipe-A-eDP-1 [222.601328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [222.608429] Starting dynamic subtest: pipe-B-eDP-1 [222.609359] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [222.616224] Starting dynamic subtest: pipe-C-eDP-1 [222.617227] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [222.623966] Starting dynamic subtest: pipe-D-eDP-1 [222.624896] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [222.625822] Subtest bad-hsync-start: SUCCESS (0.292s) [223.468755] [071/130] (794s left) syncobj_timeline (etime-multi-wait-submitted) [223.520400] Starting subtest: etime-multi-wait-submitted [223.627642] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [223.705413] [072/130] (793s left) gem_ctx_persistence (legacy-engines-hostile) [223.755854] Starting subtest: legacy-engines-hostile [223.756821] Starting dynamic subtest: render [223.856828] Dynamic subtest render: SUCCESS (0.100s) [223.868449] Starting dynamic subtest: bsd1 [223.978694] Dynamic subtest bsd1: SUCCESS (0.120s) [223.990390] Starting dynamic subtest: bsd2 [224.088329] Dynamic subtest bsd2: SUCCESS (0.107s) [224.099235] Starting dynamic subtest: blt [224.188271] Dynamic subtest blt: SUCCESS (0.097s) [224.198468] Starting dynamic subtest: vebox [224.299875] Dynamic subtest vebox: SUCCESS (0.109s) [224.301370] Subtest legacy-engines-hostile: SUCCESS (0.544s) [224.395451] [073/130] (793s left) kms_psr (psr-primary-render) [224.481433] Starting subtest: psr-primary-render [224.482394] Starting dynamic subtest: eDP-1 [226.183495] Dynamic subtest eDP-1: SUCCESS (1.701s) [226.184466] Subtest psr-primary-render: SUCCESS (1.702s) [227.063571] [074/130] (790s left) gem_mmap_gtt (big-copy-xy) [227.117033] Subtest big-copy-XY: SKIP (0.000s) [227.165580] [075/130] (790s left) syncobj_basic (test-valid-cycle) [227.214056] Starting subtest: test-valid-cycle [227.215445] Subtest test-valid-cycle: SUCCESS (0.000s) [227.318282] [076/130] (790s left) kms_plane_alpha_blend (constant-alpha-max) [227.414397] Starting subtest: constant-alpha-max [227.705936] Starting dynamic subtest: pipe-A-eDP-1 [228.592085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s) [228.599437] Starting dynamic subtest: pipe-D-eDP-1 [230.223227] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.631s) [230.224223] Subtest constant-alpha-max: SUCCESS (2.809s) [231.115095] [077/130] (786s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [231.211393] Starting subtest: fbc-psr2-sprite-mmap-cpu [231.212389] Starting dynamic subtest: eDP-1 [231.214211] Dynamic subtest eDP-1: SKIP (0.000s) [231.215874] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [231.307211] [078/130] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [231.396380] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [238.015585] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.618s) [238.156112] [079/130] (779s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [238.255458] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [238.256418] Starting dynamic subtest: pipe-A [238.262069] Dynamic subtest pipe-A: SKIP (0.005s) [238.269510] Starting dynamic subtest: pipe-B [238.279271] Dynamic subtest pipe-B: SKIP (0.016s) [238.286335] Starting dynamic subtest: pipe-C [238.295815] Dynamic subtest pipe-C: SKIP (0.016s) [238.302725] Starting dynamic subtest: pipe-D [238.311953] Dynamic subtest pipe-D: SKIP (0.016s) [238.313727] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.056s) [238.402132] [080/130] (779s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [243.405358] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [243.406224] Starting dynamic subtest: pipe-A-eDP-1 [250.471796] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.066s) [250.488808] Starting dynamic subtest: pipe-B-eDP-1 [257.545420] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.072s) [257.546433] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.141s) [258.391630] [081/130] (759s left) syncobj_timeline (multi-wait-all-signaled) [258.450566] Starting subtest: multi-wait-all-signaled [258.451427] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [258.580719] [082/130] (759s left) kms_atomic (plane-invalid-params) [258.674529] Starting subtest: plane-invalid-params [258.675521] Starting dynamic subtest: pipe-A-eDP-1 [259.060779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s) [259.061952] Subtest plane-invalid-params: SUCCESS (0.387s) [259.936869] [083/130] (758s left) sriov_basic (bind-unbind-vf) [259.986683] Starting subtest: bind-unbind-vf [259.987668] Starting dynamic subtest: vf-1 [260.015890] Dynamic subtest vf-1: FAIL (0.005s) [260.023834] Starting dynamic subtest: vf-2 [260.051078] Dynamic subtest vf-2: FAIL (0.004s) [260.058136] Starting dynamic subtest: vf-3 [260.085054] Dynamic subtest vf-3: FAIL (0.003s) [260.092051] Starting dynamic subtest: vf-4 [260.119051] Dynamic subtest vf-4: FAIL (0.004s) [260.125891] Starting dynamic subtest: vf-5 [260.153034] Dynamic subtest vf-5: FAIL (0.003s) [260.159905] Starting dynamic subtest: vf-6 [260.187286] Dynamic subtest vf-6: FAIL (0.004s) [260.193832] Starting dynamic subtest: vf-7 [260.222705] Dynamic subtest vf-7: FAIL (0.004s) [260.229492] Starting dynamic subtest: vf-random [260.255365] Dynamic subtest vf-random: FAIL (0.004s) [260.261917] Starting dynamic subtest: vf-last [260.287657] Dynamic subtest vf-last: FAIL (0.004s) [260.288447] Subtest bind-unbind-vf: FAIL (0.039s) [260.315398] [084/130] (757s left) gem_exec_reloc (basic-cpu-read) [260.371296] Subtest basic-cpu-read: SKIP (0.000s) [260.435205] [085/130] (757s left) gem_render_copy (yf-tiled) [260.491744] Starting subtest: yf-tiled [260.493768] Subtest yf-tiled: SKIP (0.000s) [260.698118] [086/130] (757s left) kms_cursor_crc (cursor-random-256x256) [260.917761] Starting subtest: cursor-random-256x256 [260.921741] Starting dynamic subtest: pipe-A-eDP-1 [264.250761] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.328s) [264.272878] Starting dynamic subtest: pipe-D-eDP-1 [268.226763] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.959s) [268.227689] Subtest cursor-random-256x256: SUCCESS (7.308s) [269.088986] [087/130] (749s left) gem_mmap_gtt (basic-small-copy-xy) [269.139528] Subtest basic-small-copy-XY: SKIP (0.000s) [269.194278] [088/130] (749s left) kms_cursor_edge_walk (64x64-top-bottom) [269.285164] Starting subtest: 64x64-top-bottom [269.285980] Starting dynamic subtest: pipe-A-eDP-1 [272.730970] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s) [272.739802] Starting dynamic subtest: pipe-D-eDP-1 [275.844230] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s) [275.845211] Subtest 64x64-top-bottom: SUCCESS (6.560s) [276.696082] [089/130] (741s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [276.791180] Starting subtest: fbcpsr-stridechange [282.904323] Subtest fbcpsr-stridechange: SUCCESS (6.114s) [283.056912] [090/130] (735s left) kms_big_fb (x-tiled-64bpp-rotate-180) [283.155444] Starting subtest: x-tiled-64bpp-rotate-180 [284.566138] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.411s) [284.726249] [091/130] (733s left) kms_selftest (drm_dp_mst_helper) [284.758452] Starting subtest: drm_dp_mst_helper [284.798999] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [284.943975] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.143s) [284.951256] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [285.063702] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.119s) [285.072480] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [285.186667] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.122s) [285.187533] Subtest drm_dp_mst_helper: SUCCESS (0.428s) [285.370449] [092/130] (732s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [285.458034] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [292.618596] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.162s) [292.774978] [093/130] (725s left) prime_vgem (basic-gtt) [292.851415] Starting subtest: basic-gtt [292.853497] Subtest basic-gtt: SKIP (0.000s) [292.952639] [094/130] (725s left) kms_rotation_crc (primary-rotation-180) [293.036899] Starting subtest: primary-rotation-180 [299.906979] Subtest primary-rotation-180: SUCCESS (6.872s) [301.086941] [095/130] (717s left) kms_vblank (ts-continuation-modeset) [301.172430] Starting subtest: ts-continuation-modeset [301.173313] Starting dynamic subtest: pipe-A-eDP-1 [302.652367] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.479s) [302.661254] Starting dynamic subtest: pipe-D-eDP-1 [304.811862] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.156s) [304.812844] Subtest ts-continuation-modeset: SUCCESS (3.640s) [305.618986] [096/130] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [305.709121] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [305.711069] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [305.821796] [097/130] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [305.910357] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [305.911915] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [306.042732] [098/130] (712s left) kms_addfb_basic (addfb25-4-tiled) [306.133477] Starting subtest: addfb25-4-tiled [306.134474] Subtest addfb25-4-tiled: SUCCESS (0.000s) [306.250368] [099/130] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [306.340438] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [306.342075] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [306.446934] [100/130] (712s left) kms_psr (pr-sprite-render) [306.537309] Starting subtest: pr-sprite-render [306.539377] Subtest pr-sprite-render: SKIP (0.000s) [306.628373] [101/130] (712s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [306.681707] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [306.737941] [102/130] (711s left) dmabuf_sync_file (import-basic) [306.766806] Starting subtest: import-basic [306.769065] Subtest import-basic: SUCCESS (0.002s) [306.829489] [103/130] (711s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [306.917590] Starting subtest: plane-all-transition-nonblocking-fencing [306.918484] Starting dynamic subtest: pipe-A-eDP-1 [309.418679] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s) [309.726456] Starting dynamic subtest: pipe-B-eDP-1 [312.951804] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.232s) [313.257187] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.340s) [314.086936] [104/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [314.180843] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [336.108155] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.927s) [336.263909] [105/130] (682s left) gem_exec_balancer (full-pulse) [336.327831] Starting subtest: full-pulse [340.851540] Subtest full-pulse: SUCCESS (4.523s) [341.205439] [106/130] (677s left) gem_mmap_offset (mmap-boundaries) [341.258980] Starting subtest: mmap-boundaries [341.260054] Starting dynamic subtest: smem0 [341.542463] Dynamic subtest smem0: SUCCESS (0.282s) [341.543789] Subtest mmap-boundaries: SUCCESS (0.283s) [341.671112] [107/130] (677s left) gem_madvise (dontneed-after-mmap) [341.697965] Starting subtest: dontneed-after-mmap [341.720411] Subtest dontneed-after-mmap: SUCCESS (0.023s) [341.853586] [108/130] (677s left) gem_exec_whisper (basic-fds) [341.901991] Starting subtest: basic-fds [349.816374] Subtest basic-fds: SUCCESS (7.910s) [350.002484] [109/130] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [350.102513] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [350.104247] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [350.195341] [110/130] (668s left) i915_drm_fdinfo (memory-info-idle) [350.226057] Starting subtest: memory-info-idle [350.227093] Starting dynamic subtest: smem0 [350.299497] Dynamic subtest smem0: SUCCESS (0.073s) [350.301460] Subtest memory-info-idle: SUCCESS (0.074s) [350.376107] [111/130] (668s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [350.473327] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [350.475247] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [350.594578] [112/130] (668s left) gem_sync (basic-each) [350.658029] Starting subtest: basic-each [353.244924] Subtest basic-each: SUCCESS (2.588s) [353.438414] [113/130] (665s left) kms_psr (fbc-pr-primary-page-flip) [353.538199] Starting subtest: fbc-pr-primary-page-flip [353.540119] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [353.617765] [114/130] (665s left) gem_exec_schedule (promotion) [353.676293] Starting subtest: promotion [353.677347] Starting dynamic subtest: rcs0 [353.778071] Dynamic subtest rcs0: SUCCESS (0.101s) [353.787619] Starting dynamic subtest: vcs0 [353.858418] Dynamic subtest vcs0: SUCCESS (0.080s) [353.868281] Starting dynamic subtest: vcs1 [353.939350] Dynamic subtest vcs1: SUCCESS (0.079s) [353.949726] Starting dynamic subtest: vecs0 [354.020687] Dynamic subtest vecs0: SUCCESS (0.081s) [354.028704] Starting dynamic subtest: ccs0 [354.103221] Dynamic subtest ccs0: SUCCESS (0.082s) [354.104306] Subtest promotion: SUCCESS (0.427s) [355.014846] [115/130] (664s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [355.108429] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [356.043343] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.935s) [356.208668] [116/130] (662s left) gem_userptr_blits (invalid-null-pointer) [356.269817] Starting subtest: invalid-null-pointer [356.270743] Subtest invalid-null-pointer: SUCCESS (0.001s) [356.424865] [117/130] (662s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [356.517572] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [356.518545] Starting dynamic subtest: pipe-A-default-mode [357.658939] Dynamic subtest pipe-A-default-mode: SKIP (1.140s) [357.660975] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.141s) [357.810210] [118/130] (661s left) gem_wait (wait) [357.873442] Starting subtest: wait [357.874642] Starting dynamic subtest: all-engines [359.895503] Dynamic subtest all-engines: SUCCESS (2.019s) [359.906281] Starting dynamic subtest: rcs0 [360.941928] Dynamic subtest rcs0: SUCCESS (1.047s) [360.953242] Starting dynamic subtest: bcs0 [361.990182] Dynamic subtest bcs0: SUCCESS (1.046s) [362.001918] Starting dynamic subtest: vcs0 [363.038722] Dynamic subtest vcs0: SUCCESS (1.045s) [363.050448] Starting dynamic subtest: vcs1 [364.086672] Dynamic subtest vcs1: SUCCESS (1.045s) [364.099635] Starting dynamic subtest: vecs0 [365.134332] Dynamic subtest vecs0: SUCCESS (1.046s) [365.145590] Starting dynamic subtest: ccs0 [366.183983] Dynamic subtest ccs0: SUCCESS (1.047s) [366.185486] Subtest wait: SUCCESS (8.310s) [366.397213] [119/130] (652s left) kms_big_fb (x-tiled-64bpp-rotate-90) [366.498248] Starting subtest: x-tiled-64bpp-rotate-90 [366.519192] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [366.648958] [120/130] (652s left) gem_softpin (full) [366.696420] Starting subtest: full [366.704952] Subtest full: SUCCESS (0.009s) [366.849979] [121/130] (652s left) kms_color (ctm-0-50) [366.939363] Starting subtest: ctm-0-50 [366.940429] Starting dynamic subtest: pipe-A-eDP-1 [370.336190] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.397s) [370.343639] Starting dynamic subtest: pipe-B-eDP-1 [374.340113] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.003s) [374.349953] Starting dynamic subtest: pipe-C-eDP-1 [378.272507] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.932s) [378.280639] Starting dynamic subtest: pipe-D-eDP-1 [382.274554] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.002s) [382.275727] Subtest ctm-0-50: SUCCESS (15.336s) [383.168141] [122/130] (636s left) vgem_basic (sysfs) [383.202574] Starting subtest: sysfs [383.203540] Subtest sysfs: SUCCESS (0.000s) [383.278344] [123/130] (636s left) core_getversion (basic) [383.307625] Starting subtest: basic [383.309419] Subtest basic: SUCCESS (0.000s) [383.379580] [124/130] (636s left) gem_eio (in-flight-internal-10ms) [383.589255] Starting subtest: in-flight-internal-10ms [384.976997] Subtest in-flight-internal-10ms: SUCCESS (1.387s) [385.134259] [125/130] (634s left) gem_spin_batch (legacy-resubmit) [385.201139] Starting subtest: legacy-resubmit [385.202279] Starting dynamic subtest: default [385.207077] Dynamic subtest default: SUCCESS (0.006s) [385.216325] Starting dynamic subtest: render [385.217246] Dynamic subtest render: SUCCESS (0.001s) [385.224601] Starting dynamic subtest: bsd [385.225553] Dynamic subtest bsd: SUCCESS (0.002s) [385.232929] Starting dynamic subtest: bsd1 [385.233899] Dynamic subtest bsd1: SUCCESS (0.001s) [385.240979] Starting dynamic subtest: bsd2 [385.241984] Dynamic subtest bsd2: SUCCESS (0.002s) [385.249087] Starting dynamic subtest: blt [385.249937] Dynamic subtest blt: SUCCESS (0.002s) [385.257048] Starting dynamic subtest: vebox [385.257878] Dynamic subtest vebox: SUCCESS (0.002s) [385.258708] Subtest legacy-resubmit: SUCCESS (0.020s) [385.488006] [126/130] (633s left) kms_chamelium_frames (dp-crc-multiple) [385.862248] Subtest dp-crc-multiple: SKIP (0.000s) [386.659484] [127/130] (632s left) perf_pmu (pmu-read) [386.694422] Starting subtest: pmu-read [386.697337] Subtest pmu-read: SUCCESS (0.003s) [386.826110] [128/130] (632s left) kms_rotation_crc (cursor-rotation-180) [386.920308] Starting subtest: cursor-rotation-180 [388.425203] Subtest cursor-rotation-180: SUCCESS (1.506s) [389.667431] [129/130] (629s left) perf_pmu (busy-hang) [389.701328] Starting subtest: busy-hang [389.702438] Starting dynamic subtest: rcs0 [390.983849] Dynamic subtest rcs0: SUCCESS (1.279s) [390.992934] Starting dynamic subtest: bcs0 [392.188352] Dynamic subtest bcs0: SUCCESS (1.203s) [392.197186] Starting dynamic subtest: vcs0 [394.454029] Dynamic subtest vcs0: SUCCESS (2.265s) [394.463842] Starting dynamic subtest: vcs1 [396.448912] Dynamic subtest vcs1: SUCCESS (1.993s) [396.459928] Starting dynamic subtest: vecs0 [398.424947] Dynamic subtest vecs0: SUCCESS (1.974s) [398.435949] Starting dynamic subtest: ccs0 [399.663293] Dynamic subtest ccs0: SUCCESS (1.235s) [399.664603] Subtest busy-hang: SUCCESS (9.961s) [399.786447] [130/130] (619s left) gem_exec_schedule (u-lateslice) [399.840074] Starting subtest: u-lateslice [399.841077] Starting dynamic subtest: rcs0 [399.869409] Dynamic subtest rcs0: SUCCESS (0.029s) [399.879523] Starting dynamic subtest: bcs0 [399.891407] Dynamic subtest bcs0: SUCCESS (0.022s) [399.898868] Starting dynamic subtest: vcs0 [399.912426] Dynamic subtest vcs0: SUCCESS (0.020s) [399.920378] Starting dynamic subtest: vcs1 [399.934699] Dynamic subtest vcs1: SUCCESS (0.022s) [399.941987] Starting dynamic subtest: vecs0 [399.956068] Dynamic subtest vecs0: SUCCESS (0.021s) [399.963691] Starting dynamic subtest: ccs0 [399.979590] Dynamic subtest ccs0: SUCCESS (0.023s) [399.980559] Subtest u-lateslice: SUCCESS (0.140s) [401.984880] 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.