[54.847979] Initializing watchdogs [54.848035] /dev/watchdog0 [54.861856] [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.865844] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.868154] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.871445] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [54.993647] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [54.997708] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [55.118720] [002/130] (960s left) kms_pm_dc (dc6-dpms) [56.218039] Starting subtest: dc6-dpms [58.317148] Subtest dc6-dpms: SUCCESS (2.131s) [58.411257] [003/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [58.520242] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [58.524493] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [58.637430] [004/130] (956s left) gem_exec_balancer (invalid-balancer) [58.706561] Starting subtest: invalid-balancer [59.545233] Subtest invalid-balancer: SUCCESS (0.849s) [59.865514] [005/130] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [59.968029] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [59.972193] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [60.098392] [006/130] (955s left) syncobj_eventfd (invalid-illegal-eventfd) [60.157743] Starting subtest: invalid-illegal-eventfd [60.160099] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [60.284181] [007/130] (955s left) prime_vgem (fence-write-hang) [60.403755] Subtest fence-write-hang: SKIP (0.000s) [60.532600] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [60.535503] [008/130] (955s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [60.630659] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [60.632484] Starting dynamic subtest: pipe-A-eDP-1 [60.798674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s) [60.807962] Starting dynamic subtest: pipe-B-eDP-1 [60.825802] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [60.832222] Starting dynamic subtest: pipe-C-eDP-1 [60.848142] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [60.854569] Starting dynamic subtest: pipe-D-eDP-1 [60.871123] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [60.873036] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.169s) [63.085560] [009/130] (952s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [63.172407] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [63.176969] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [64.316049] [010/130] (951s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [64.413799] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [64.417766] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [64.527168] [011/130] (951s left) perf (sysctl-defaults) [64.601870] Starting subtest: sysctl-defaults [64.604376] Subtest sysctl-defaults: SUCCESS (0.000s) [64.693239] [012/130] (951s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [64.784056] Starting subtest: plane-use-after-nonblocking-unbind-fencing [64.786301] Starting dynamic subtest: pipe-A-eDP-1 [64.857417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.073s) [65.161266] Starting dynamic subtest: pipe-B-eDP-1 [65.927780] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s) [66.221592] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.444s) [67.094177] [013/130] (948s left) kms_content_protection (dp-mst-type-0) [67.237843] Starting subtest: dp-mst-type-0 [67.242551] Subtest dp-mst-type-0: SKIP (0.000s) [67.399581] [014/130] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [67.490253] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [67.492583] Starting dynamic subtest: pipe-A-eDP-1 [67.513623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [67.522798] Starting dynamic subtest: pipe-B-eDP-1 [67.542262] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [67.549055] Starting dynamic subtest: pipe-C-eDP-1 [67.568617] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [67.576068] Starting dynamic subtest: pipe-D-eDP-1 [67.595662] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [67.597663] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [69.659849] [015/130] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [69.751219] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [69.753505] Starting dynamic subtest: pipe-A-eDP-1 [69.810796] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [69.818714] Starting dynamic subtest: pipe-B-eDP-1 [69.874707] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [69.883431] Starting dynamic subtest: pipe-C-eDP-1 [69.942378] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [69.950627] Starting dynamic subtest: pipe-D-eDP-1 [70.005051] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [70.009112] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [71.939370] [016/130] (943s left) gem_exec_reloc (basic-cpu) [72.018262] Subtest basic-cpu: SKIP (0.000s) [72.212391] [017/130] (943s left) kms_chamelium_hpd (dp-hpd-storm-disable) [72.597811] Subtest dp-hpd-storm-disable: SKIP (0.000s) [73.418432] [018/130] (942s left) syncobj_timeline (wait-for-submit-delayed-submit) [73.474977] Starting subtest: wait-for-submit-delayed-submit [73.579736] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [73.663166] [019/130] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [73.751820] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [73.756322] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [73.866184] [020/130] (942s left) gem_mmap_offset (bad-extensions) [73.918625] Starting subtest: bad-extensions [73.920706] Subtest bad-extensions: SUCCESS (0.000s) [74.048952] [021/130] (942s left) kms_lease (atomic-implicit-crtc) [74.137271] Starting subtest: atomic-implicit-crtc [74.139642] Starting dynamic subtest: pipe-A-eDP-1 [74.151317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [74.159761] Starting dynamic subtest: pipe-B-eDP-1 [74.170537] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s) [74.177394] Starting dynamic subtest: pipe-C-eDP-1 [74.187768] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [74.194432] Starting dynamic subtest: pipe-D-eDP-1 [74.204495] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s) [74.206382] Subtest atomic-implicit-crtc: SUCCESS (0.028s) [74.296938] [022/130] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [74.395965] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [74.400178] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [74.521696] [023/130] (941s left) gem_partial_pwrite_pread (write) [74.582222] Subtest write: SKIP (0.000s) [74.656996] [024/130] (941s left) kms_dither (fb-8bpc-vs-panel-8bpc) [74.746393] Starting subtest: fb-8bpc-vs-panel-8bpc [74.748522] Starting dynamic subtest: pipe-A-eDP-1 [76.091334] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.348s) [76.093864] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.348s) [76.903199] [025/130] (939s left) kms_flip (basic-flip-vs-modeset) [77.000419] Starting subtest: basic-flip-vs-modeset [77.002870] Starting dynamic subtest: A-eDP1 [79.610985] Dynamic subtest A-eDP1: SUCCESS (2.612s) [79.620113] Starting dynamic subtest: B-eDP1 [81.772473] Dynamic subtest B-eDP1: SUCCESS (2.162s) [81.781353] Starting dynamic subtest: C-eDP1 [83.944151] Dynamic subtest C-eDP1: SUCCESS (2.172s) [83.952351] Starting dynamic subtest: D-eDP1 [86.103563] Dynamic subtest D-eDP1: SUCCESS (2.159s) [86.105735] Subtest basic-flip-vs-modeset: SUCCESS (9.111s) [86.909414] [026/130] (929s left) gem_bad_reloc (negative-reloc-bltcopy) [86.965988] Subtest negative-reloc-bltcopy: SKIP (0.000s) [87.038287] [027/130] (929s left) i915_drm_fdinfo (busy-check-all) [87.071721] Starting subtest: busy-check-all [87.075567] Starting dynamic subtest: rcs0 [87.080246] Dynamic subtest rcs0: SKIP (0.004s) [87.089963] Starting dynamic subtest: bcs0 [87.094296] Dynamic subtest bcs0: SKIP (0.000s) [87.100993] Starting dynamic subtest: vcs0 [87.105060] Dynamic subtest vcs0: SKIP (0.000s) [87.112104] Starting dynamic subtest: vcs1 [87.117193] Dynamic subtest vcs1: SKIP (0.000s) [87.124183] Starting dynamic subtest: vecs0 [87.128576] Dynamic subtest vecs0: SKIP (0.000s) [87.135424] Starting dynamic subtest: ccs0 [87.139812] Dynamic subtest ccs0: SKIP (0.000s) [87.144203] Subtest busy-check-all: SKIP (0.006s) [87.177798] [028/130] (929s left) gem_ccs (block-multicopy-inplace) [87.276272] Starting subtest: block-multicopy-inplace [87.280986] Subtest block-multicopy-inplace: SKIP (0.000s) [87.409347] [029/130] (929s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [87.495214] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [87.497608] Starting dynamic subtest: pipe-A [87.843799] Dynamic subtest pipe-A: SUCCESS (0.351s) [87.852606] Starting dynamic subtest: pipe-B [89.296483] Dynamic subtest pipe-B: SUCCESS (1.452s) [89.304996] Starting dynamic subtest: pipe-C [90.726299] Dynamic subtest pipe-C: SUCCESS (1.429s) [90.734534] Starting dynamic subtest: pipe-D [92.167385] Dynamic subtest pipe-D: SUCCESS (1.440s) [92.169693] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.673s) [93.348884] [030/130] (923s left) gem_exec_reloc (basic-cpu-read-noreloc) [93.406112] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [93.484216] [031/130] (923s left) syncobj_basic (bad-destroy) [93.540310] Starting subtest: bad-destroy [93.542305] Subtest bad-destroy: SUCCESS (0.000s) [93.645685] [032/130] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [93.742433] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [97.456473] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.717s) [98.666472] [033/130] (917s left) i915_pm_freq_api (freq-reset) [98.732171] Starting subtest: freq-reset [98.734477] Starting dynamic subtest: gt0 [98.904795] Dynamic subtest gt0: SUCCESS (0.170s) [98.911681] Starting dynamic subtest: gt1 [99.052982] Dynamic subtest gt1: SUCCESS (0.148s) [99.055592] Subtest freq-reset: SUCCESS (0.320s) [99.153424] [034/130] (917s left) i915_pm_rps (fence-order) [99.211956] Starting subtest: fence-order [102.220348] Subtest fence-order: SUCCESS (3.005s) [102.303711] [035/130] (914s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [102.360915] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [102.363394] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [102.481617] [036/130] (914s left) gem_readwrite (beyond-eob) [102.543708] Subtest beyond-EOB: SKIP (0.000s) [102.611224] [037/130] (914s left) gem_media_vme [102.760160] [038/130] (914s left) gem_exec_reloc (basic-wc-gtt-active) [102.821406] Subtest basic-wc-gtt-active: SKIP (0.000s) [102.897045] [039/130] (913s left) gem_mmap_wc (read) [102.952406] Subtest read: SKIP (0.000s) [103.012224] [040/130] (913s left) kms_atomic_transition (modeset-transition-nonblocking) [103.108981] Starting subtest: modeset-transition-nonblocking [103.111223] Starting dynamic subtest: 1x-outputs [113.616211] Dynamic subtest 1x-outputs: SUCCESS (10.505s) [113.881034] Subtest modeset-transition-nonblocking: SUCCESS (10.770s) [114.755243] [041/130] (902s left) gem_ctx_shared (q-out-order) [114.824069] Starting subtest: Q-out-order [114.826572] Starting dynamic subtest: rcs0 [114.920199] Dynamic subtest rcs0: SUCCESS (0.096s) [114.937401] Starting dynamic subtest: vcs0 [114.999122] Dynamic subtest vcs0: SUCCESS (0.078s) [115.013065] Starting dynamic subtest: vcs1 [115.078655] Dynamic subtest vcs1: SUCCESS (0.080s) [115.099628] Starting dynamic subtest: vecs0 [115.152522] Dynamic subtest vecs0: SUCCESS (0.074s) [115.168321] Starting dynamic subtest: ccs0 [115.221757] Dynamic subtest ccs0: SUCCESS (0.069s) [115.224076] Subtest Q-out-order: SUCCESS (0.398s) [116.995717] [042/130] (899s left) kms_flip (2x-flip-vs-panning-interruptible) [117.093201] Starting subtest: 2x-flip-vs-panning-interruptible [117.104344] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s) [117.200229] [043/130] (899s left) gem_exec_fence (syncobj-timeline-repeat) [117.724574] Starting subtest: syncobj-timeline-repeat [117.940038] Subtest syncobj-timeline-repeat: SUCCESS (0.216s) [119.023240] [044/130] (897s left) gem_pxp (create-regular-buffer) [119.137096] Starting subtest: create-regular-buffer [119.139618] Subtest create-regular-buffer: SUCCESS (0.000s) [119.265286] [045/130] (897s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [124.324448] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [124.329063] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [125.205233] [046/130] (891s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [130.142826] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [130.145303] Starting dynamic subtest: pipe-A-eDP-1 [130.960643] Dynamic subtest pipe-A-eDP-1: SKIP (0.813s) [130.968980] Starting dynamic subtest: pipe-B-eDP-1 [132.095607] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [132.100167] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.949s) [133.307239] [047/130] (883s left) kms_hdr (brightness-with-hdr) [133.395535] Starting subtest: brightness-with-hdr [133.401930] Subtest brightness-with-hdr: SKIP (0.000s) [133.492885] [048/130] (883s left) kms_getfb (getfb-handle-closed) [133.577067] Starting subtest: getfb-handle-closed [133.579303] Subtest getfb-handle-closed: SUCCESS (0.000s) [133.696729] [049/130] (883s left) gem_close_race (basic-threads) [133.759619] Starting subtest: basic-threads [135.033629] Subtest basic-threads: SUCCESS (1.274s) [135.230764] [050/130] (882s left) kms_vrr (flipline) [135.335180] Starting subtest: flipline [135.341789] Subtest flipline: SKIP (0.000s) [135.415720] [051/130] (881s left) kms_plane_multiple (2x-tiling-none) [135.517264] Starting subtest: 2x-tiling-none [135.521250] Subtest 2x-tiling-none: SKIP (0.000s) [135.614638] [052/130] (881s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [135.711420] Starting subtest: fbc-1p-pri-indfb-multidraw [148.631414] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.920s) [149.802915] [053/130] (867s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [149.915729] Starting subtest: cursorB-vs-flipB-atomic-transitions [149.920268] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [150.082505] [054/130] (867s left) gem_mmap_wc (coherency) [150.138273] Subtest coherency: SKIP (0.000s) [150.201327] [055/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [150.297295] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [150.301220] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [150.402522] [056/130] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [150.501048] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [150.505280] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [150.620504] [057/130] (866s left) gem_exec_fence (invalid-fence-array) [151.032839] Starting subtest: invalid-fence-array [151.037944] Subtest invalid-fence-array: SUCCESS (0.003s) [152.990636] [058/130] (864s left) api_intel_bb (destroy-bb) [153.043493] Starting subtest: destroy-bb [153.057260] Subtest destroy-bb: SUCCESS (0.014s) [153.219576] [059/130] (864s left) kms_cursor_crc (cursor-rapid-movement-256x256) [153.463389] Starting subtest: cursor-rapid-movement-256x256 [153.465660] Starting dynamic subtest: pipe-A-eDP-1 [153.996254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [154.023313] Starting dynamic subtest: pipe-D-eDP-1 [155.175242] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s) [155.177491] Subtest cursor-rapid-movement-256x256: SUCCESS (1.710s) [156.058273] [060/130] (861s left) kms_big_fb (y-tiled-16bpp-rotate-0) [156.163374] Starting subtest: y-tiled-16bpp-rotate-0 [156.167573] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [156.296973] [061/130] (861s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [156.390444] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [156.392887] Starting dynamic subtest: A-eDP1 [165.281924] Dynamic subtest A-eDP1: SUCCESS (8.894s) [165.294435] Starting dynamic subtest: B-eDP1 [174.198163] Dynamic subtest B-eDP1: SUCCESS (8.916s) [174.208672] Starting dynamic subtest: C-eDP1 [183.117072] Dynamic subtest C-eDP1: SUCCESS (8.918s) [183.128232] Starting dynamic subtest: D-eDP1 [191.938040] Dynamic subtest D-eDP1: SUCCESS (8.821s) [191.940356] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.557s) [193.174087] [062/130] (824s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [193.284567] Starting subtest: fbcpsr-rgb101010-draw-blt [200.002641] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.721s) [200.148306] [063/130] (817s left) kms_psr (pr-cursor-plane-move) [200.250161] Starting subtest: pr-cursor-plane-move [200.254546] Subtest pr-cursor-plane-move: SKIP (0.000s) [200.341178] [064/130] (817s left) gem_exec_schedule (out-order) [200.417132] Starting subtest: out-order [200.419456] Starting dynamic subtest: rcs0 [200.505063] Dynamic subtest rcs0: SUCCESS (0.096s) [200.516342] Starting dynamic subtest: vcs0 [200.582674] Dynamic subtest vcs0: SUCCESS (0.078s) [200.594233] Starting dynamic subtest: vcs1 [200.658760] Dynamic subtest vcs1: SUCCESS (0.076s) [200.669387] Starting dynamic subtest: vecs0 [200.739932] Dynamic subtest vecs0: SUCCESS (0.080s) [200.752353] Starting dynamic subtest: ccs0 [200.821905] Dynamic subtest ccs0: SUCCESS (0.082s) [200.824311] Subtest out-order: SUCCESS (0.414s) [202.060248] [065/130] (815s left) kms_plane_scaling (2x-scaler-multi-pipe) [202.156108] Starting subtest: 2x-scaler-multi-pipe [202.160602] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [202.274338] [066/130] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [202.363066] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [205.997060] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.639s) [207.199795] [067/130] (810s left) kms_fb_coherency (memset-crc) [207.284976] Starting subtest: memset-crc [207.287404] Starting dynamic subtest: mmap-offset-wc [207.634161] Dynamic subtest mmap-offset-wc: SUCCESS (0.351s) [207.925035] Starting dynamic subtest: mmap-offset-uc [214.031765] Dynamic subtest mmap-offset-uc: SUCCESS (6.116s) [214.312610] Subtest memset-crc: SUCCESS (7.028s) [215.130466] [068/130] (802s left) kms_chamelium_audio (dp-audio) [215.517066] Subtest dp-audio: SKIP (0.000s) [216.330821] [069/130] (801s left) gem_ctx_isolation (clean) [216.383268] Starting subtest: clean [216.385638] Starting dynamic subtest: rcs0 [216.428781] Dynamic subtest rcs0: SUCCESS (0.045s) [216.437142] Starting dynamic subtest: bcs0 [216.507439] Dynamic subtest bcs0: SUCCESS (0.078s) [216.518299] Starting dynamic subtest: vcs0 [216.605527] Dynamic subtest vcs0: SUCCESS (0.097s) [216.616077] Starting dynamic subtest: vcs1 [217.968152] Dynamic subtest vcs1: SUCCESS (1.362s) [217.976815] Starting dynamic subtest: vecs0 [219.968781] Dynamic subtest vecs0: SUCCESS (2.000s) [219.977144] Starting dynamic subtest: ccs0 [221.914765] Dynamic subtest ccs0: SUCCESS (1.945s) [221.917163] Subtest clean: SUCCESS (5.531s) [222.107861] [070/130] (795s left) kms_invalid_mode (bad-hsync-start) [222.210133] Starting subtest: bad-hsync-start [222.212453] Starting dynamic subtest: pipe-A-eDP-1 [222.485165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [222.494859] Starting dynamic subtest: pipe-B-eDP-1 [222.497097] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [222.505014] Starting dynamic subtest: pipe-C-eDP-1 [222.507312] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [222.516619] Starting dynamic subtest: pipe-D-eDP-1 [222.519433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [222.521925] Subtest bad-hsync-start: SUCCESS (0.287s) [223.295235] [071/130] (794s left) syncobj_timeline (etime-multi-wait-submitted) [223.347590] Starting subtest: etime-multi-wait-submitted [223.456467] Subtest etime-multi-wait-submitted: SUCCESS (0.109s) [223.542440] [072/130] (794s left) gem_ctx_persistence (legacy-engines-hostile) [223.594528] Starting subtest: legacy-engines-hostile [223.597270] Starting dynamic subtest: render [223.684669] Dynamic subtest render: SUCCESS (0.089s) [223.696697] Starting dynamic subtest: bsd1 [223.804042] Dynamic subtest bsd1: SUCCESS (0.118s) [223.815497] Starting dynamic subtest: bsd2 [223.909272] Dynamic subtest bsd2: SUCCESS (0.103s) [223.920919] Starting dynamic subtest: blt [224.011726] Dynamic subtest blt: SUCCESS (0.101s) [224.023979] Starting dynamic subtest: vebox [224.113887] Dynamic subtest vebox: SUCCESS (0.100s) [224.116587] Subtest legacy-engines-hostile: SUCCESS (0.520s) [224.203530] [073/130] (793s left) kms_psr (psr-primary-render) [224.286428] Starting subtest: psr-primary-render [224.288800] Starting dynamic subtest: eDP-1 [225.988959] Dynamic subtest eDP-1: SUCCESS (1.704s) [225.991404] Subtest psr-primary-render: SUCCESS (1.704s) [226.854702] [074/130] (791s left) gem_mmap_gtt (big-copy-xy) [226.912909] Subtest big-copy-XY: SKIP (0.000s) [226.964376] [075/130] (791s left) syncobj_basic (test-valid-cycle) [227.018698] Starting subtest: test-valid-cycle [227.020926] Subtest test-valid-cycle: SUCCESS (0.000s) [227.153334] [076/130] (791s left) kms_plane_alpha_blend (constant-alpha-max) [227.239358] Starting subtest: constant-alpha-max [227.519699] Starting dynamic subtest: pipe-A-eDP-1 [228.441593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [228.451028] Starting dynamic subtest: pipe-D-eDP-1 [230.036029] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.594s) [230.038299] Subtest constant-alpha-max: SUCCESS (2.796s) [230.921385] [077/130] (787s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [231.017227] Starting subtest: fbc-psr2-sprite-mmap-cpu [231.019481] Starting dynamic subtest: eDP-1 [231.023628] Dynamic subtest eDP-1: SKIP (0.000s) [231.027773] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [231.101354] [078/130] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [231.206289] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [237.718726] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.515s) [237.878607] [079/130] (780s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5) [237.979141] Starting subtest: planes-upscale-20x20-downscale-factor-0-5 [237.981478] Starting dynamic subtest: pipe-A [237.991828] Dynamic subtest pipe-A: SKIP (0.005s) [238.000698] Starting dynamic subtest: pipe-B [238.009839] Dynamic subtest pipe-B: SKIP (0.018s) [238.018647] Starting dynamic subtest: pipe-C [238.027812] Dynamic subtest pipe-C: SKIP (0.017s) [238.036313] Starting dynamic subtest: pipe-D [238.043547] Dynamic subtest pipe-D: SKIP (0.017s) [238.047286] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.060s) [238.156680] [080/130] (780s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [243.121204] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [243.123410] Starting dynamic subtest: pipe-A-eDP-1 [250.177529] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.053s) [250.200807] Starting dynamic subtest: pipe-B-eDP-1 [257.244876] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.065s) [257.247779] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.123s) [258.107317] [081/130] (760s left) syncobj_timeline (multi-wait-all-signaled) [258.162236] Starting subtest: multi-wait-all-signaled [258.164547] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [258.291220] [082/130] (760s left) kms_atomic (plane-invalid-params) [258.387229] Starting subtest: plane-invalid-params [258.389511] Starting dynamic subtest: pipe-A-eDP-1 [258.782728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s) [258.785077] Subtest plane-invalid-params: SUCCESS (0.397s) [259.644889] [083/130] (758s left) sriov_basic (bind-unbind-vf) [259.705086] Starting subtest: bind-unbind-vf [259.707283] Starting dynamic subtest: vf-1 [259.779404] Dynamic subtest vf-1: FAIL (0.006s) [259.788125] Starting dynamic subtest: vf-2 [259.861721] Dynamic subtest vf-2: FAIL (0.004s) [259.871780] Starting dynamic subtest: vf-3 [259.944813] Dynamic subtest vf-3: FAIL (0.003s) [259.954148] Starting dynamic subtest: vf-4 [260.026776] Dynamic subtest vf-4: FAIL (0.003s) [260.036505] Starting dynamic subtest: vf-5 [260.107061] Dynamic subtest vf-5: FAIL (0.004s) [260.115592] Starting dynamic subtest: vf-6 [260.184744] Dynamic subtest vf-6: FAIL (0.003s) [260.193630] Starting dynamic subtest: vf-7 [260.264259] Dynamic subtest vf-7: FAIL (0.004s) [260.271716] Starting dynamic subtest: vf-random [260.336037] Dynamic subtest vf-random: FAIL (0.004s) [260.344205] Starting dynamic subtest: vf-last [260.400806] Dynamic subtest vf-last: FAIL (0.498s) [260.402534] Subtest bind-unbind-vf: FAIL (0.535s) [260.436017] [084/130] (758s left) gem_exec_reloc (basic-cpu-read) [260.488093] Subtest basic-cpu-read: SKIP (0.000s) [260.585470] [085/130] (758s left) gem_render_copy (yf-tiled) [260.645166] Starting subtest: yf-tiled [260.648835] Subtest yf-tiled: SKIP (0.000s) [260.848165] [086/130] (757s left) kms_cursor_crc (cursor-random-256x256) [261.085650] Starting subtest: cursor-random-256x256 [261.090773] Starting dynamic subtest: pipe-A-eDP-1 [264.411760] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.323s) [264.439569] Starting dynamic subtest: pipe-D-eDP-1 [268.407864] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.974s) [268.410239] Subtest cursor-random-256x256: SUCCESS (7.321s) [269.304509] [087/130] (749s left) gem_mmap_gtt (basic-small-copy-xy) [269.360710] Subtest basic-small-copy-XY: SKIP (0.000s) [269.432290] [088/130] (749s left) kms_cursor_edge_walk (64x64-top-bottom) [269.522060] Starting subtest: 64x64-top-bottom [269.524357] Starting dynamic subtest: pipe-A-eDP-1 [272.948086] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s) [272.957617] Starting dynamic subtest: pipe-D-eDP-1 [276.090040] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s) [276.092404] Subtest 64x64-top-bottom: SUCCESS (6.568s) [276.907264] [089/130] (741s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [277.010525] Starting subtest: fbcpsr-stridechange [283.135426] Subtest fbcpsr-stridechange: SUCCESS (6.128s) [283.300529] [090/130] (735s left) kms_big_fb (x-tiled-64bpp-rotate-180) [283.401374] Starting subtest: x-tiled-64bpp-rotate-180 [284.866040] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.466s) [285.070262] [091/130] (733s left) kms_selftest (drm_dp_mst_helper) [285.104840] Starting subtest: drm_dp_mst_helper [285.145789] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [285.256651] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.112s) [285.264909] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [285.385262] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.127s) [285.393238] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [285.558673] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.171s) [285.560651] Subtest drm_dp_mst_helper: SUCCESS (0.451s) [285.770442] [092/130] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [285.882230] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [292.972870] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.093s) [293.119174] [093/130] (725s left) prime_vgem (basic-gtt) [293.207291] Starting subtest: basic-gtt [293.211602] Subtest basic-gtt: SKIP (0.000s) [293.332393] [094/130] (725s left) kms_rotation_crc (primary-rotation-180) [293.412347] Starting subtest: primary-rotation-180 [300.317457] Subtest primary-rotation-180: SUCCESS (6.907s) [301.527572] [095/130] (717s left) kms_vblank (ts-continuation-modeset) [301.634479] Starting subtest: ts-continuation-modeset [301.636809] Starting dynamic subtest: pipe-A-eDP-1 [303.077154] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.442s) [303.090956] Starting dynamic subtest: pipe-D-eDP-1 [305.246054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.165s) [305.248305] Subtest ts-continuation-modeset: SUCCESS (3.611s) [306.066568] [096/130] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [306.168558] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [306.172883] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [306.278183] [097/130] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [306.378489] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [306.382542] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [306.523200] [098/130] (712s left) kms_addfb_basic (addfb25-4-tiled) [306.615183] Starting subtest: addfb25-4-tiled [306.617351] Subtest addfb25-4-tiled: SUCCESS (0.000s) [306.746616] [099/130] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [306.842747] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [306.846862] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [306.946255] [100/130] (712s left) kms_psr (pr-sprite-render) [307.030447] Starting subtest: pr-sprite-render [307.034077] Subtest pr-sprite-render: SKIP (0.000s) [307.113993] [101/130] (712s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [307.162603] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [307.221940] [102/130] (712s left) dmabuf_sync_file (import-basic) [307.259498] Starting subtest: import-basic [307.261560] Subtest import-basic: SUCCESS (0.002s) [307.338485] [103/130] (711s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [307.440548] Starting subtest: plane-all-transition-nonblocking-fencing [307.442502] Starting dynamic subtest: pipe-A-eDP-1 [309.938079] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s) [310.244682] Starting dynamic subtest: pipe-B-eDP-1 [313.486080] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.250s) [313.793892] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.354s) [314.620096] [104/130] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [314.724363] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [336.485757] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.763s) [336.663162] [105/130] (682s left) gem_exec_balancer (full-pulse) [336.725451] Starting subtest: full-pulse [341.699805] Subtest full-pulse: SUCCESS (4.974s) [341.992463] [106/130] (677s left) gem_mmap_offset (mmap-boundaries) [342.041253] Starting subtest: mmap-boundaries [342.043437] Starting dynamic subtest: smem0 [342.316831] Dynamic subtest smem0: SUCCESS (0.276s) [342.319538] Subtest mmap-boundaries: SUCCESS (0.276s) [342.453661] [107/130] (677s left) gem_madvise (dontneed-after-mmap) [342.486342] Starting subtest: dontneed-after-mmap [342.512054] Subtest dontneed-after-mmap: SUCCESS (0.025s) [342.644610] [108/130] (676s left) gem_exec_whisper (basic-fds) [342.703374] Starting subtest: basic-fds [349.611410] Subtest basic-fds: SUCCESS (6.906s) [349.826155] [109/130] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [349.934147] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [349.938088] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [350.056372] [110/130] (669s left) i915_drm_fdinfo (memory-info-idle) [350.096087] Starting subtest: memory-info-idle [350.098293] Starting dynamic subtest: smem0 [350.176095] Dynamic subtest smem0: SUCCESS (0.082s) [350.178739] Subtest memory-info-idle: SUCCESS (0.082s) [350.263501] [111/130] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [350.368106] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [350.372407] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [350.487526] [112/130] (669s left) gem_sync (basic-each) [350.557394] Starting subtest: basic-each [352.828291] Subtest basic-each: SUCCESS (2.282s) [353.023703] [113/130] (666s left) kms_psr (fbc-pr-primary-page-flip) [353.110160] Starting subtest: fbc-pr-primary-page-flip [353.114401] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [353.179505] [114/130] (666s left) gem_exec_schedule (promotion) [353.255532] Starting subtest: promotion [353.257853] Starting dynamic subtest: rcs0 [353.354029] Dynamic subtest rcs0: SUCCESS (0.106s) [353.364912] Starting dynamic subtest: vcs0 [353.432748] Dynamic subtest vcs0: SUCCESS (0.078s) [353.445087] Starting dynamic subtest: vcs1 [353.511761] Dynamic subtest vcs1: SUCCESS (0.078s) [353.520933] Starting dynamic subtest: vecs0 [353.591600] Dynamic subtest vecs0: SUCCESS (0.078s) [353.603649] Starting dynamic subtest: ccs0 [353.673045] Dynamic subtest ccs0: SUCCESS (0.080s) [353.675398] Subtest promotion: SUCCESS (0.425s) [355.015761] [115/130] (664s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [355.109934] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [356.042536] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.934s) [356.187618] [116/130] (663s left) gem_userptr_blits (invalid-null-pointer) [356.251852] Starting subtest: invalid-null-pointer [356.253732] Subtest invalid-null-pointer: SUCCESS (0.001s) [356.402235] [117/130] (663s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [356.500379] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [356.502245] Starting dynamic subtest: pipe-A-default-mode [357.683754] Dynamic subtest pipe-A-default-mode: SKIP (1.179s) [357.688482] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.180s) [357.873363] [118/130] (662s left) gem_wait (wait) [357.948743] Starting subtest: wait [357.951088] Starting dynamic subtest: all-engines [359.891191] Dynamic subtest all-engines: SUCCESS (1.940s) [359.906122] Starting dynamic subtest: rcs0 [360.937530] Dynamic subtest rcs0: SUCCESS (1.046s) [360.948302] Starting dynamic subtest: bcs0 [361.984591] Dynamic subtest bcs0: SUCCESS (1.044s) [361.995893] Starting dynamic subtest: vcs0 [363.029252] Dynamic subtest vcs0: SUCCESS (1.043s) [363.042526] Starting dynamic subtest: vcs1 [364.074132] Dynamic subtest vcs1: SUCCESS (1.044s) [364.085618] Starting dynamic subtest: vecs0 [365.118137] Dynamic subtest vecs0: SUCCESS (1.042s) [365.129840] Starting dynamic subtest: ccs0 [366.165487] Dynamic subtest ccs0: SUCCESS (1.045s) [366.167916] Subtest wait: SUCCESS (8.217s) [366.376211] [119/130] (653s left) kms_big_fb (x-tiled-64bpp-rotate-90) [366.497390] Starting subtest: x-tiled-64bpp-rotate-90 [366.517094] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [366.678988] [120/130] (653s left) gem_softpin (full) [366.735921] Starting subtest: full [366.743524] Subtest full: SUCCESS (0.007s) [366.913807] [121/130] (653s left) kms_color (ctm-0-50) [367.004137] Starting subtest: ctm-0-50 [367.006356] Starting dynamic subtest: pipe-A-eDP-1 [370.455338] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s) [370.464330] Starting dynamic subtest: pipe-B-eDP-1 [374.454039] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.998s) [374.463589] Starting dynamic subtest: pipe-C-eDP-1 [378.464622] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.007s) [378.473873] Starting dynamic subtest: pipe-D-eDP-1 [382.476417] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.013s) [382.478747] Subtest ctm-0-50: SUCCESS (15.474s) [383.335925] [122/130] (636s left) vgem_basic (sysfs) [383.381388] Starting subtest: sysfs [383.383623] Subtest sysfs: SUCCESS (0.000s) [383.449152] [123/130] (636s left) core_getversion (basic) [383.484405] Starting subtest: basic [383.489052] Subtest basic: SUCCESS (0.000s) [383.568877] [124/130] (636s left) gem_eio (in-flight-internal-10ms) [383.754931] Starting subtest: in-flight-internal-10ms [384.972360] Subtest in-flight-internal-10ms: SUCCESS (1.216s) [385.125788] [125/130] (635s left) gem_spin_batch (legacy-resubmit) [385.188502] Starting subtest: legacy-resubmit [385.190767] Starting dynamic subtest: default [385.195534] Dynamic subtest default: SUCCESS (0.004s) [385.204992] Starting dynamic subtest: render [385.207122] Dynamic subtest render: SUCCESS (0.001s) [385.216038] Starting dynamic subtest: bsd [385.218169] Dynamic subtest bsd: SUCCESS (0.002s) [385.226833] Starting dynamic subtest: bsd1 [385.229064] Dynamic subtest bsd1: SUCCESS (0.001s) [385.237441] Starting dynamic subtest: bsd2 [385.239623] Dynamic subtest bsd2: SUCCESS (0.002s) [385.247836] Starting dynamic subtest: blt [385.250075] Dynamic subtest blt: SUCCESS (0.002s) [385.258203] Starting dynamic subtest: vebox [385.260307] Dynamic subtest vebox: SUCCESS (0.002s) [385.262459] Subtest legacy-resubmit: SUCCESS (0.019s) [385.453130] [126/130] (634s left) kms_chamelium_frames (dp-crc-multiple) [385.832749] Subtest dp-crc-multiple: SKIP (0.000s) [386.635606] [127/130] (633s left) perf_pmu (pmu-read) [386.675447] Starting subtest: pmu-read [386.677704] Subtest pmu-read: SUCCESS (0.002s) [386.793275] [128/130] (633s left) kms_rotation_crc (cursor-rotation-180) [386.883230] Starting subtest: cursor-rotation-180 [388.295920] Subtest cursor-rotation-180: SUCCESS (1.415s) [389.535988] [129/130] (630s left) perf_pmu (busy-hang) [389.573724] Starting subtest: busy-hang [389.576180] Starting dynamic subtest: rcs0 [390.853359] Dynamic subtest rcs0: SUCCESS (1.277s) [390.863911] Starting dynamic subtest: bcs0 [392.080389] Dynamic subtest bcs0: SUCCESS (1.225s) [392.092259] Starting dynamic subtest: vcs0 [394.395620] Dynamic subtest vcs0: SUCCESS (2.317s) [394.406915] Starting dynamic subtest: vcs1 [396.444667] Dynamic subtest vcs1: SUCCESS (2.044s) [396.455485] Starting dynamic subtest: vecs0 [398.424488] Dynamic subtest vecs0: SUCCESS (1.978s) [398.435810] Starting dynamic subtest: ccs0 [399.644380] Dynamic subtest ccs0: SUCCESS (1.219s) [399.646677] Subtest busy-hang: SUCCESS (10.069s) [399.773229] [130/130] (620s left) gem_exec_schedule (u-lateslice) [399.841703] Starting subtest: u-lateslice [399.843902] Starting dynamic subtest: rcs0 [399.862359] Dynamic subtest rcs0: SUCCESS (0.026s) [399.871379] Starting dynamic subtest: bcs0 [399.885425] Dynamic subtest bcs0: SUCCESS (0.023s) [399.894895] Starting dynamic subtest: vcs0 [399.907539] Dynamic subtest vcs0: SUCCESS (0.022s) [399.916488] Starting dynamic subtest: vcs1 [399.927066] Dynamic subtest vcs1: SUCCESS (0.019s) [399.935549] Starting dynamic subtest: vecs0 [399.947673] Dynamic subtest vecs0: SUCCESS (0.020s) [399.956229] Starting dynamic subtest: ccs0 [399.968762] Dynamic subtest ccs0: SUCCESS (0.021s) [399.971161] Subtest u-lateslice: SUCCESS (0.133s) [402.054707] 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.