[96.620939] Initializing watchdogs [96.620987] /dev/watchdog0 [96.634279] [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] [96.638536] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [96.640876] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [96.644298] [001/130] (960s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [101.778097] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [101.782662] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s) [102.609308] [002/130] (954s left) kms_cursor_crc (cursor-onscreen-512x512) [102.853265] Starting subtest: cursor-onscreen-512x512 [102.857700] Subtest cursor-onscreen-512x512: SKIP (0.001s) [103.027983] [003/130] (954s left) syncobj_wait (invalid-wait-bad-flags) [103.087190] Starting subtest: invalid-wait-bad-flags [103.089066] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [103.178046] [004/130] (954s left) gem_watchdog (default-virtual) [103.253491] Starting subtest: default-virtual [109.532835] Subtest default-virtual: SUCCESS (6.284s) [109.635313] [005/130] (947s left) kms_color (ctm-blue-to-red) [109.750912] Starting subtest: ctm-blue-to-red [109.753323] Starting dynamic subtest: pipe-A-eDP-1 [110.448812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s) [110.461082] Starting dynamic subtest: pipe-B-eDP-1 [111.774849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.326s) [111.783832] Starting dynamic subtest: pipe-C-eDP-1 [113.068593] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s) [113.080647] Starting dynamic subtest: pipe-D-eDP-1 [114.380377] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s) [114.382786] Subtest ctm-blue-to-red: SUCCESS (4.628s) [115.211091] [006/130] (942s left) api_intel_bb (delta-check) [115.277827] Starting subtest: delta-check [115.282751] Subtest delta-check: SUCCESS (0.006s) [115.393205] [007/130] (941s left) kms_vrr (flip-dpms) [115.487868] Starting subtest: flip-dpms [115.494464] Subtest flip-dpms: SKIP (0.000s) [115.554970] [008/130] (941s left) gem_mmap_offset (blt-coherency) [115.618165] Starting subtest: blt-coherency [115.625059] Subtest blt-coherency: SUCCESS (0.009s) [115.755128] [009/130] (941s left) kms_atomic_interruptible (legacy-pageflip) [115.856575] Starting subtest: legacy-pageflip [115.858972] Starting dynamic subtest: pipe-A-eDP-1 [123.222543] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.367s) [123.224484] Subtest legacy-pageflip: SUCCESS (7.368s) [124.057634] [010/130] (933s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite) [124.164896] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite [130.439522] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.275s) [130.534182] [011/130] (926s left) kms_cursor_crc (cursor-offscreen-32x10) [130.676349] Starting subtest: cursor-offscreen-32x10 [130.716726] Subtest cursor-offscreen-32x10: SKIP (0.036s) [130.969133] [012/130] (926s left) gem_eio (create-ext) [131.170902] Starting subtest: create-ext [131.449107] Subtest create-ext: SUCCESS (0.278s) [131.599196] [013/130] (925s left) prime_busy (after-wait) [131.668528] Starting subtest: after-wait [131.672509] Starting dynamic subtest: rcs0 [131.716912] Dynamic subtest rcs0: SUCCESS (0.045s) [131.725958] Starting dynamic subtest: bcs0 [131.780486] Dynamic subtest bcs0: SUCCESS (0.063s) [131.789318] Starting dynamic subtest: vcs0 [131.820090] Dynamic subtest vcs0: SUCCESS (0.040s) [131.828120] Starting dynamic subtest: vcs1 [131.861391] Dynamic subtest vcs1: SUCCESS (0.041s) [131.869491] Starting dynamic subtest: vecs0 [131.902467] Dynamic subtest vecs0: SUCCESS (0.041s) [131.911039] Starting dynamic subtest: ccs0 [131.942769] Dynamic subtest ccs0: SUCCESS (0.040s) [132.052225] Subtest after-wait: SUCCESS (0.382s) [132.118524] [014/130] (925s left) kms_atomic_interruptible (atomic-setmode) [132.221187] Starting subtest: atomic-setmode [132.223772] Starting dynamic subtest: pipe-A-eDP-1 [139.103647] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.882s) [139.105949] Subtest atomic-setmode: SUCCESS (6.883s) [139.960164] [015/130] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [140.055991] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [140.060128] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [140.138971] [016/130] (917s left) gem_flink_basic (double-flink) [140.195151] Starting subtest: double-flink [140.197484] Subtest double-flink: SUCCESS (0.000s) [140.284044] [017/130] (917s left) syncobj_wait (single-wait-all-submitted) [140.341973] Starting subtest: single-wait-all-submitted [140.446907] Subtest single-wait-all-submitted: SUCCESS (0.104s) [140.515471] [018/130] (917s left) gem_create (create-size-update) [140.575862] Starting subtest: create-size-update [140.577841] Subtest create-size-update: SUCCESS (0.000s) [140.774249] [019/130] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [140.878657] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [140.883257] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [140.976690] [020/130] (916s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [141.088340] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [141.967434] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.881s) [142.187490] [021/130] (915s left) gem_exec_fence (submit3) [142.371414] Starting subtest: submit3 [142.376129] Subtest submit3: SKIP (0.000s) [143.998079] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [144.001097] [022/130] (913s left) kms_setmode (invalid-clone-single-crtc) [144.063955] Starting subtest: invalid-clone-single-crtc [144.070141] Subtest invalid-clone-single-crtc: SKIP (0.000s) [144.167995] [023/130] (913s left) kms_psr (pr-suspend) [144.257181] Starting subtest: pr-suspend [144.261595] Subtest pr-suspend: SKIP (0.000s) [144.326901] [024/130] (913s left) vgem_slow (nohang) [144.372627] Starting subtest: nohang [154.761056] Subtest nohang: SUCCESS (10.389s) [154.823748] [025/130] (903s left) kms_chamelium_color (ctm-max) [154.932400] Subtest ctm-max: SKIP (0.000s) [154.974431] [026/130] (903s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [155.098355] Starting subtest: 2x-flip-vs-cursor-legacy [155.102631] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [155.189378] [027/130] (902s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [155.293855] Starting subtest: plane-downscale-factor-0-5-with-rotation [155.296173] Starting dynamic subtest: pipe-A [155.305329] Dynamic subtest pipe-A: SKIP (0.004s) [155.313903] Starting dynamic subtest: pipe-B [155.323454] Dynamic subtest pipe-B: SKIP (0.017s) [155.332793] Starting dynamic subtest: pipe-C [155.341979] Dynamic subtest pipe-C: SKIP (0.015s) [155.349174] Starting dynamic subtest: pipe-D [155.356714] Dynamic subtest pipe-D: SKIP (0.015s) [155.360510] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.053s) [155.451080] [028/130] (902s left) gem_exec_suspend (basic-s3) [155.512888] Starting subtest: basic-S3 [155.515343] Starting dynamic subtest: smem [175.268861] Dynamic subtest smem: SUCCESS (6.383s) [175.271160] Subtest basic-S3: SUCCESS (6.384s) [175.451950] [029/130] (896s left) gem_exec_fence (syncobj-unused-fence) [175.906328] Starting subtest: syncobj-unused-fence [175.912949] Subtest syncobj-unused-fence: SUCCESS (0.007s) [177.432672] [030/130] (894s left) kms_frontbuffer_tracking (fbc-tiling-y) [177.534490] Starting subtest: fbc-tiling-y [177.538818] Subtest fbc-tiling-y: SKIP (0.000s) [177.668365] [031/130] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [177.780841] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [177.785254] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [177.866914] [032/130] (893s left) gem_ctx_persistence (engines-persistence) [177.929015] Starting subtest: engines-persistence [177.931102] Starting dynamic subtest: rcs0 [178.748344] Dynamic subtest rcs0: SUCCESS (0.818s) [178.759384] Starting dynamic subtest: bcs0 [179.544032] Dynamic subtest bcs0: SUCCESS (0.795s) [179.555140] Starting dynamic subtest: vcs0 [180.331166] Dynamic subtest vcs0: SUCCESS (0.786s) [180.340391] Starting dynamic subtest: vcs1 [181.097275] Dynamic subtest vcs1: SUCCESS (0.765s) [181.107621] Starting dynamic subtest: vecs0 [181.886446] Dynamic subtest vecs0: SUCCESS (0.788s) [181.896159] Starting dynamic subtest: ccs0 [182.674364] Dynamic subtest ccs0: SUCCESS (0.787s) [182.676833] Subtest engines-persistence: SUCCESS (4.742s) [182.791824] [033/130] (888s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [182.900250] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [182.902507] Starting dynamic subtest: pipe-A-eDP-1 [184.192994] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.291s) [184.203577] Starting dynamic subtest: pipe-B-eDP-1 [186.546952] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.353s) [186.556162] Starting dynamic subtest: pipe-C-eDP-1 [188.869732] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.321s) [188.879580] Starting dynamic subtest: pipe-D-eDP-1 [191.187428] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.316s) [191.190002] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.284s) [192.358399] [034/130] (879s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [192.474704] Starting subtest: psr-2p-scndscrn-spr-indfb-move [192.478919] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [192.575425] [035/130] (879s left) gem_lmem_swapping (smem-oom) [192.619116] Subtest smem-oom: SKIP (0.000s) [192.668224] [036/130] (879s left) gem_mmap_gtt (ptrace) [192.723711] Subtest ptrace: SKIP (0.000s) [192.772556] [037/130] (879s left) gem_mmap_wc (invalid-flags) [192.837669] Subtest invalid-flags: SKIP (0.000s) [192.896973] [038/130] (878s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [192.954432] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [192.956428] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [193.062696] [039/130] (878s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [194.596877] Starting subtest: dpms-mode-unset-non-lpsp [195.754161] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s) [196.100590] [040/130] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [196.211296] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [196.215391] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [196.319922] [041/130] (875s left) kms_flip (plain-flip-ts-check-interruptible) [196.418143] Starting subtest: plain-flip-ts-check-interruptible [196.420456] Starting dynamic subtest: A-eDP1 [205.275022] Dynamic subtest A-eDP1: SUCCESS (8.852s) [205.283552] Starting dynamic subtest: B-eDP1 [214.100380] Dynamic subtest B-eDP1: SUCCESS (8.817s) [214.112749] Starting dynamic subtest: C-eDP1 [222.920539] Dynamic subtest C-eDP1: SUCCESS (8.813s) [222.930230] Starting dynamic subtest: D-eDP1 [231.751596] Dynamic subtest D-eDP1: SUCCESS (8.827s) [231.756757] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.317s) [232.930344] [042/130] (839s left) api_intel_allocator (alloc-simple) [232.997573] Starting subtest: alloc-simple [232.999979] Subtest alloc-simple: SUCCESS (0.003s) [233.123759] [043/130] (838s left) syncobj_timeline (wait-any-snapshot) [233.182373] Starting subtest: wait-any-snapshot [233.262576] Subtest wait-any-snapshot: SUCCESS (0.081s) [233.340735] [044/130] (838s left) gem_busy (parallel) [233.533492] Starting subtest: parallel [233.536019] Starting dynamic subtest: rcs0 [235.301215] Dynamic subtest rcs0: SUCCESS (1.765s) [235.312937] Starting dynamic subtest: bcs0 [237.284143] Dynamic subtest bcs0: SUCCESS (1.981s) [237.295223] Starting dynamic subtest: vcs0 [239.270414] Dynamic subtest vcs0: SUCCESS (1.984s) [239.282177] Starting dynamic subtest: vcs1 [241.316917] Dynamic subtest vcs1: SUCCESS (2.045s) [241.328008] Starting dynamic subtest: vecs0 [243.301069] Dynamic subtest vecs0: SUCCESS (1.982s) [243.311607] Starting dynamic subtest: ccs0 [245.285168] Dynamic subtest ccs0: SUCCESS (1.982s) [245.288234] Subtest parallel: SUCCESS (11.746s) [245.548104] [045/130] (826s left) gem_softpin (allocator-basic) [245.619667] Starting subtest: allocator-basic [245.689400] Subtest allocator-basic: SUCCESS (0.070s) [245.842582] [046/130] (826s left) gem_exec_params (secure-non-master) [245.916890] Starting subtest: secure-non-master [245.921299] Subtest secure-non-master: SKIP (0.000s) [246.031861] [047/130] (826s left) kms_psr (fbc-psr2-dpms) [246.140673] Starting subtest: fbc-psr2-dpms [246.143007] Starting dynamic subtest: eDP-1 [246.147200] Dynamic subtest eDP-1: SKIP (0.000s) [246.151429] Subtest fbc-psr2-dpms: SKIP (0.001s) [246.242960] [048/130] (825s left) kms_universal_plane (universal-plane-functional) [246.344556] Starting subtest: universal-plane-functional [246.347398] Starting dynamic subtest: pipe-A-eDP-1 [250.165365] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.819s) [250.174912] Starting dynamic subtest: pipe-B-eDP-1 [254.535707] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.367s) [254.545138] Starting dynamic subtest: pipe-C-eDP-1 [258.893411] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.356s) [258.902596] Starting dynamic subtest: pipe-D-eDP-1 [263.061331] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.166s) [263.063745] Subtest universal-plane-functional: SUCCESS (16.713s) [263.846904] [049/130] (808s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [263.961666] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [263.965644] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [264.039247] [050/130] (808s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [264.134454] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [264.136944] Starting dynamic subtest: pipe-A-eDP-1 [264.145936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [264.155518] Starting dynamic subtest: pipe-B-eDP-1 [264.164395] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [264.172372] Starting dynamic subtest: pipe-C-eDP-1 [264.180727] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [264.188533] Starting dynamic subtest: pipe-D-eDP-1 [264.196913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [264.201032] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s) [266.288247] [051/130] (806s left) syncobj_basic (test-valid-cycle) [266.348944] Starting subtest: test-valid-cycle [266.351242] Subtest test-valid-cycle: SUCCESS (0.000s) [266.465109] [052/130] (805s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [271.449222] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf [271.452222] Starting dynamic subtest: pipe-A-eDP-1 [272.247433] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s) [272.256553] Starting dynamic subtest: pipe-B-eDP-1 [273.371933] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s) [273.376618] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.918s) [274.544136] [053/130] (797s left) kms_plane_alpha_blend (constant-alpha-max) [274.646428] Starting subtest: constant-alpha-max [275.064338] Starting dynamic subtest: pipe-A-eDP-1 [275.997593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.930s) [276.006676] Starting dynamic subtest: pipe-D-eDP-1 [277.540692] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s) [277.542631] Subtest constant-alpha-max: SUCCESS (2.891s) [278.417582] [054/130] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [278.535568] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [281.817406] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (3.290s) [281.939120] [055/130] (790s left) gem_exec_reloc (basic-write-gtt-noreloc) [281.999259] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [282.066581] [056/130] (790s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [282.168659] Starting subtest: drrs-dirtyfb-ioctl [282.179416] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [282.283439] [057/130] (790s left) gem_madvise (dontneed-before-mmap) [282.320801] Starting subtest: dontneed-before-mmap [282.351590] Subtest dontneed-before-mmap: SUCCESS (0.031s) [282.459365] [058/130] (790s left) gem_ctx_persistence (idempotent) [282.519619] Starting subtest: idempotent [282.521694] Subtest idempotent: SUCCESS (0.000s) [282.627551] [059/130] (790s left) kms_frontbuffer_tracking (fbc-suspend) [282.734357] Starting subtest: fbc-suspend [319.542238] Subtest fbc-suspend: SUCCESS (6.117s) [319.662681] [060/130] (783s left) kms_prop_blob (invalid-set-prop-any) [319.713226] Starting subtest: invalid-set-prop-any [319.715185] Subtest invalid-set-prop-any: SUCCESS (0.000s) [319.806761] [061/130] (783s left) kms_big_fb (y-tiled-8bpp-rotate-180) [319.918210] Starting subtest: y-tiled-8bpp-rotate-180 [319.922291] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [320.028303] [062/130] (783s left) core_auth (getclient-master-drop) [320.067562] Starting subtest: getclient-master-drop [320.089198] Subtest getclient-master-drop: SUCCESS (0.025s) [320.207386] [063/130] (783s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [320.302281] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [320.304476] Starting dynamic subtest: pipe-A [320.322154] Dynamic subtest pipe-A: SKIP (0.012s) [320.332497] Starting dynamic subtest: pipe-B [320.344730] Dynamic subtest pipe-B: SKIP (0.022s) [320.353267] Starting dynamic subtest: pipe-C [320.365284] Dynamic subtest pipe-C: SKIP (0.022s) [320.373444] Starting dynamic subtest: pipe-D [320.387438] Dynamic subtest pipe-D: SKIP (0.022s) [320.391262] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.081s) [320.484378] [064/130] (783s left) drm_read (short-buffer-nonblock) [320.651585] Starting subtest: short-buffer-nonblock [320.653821] Subtest short-buffer-nonblock: SUCCESS (0.000s) [320.771357] [065/130] (782s left) i915_pm_rpm (debugfs-forcewake-user) [322.307793] Starting subtest: debugfs-forcewake-user [333.697425] Subtest debugfs-forcewake-user: SUCCESS (11.379s) [334.057138] [066/130] (769s left) gem_exec_parallel (engines) [334.120620] Starting subtest: engines [334.122971] Starting dynamic subtest: basic [335.935421] Dynamic subtest basic: SUCCESS (1.811s) [335.945526] Starting dynamic subtest: contexts [340.231817] Dynamic subtest contexts: SUCCESS (4.292s) [340.243143] Starting dynamic subtest: fds [344.106518] Dynamic subtest fds: SUCCESS (3.870s) [344.118491] Starting dynamic subtest: userptr [346.004131] Dynamic subtest userptr: SUCCESS (1.895s) [346.006652] Subtest engines: SUCCESS (11.876s) [346.188407] [067/130] (757s left) gem_pxp (reject-modify-context-protection-off-3) [346.320931] Starting subtest: reject-modify-context-protection-off-3 [346.323320] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [346.439515] [068/130] (757s left) gem_exec_reloc (basic-wc-read) [346.500749] Subtest basic-wc-read: SKIP (0.000s) [346.593992] [069/130] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [346.700446] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [346.704885] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [346.807105] [070/130] (756s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [346.915551] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [346.919967] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [347.024648] [071/130] (756s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [347.142172] Starting subtest: flip-vs-cursor-busy-crc-legacy [347.905152] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.760s) [348.774549] [072/130] (755s left) i915_query (query-topology-garbage-items) [348.836633] Starting subtest: query-topology-garbage-items [348.838497] Subtest query-topology-garbage-items: SUCCESS (0.000s) [348.956326] [073/130] (754s left) kms_lease (lease-revoke) [349.072717] Starting subtest: lease-revoke [349.075129] Starting dynamic subtest: pipe-A-eDP-1 [349.123433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.046s) [349.138511] Starting dynamic subtest: pipe-B-eDP-1 [349.175909] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.055s) [349.190006] Starting dynamic subtest: pipe-C-eDP-1 [349.225481] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.048s) [349.236738] Starting dynamic subtest: pipe-D-eDP-1 [349.267127] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.038s) [349.269299] Subtest lease-revoke: SUCCESS (0.192s) [349.406676] [074/130] (754s left) drm_fdinfo (most-busy-check-all) [349.450473] Starting subtest: most-busy-check-all [349.452708] Starting dynamic subtest: rcs0 [349.457277] Dynamic subtest rcs0: SKIP (0.004s) [349.467461] Starting dynamic subtest: bcs0 [349.471562] Dynamic subtest bcs0: SKIP (0.000s) [349.481043] Starting dynamic subtest: vcs0 [349.485324] Dynamic subtest vcs0: SKIP (0.000s) [349.493347] Starting dynamic subtest: vcs1 [349.497556] Dynamic subtest vcs1: SKIP (0.000s) [349.505676] Starting dynamic subtest: vecs0 [349.510087] Dynamic subtest vecs0: SKIP (0.000s) [349.518110] Starting dynamic subtest: ccs0 [349.522488] Dynamic subtest ccs0: SKIP (0.000s) [349.526897] Subtest most-busy-check-all: SKIP (0.008s) [349.561232] [075/130] (754s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [349.621770] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [349.724390] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s) [349.799411] [076/130] (754s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [349.866675] Starting subtest: multi-wait-all-for-submit-unsubmitted [349.972311] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [350.045336] [077/130] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [350.151738] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [350.156156] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [350.278443] [078/130] (753s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [350.379118] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [350.381398] Starting dynamic subtest: pipe-A [350.390749] Dynamic subtest pipe-A: SKIP (0.005s) [350.399746] Starting dynamic subtest: pipe-B [350.413721] Dynamic subtest pipe-B: SKIP (0.023s) [350.427696] Starting dynamic subtest: pipe-C [350.436892] Dynamic subtest pipe-C: SKIP (0.017s) [350.450330] Starting dynamic subtest: pipe-D [350.459258] Dynamic subtest pipe-D: SKIP (0.016s) [350.463780] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.064s) [350.541780] [079/130] (753s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [350.601244] Starting subtest: mixed-tiled-to-yf-tiled-ccs [350.605860] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [350.786302] [080/130] (753s left) gem_userptr_blits (unsync-unmap-cycles) [350.854038] Subtest unsync-unmap-cycles: SKIP (0.000s) [350.987096] [081/130] (753s left) gem_workarounds (suspend-resume-context) [351.057638] Starting subtest: suspend-resume-context [367.370558] Subtest suspend-resume-context: SUCCESS (1.222s) [367.479880] [082/130] (751s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [367.585855] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [367.588669] Starting dynamic subtest: pipe-A-default-mode [367.890798] Dynamic subtest pipe-A-default-mode: SKIP (0.301s) [367.896232] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.302s) [368.675694] [083/130] (750s left) kms_flip_tiling (flip-change-tiling) [368.770542] Starting subtest: flip-change-tiling [368.772743] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [368.989466] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.220s) [369.001126] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [369.174153] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.182s) [369.185755] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [369.358009] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.181s) [369.374738] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [369.550896] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.190s) [369.560678] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [369.737836] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.187s) [369.748866] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [369.924647] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.185s) [369.936456] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [370.112838] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.185s) [370.124414] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [370.263157] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [370.272846] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [370.435932] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s) [370.449189] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [370.625908] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.188s) [370.637667] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [370.808618] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.181s) [370.820076] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [370.992205] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.181s) [371.003897] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [371.164149] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.170s) [371.176437] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [371.336233] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s) [371.346477] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [371.487869] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.149s) [371.499496] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [371.664362] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.175s) [371.677411] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [371.841625] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.176s) [371.852702] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [372.023273] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.180s) [372.033770] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [372.197773] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.172s) [372.208730] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [372.376483] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.176s) [372.389940] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [372.560284] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.182s) [372.571330] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [372.737363] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.175s) [372.749148] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [372.913140] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.174s) [372.924132] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [373.093386] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.178s) [373.104418] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [373.269670] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.174s) [373.280780] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [373.442731] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.171s) [373.459532] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [373.614767] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.170s) [373.625852] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [373.795501] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.178s) [373.806666] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [373.961255] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.163s) [373.972479] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [374.142727] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.180s) [374.154153] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [374.318301] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.173s) [374.328765] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [374.490028] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.170s) [374.502540] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [374.676038] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.183s) [374.687079] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [374.856895] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.180s) [374.867985] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [375.041662] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.182s) [375.052854] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [375.201713] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.158s) [375.249229] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [376.456193] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.218s) [376.468004] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [376.629704] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.171s) [376.641609] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [376.813405] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.181s) [376.825112] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [377.028706] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.213s) [377.039198] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [377.212477] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.183s) [377.223359] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [377.400565] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.186s) [377.410104] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [377.572473] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.170s) [377.583093] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [377.723113] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [377.735559] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [377.895380] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s) [377.906884] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [378.066712] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.170s) [378.078550] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [378.252353] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.184s) [378.263406] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [378.424503] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.170s) [378.436027] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [378.610199] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.183s) [378.621531] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [378.783207] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s) [378.794791] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [378.931844] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s) [378.945077] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [379.106069] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.172s) [379.117147] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [379.278533] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.171s) [379.289372] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [379.454978] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.174s) [379.466763] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [379.633231] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.175s) [379.644836] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [379.815537] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.181s) [379.826692] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [379.987988] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.170s) [380.003377] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [380.147492] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.158s) [380.159228] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [380.330354] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.182s) [380.339403] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [380.507528] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.176s) [380.519381] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [380.687363] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.178s) [380.698226] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [380.865513] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.176s) [380.876423] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [381.043028] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.176s) [381.053782] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [381.245478] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.200s) [381.257883] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [381.427998] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.181s) [381.438760] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [381.608300] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.178s) [381.619550] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [381.788702] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.179s) [381.799529] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [381.972398] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.181s) [381.983165] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [382.144311] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.170s) [382.154742] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [382.323847] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.178s) [382.334861] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [382.506843] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.181s) [382.517297] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [382.670295] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.162s) [382.724729] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [383.990721] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.274s) [384.002490] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [384.141116] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [384.151988] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [384.291119] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [384.302238] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [384.441230] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.150s) [384.451420] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [384.597424] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.154s) [384.608586] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [384.753269] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.155s) [384.772558] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [384.903213] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.146s) [384.913880] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [385.053912] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [385.066031] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [385.204246] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [385.215462] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [385.353045] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.149s) [385.364862] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [385.502721] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.148s) [385.512406] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [385.658640] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.153s) [385.669430] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [385.808552] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s) [385.819300] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [385.959308] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s) [385.969720] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [386.109065] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s) [386.120479] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [386.264461] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.155s) [386.275787] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [386.414157] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.148s) [386.424468] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [386.563999] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.148s) [386.574151] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [386.714604] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.150s) [386.726131] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [386.868379] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.151s) [386.880384] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [387.018386] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.148s) [387.027877] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [387.166719] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.148s) [387.178566] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [387.324220] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.156s) [387.334760] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [387.477629] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.152s) [387.489097] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [387.627378] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.149s) [387.637902] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [387.778842] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.150s) [387.789485] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [387.928863] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.149s) [387.940185] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [388.082619] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.153s) [388.093743] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [388.241557] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.158s) [388.250780] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [388.398841] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.155s) [388.410177] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [388.548171] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.148s) [388.557322] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [388.697865] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.149s) [388.708780] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [388.848194] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.150s) [388.858758] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [389.003475] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.153s) [389.011876] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [389.158587] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.154s) [389.168888] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [389.317890] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.157s) [389.348506] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [390.622242] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.280s) [390.633523] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [390.772895] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [390.784672] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [390.922699] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [390.934724] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [391.073851] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.151s) [391.084637] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [391.227505] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.152s) [391.236508] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [391.377372] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s) [391.387588] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [391.527363] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.149s) [391.539454] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [391.678335] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [391.688871] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [391.828296] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [391.839641] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [391.990771] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.162s) [392.001382] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [392.152150] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.159s) [392.163001] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [392.301632] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.149s) [392.312323] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [392.424462] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.121s) [392.435862] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [392.546064] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.121s) [392.557601] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [392.697511] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.149s) [392.708679] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [392.846060] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s) [392.857485] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [392.995835] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.148s) [393.005168] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [393.145756] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.149s) [393.155612] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [393.295561] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.149s) [393.305847] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [393.447093] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.149s) [393.458914] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [393.597254] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.149s) [393.609049] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [393.751702] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.154s) [393.762238] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [393.907132] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.154s) [393.918590] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [394.060498] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.152s) [394.077158] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [394.212551] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.150s) [394.225166] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [394.362797] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.149s) [394.373570] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [394.512239] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.149s) [394.523306] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [394.670770] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.157s) [394.681715] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [394.864579] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.192s) [394.875669] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [395.021739] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.156s) [395.032305] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [395.173714] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.150s) [395.183837] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [395.324015] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.149s) [395.334107] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [395.484170] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.160s) [395.494831] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [395.645525] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.160s) [395.655830] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [395.798347] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.151s) [395.808710] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [395.952007] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.152s) [395.973580] Subtest flip-change-tiling: SUCCESS (27.180s) [397.212560] [084/130] (722s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [397.313732] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [397.318725] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [397.393504] [085/130] (722s left) kms_psr (fbc-pr-no-drrs) [397.484499] Starting subtest: fbc-pr-no-drrs [397.489559] Subtest fbc-pr-no-drrs: SKIP (0.000s) [397.553365] [086/130] (721s left) kms_selftest (drm_dp_mst_helper) [397.593571] Starting subtest: drm_dp_mst_helper [397.640212] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [397.787547] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.147s) [397.798858] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [397.912751] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.127s) [397.922845] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [398.040867] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.126s) [398.043650] Subtest drm_dp_mst_helper: SUCCESS (0.449s) [398.188421] [087/130] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [398.297632] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [398.302427] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [398.382235] [088/130] (721s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [398.448893] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [398.452077] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [398.547381] [089/130] (721s left) kms_joiner (basic-big-joiner) [398.649646] Starting subtest: basic-big-joiner [398.654726] Subtest basic-big-joiner: SKIP (0.000s) [398.708906] [090/130] (720s left) perf_pmu (busy-idle-check-all) [398.750823] Starting subtest: busy-idle-check-all [398.752776] Starting dynamic subtest: rcs0 [399.426146] Dynamic subtest rcs0: SUCCESS (0.676s) [399.437902] Starting dynamic subtest: bcs0 [400.078098] Dynamic subtest bcs0: SUCCESS (0.650s) [400.088842] Starting dynamic subtest: vcs0 [400.795703] Dynamic subtest vcs0: FAIL (0.631s) [400.806165] Starting dynamic subtest: vcs1 [401.416816] Dynamic subtest vcs1: FAIL (0.620s) [401.429644] Starting dynamic subtest: vecs0 [402.097181] Dynamic subtest vecs0: SUCCESS (0.765s) [402.112444] Starting dynamic subtest: ccs0 [402.824584] Dynamic subtest ccs0: FAIL (0.626s) [402.827390] Subtest busy-idle-check-all: FAIL (3.978s) [402.867726] [091/130] (716s left) syncobj_timeline (reset-multiple-signaled) [402.936158] Starting subtest: reset-multiple-signaled [402.938697] Subtest reset-multiple-signaled: SUCCESS (0.000s) [403.045938] [092/130] (716s left) kms_dp_link_training (non-uhbr-sst) [403.149518] Starting subtest: non-uhbr-sst [403.159710] Subtest non-uhbr-sst: SKIP (0.000s) [403.217849] [093/130] (716s left) kms_properties (connector-properties-atomic) [403.312594] Starting subtest: connector-properties-atomic [403.315108] Starting dynamic subtest: pipe-A-eDP-1 [410.941820] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.628s) [410.952849] Starting dynamic subtest: pipe-None-DP-1 [410.958284] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [410.967162] Starting dynamic subtest: pipe-None-HDMI-A-1 [410.971788] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [410.980527] Starting dynamic subtest: pipe-None-DP-2 [410.985680] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [410.995004] Starting dynamic subtest: pipe-None-HDMI-A-2 [411.000665] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [411.009983] Starting dynamic subtest: pipe-None-DP-3 [411.015706] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [411.025067] Starting dynamic subtest: pipe-None-DP-4 [411.030549] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [411.033459] Subtest connector-properties-atomic: SUCCESS (7.637s) [411.798772] [094/130] (707s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [411.910722] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [412.779859] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.871s) [413.002902] [095/130] (706s left) gem_readwrite (read-write) [413.074870] Subtest read-write: SKIP (0.000s) [413.137482] [096/130] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [413.251184] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [418.130902] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.883s) [418.286164] [097/130] (701s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [418.387498] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [418.392339] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [419.481220] [098/130] (700s left) gen9_exec_parse (secure-batches) [419.549712] Subtest secure-batches: SKIP (0.000s) [419.636335] [099/130] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [419.735581] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [424.904185] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.173s) [425.037220] [100/130] (694s left) gem_exec_reloc (basic-write-read) [425.089884] Subtest basic-write-read: SKIP (0.000s) [425.154345] [101/130] (694s left) gem_exec_schedule (u-submit-late-slice) [425.228248] Starting subtest: u-submit-late-slice [425.230639] Starting dynamic subtest: rcs0 [425.257523] Dynamic subtest rcs0: SUCCESS (0.038s) [425.270324] Starting dynamic subtest: bcs0 [425.284374] Dynamic subtest bcs0: SUCCESS (0.027s) [425.294726] Starting dynamic subtest: vcs0 [425.314265] Dynamic subtest vcs0: SUCCESS (0.029s) [425.323626] Starting dynamic subtest: vcs1 [425.343836] Dynamic subtest vcs1: SUCCESS (0.028s) [425.359825] Starting dynamic subtest: vecs0 [425.376873] Dynamic subtest vecs0: SUCCESS (0.032s) [425.386337] Starting dynamic subtest: ccs0 [425.403431] Dynamic subtest ccs0: SUCCESS (0.026s) [425.406058] Subtest u-submit-late-slice: SUCCESS (0.185s) [427.166662] [102/130] (692s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [427.231792] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [427.234793] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [427.342075] [103/130] (692s left) gem_exec_balancer (parallel-keep-submit-fence) [427.584732] Starting subtest: parallel-keep-submit-fence [428.825114] Subtest parallel-keep-submit-fence: SUCCESS (1.238s) [428.931249] [104/130] (691s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [429.043619] Starting subtest: extended-pageflip-modeset-hang-oldfb [429.046362] Starting dynamic subtest: pipe-A [436.946845] Dynamic subtest pipe-A: SUCCESS (7.902s) [436.956954] Starting dynamic subtest: pipe-D [445.524987] Dynamic subtest pipe-D: SUCCESS (8.574s) [445.527473] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.480s) [446.371308] [105/130] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [446.475581] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [446.480441] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [446.586716] [106/130] (673s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [446.685670] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [446.697509] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s) [446.769543] [107/130] (673s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [447.166452] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [447.975161] [108/130] (672s left) kms_big_fb (4-tiled-64bpp-rotate-180) [448.078350] Starting subtest: 4-tiled-64bpp-rotate-180 [450.256716] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.179s) [450.476235] [109/130] (669s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [450.580373] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [450.585513] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [450.693290] [110/130] (669s left) gem_exec_flush (basic-wb-set-default) [450.757222] Starting subtest: basic-wb-set-default [456.235652] Subtest basic-wb-set-default: SUCCESS (5.477s) [456.419150] [111/130] (663s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [456.537311] Starting subtest: fbcpsr-slowdraw [479.574613] Subtest fbcpsr-slowdraw: SUCCESS (23.042s) [479.720515] [112/130] (640s left) kms_psr (psr2-sprite-plane-move) [479.813165] Starting subtest: psr2-sprite-plane-move [479.815740] Starting dynamic subtest: eDP-1 [481.567687] Dynamic subtest eDP-1: SUCCESS (1.750s) [481.569875] Subtest psr2-sprite-plane-move: SUCCESS (1.751s) [482.394039] [113/130] (638s left) kms_big_fb (x-tiled-32bpp-rotate-270) [482.499703] Starting subtest: x-tiled-32bpp-rotate-270 [482.523713] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [482.644023] [114/130] (637s left) kms_cursor_crc (cursor-rapid-movement-512x170) [482.923297] Starting subtest: cursor-rapid-movement-512x170 [482.928150] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [483.082096] [115/130] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [483.189891] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [483.194754] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [483.289088] [116/130] (637s left) kms_setmode (basic-clone-single-crtc) [483.344585] Starting subtest: basic-clone-single-crtc [483.351265] Subtest basic-clone-single-crtc: SKIP (0.000s) [483.450468] [117/130] (637s left) i915_pm_rps (reset) [483.508668] Starting subtest: reset [483.585464] Subtest reset: FAIL (0.005s) [483.656826] [118/130] (636s left) prime_vgem (sync) [483.743128] Starting subtest: sync [483.745896] Starting dynamic subtest: rcs0 [483.793222] Dynamic subtest rcs0: SUCCESS (0.050s) [483.802442] Starting dynamic subtest: bcs0 [483.888856] Dynamic subtest bcs0: SUCCESS (0.095s) [483.903396] Starting dynamic subtest: vcs0 [483.936246] Dynamic subtest vcs0: SUCCESS (0.046s) [483.945900] Starting dynamic subtest: vcs1 [483.982924] Dynamic subtest vcs1: SUCCESS (0.046s) [483.992563] Starting dynamic subtest: vecs0 [484.030690] Dynamic subtest vecs0: SUCCESS (0.047s) [484.039799] Starting dynamic subtest: ccs0 [484.077850] Dynamic subtest ccs0: SUCCESS (0.046s) [484.080442] Subtest sync: SUCCESS (0.334s) [484.216838] [119/130] (636s left) dmabuf_sync_file (export-wait-after-attach) [484.262499] Starting subtest: export-wait-after-attach [484.264602] Subtest export-wait-after-attach: SUCCESS (0.000s) [484.315056] [120/130] (636s left) kms_flip (2x-plain-flip-ts-check) [484.409632] Starting subtest: 2x-plain-flip-ts-check [484.421144] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [484.534351] [121/130] (636s left) gem_softpin (evict-single-offset) [484.597835] Starting subtest: evict-single-offset [512.050877] Subtest evict-single-offset: SUCCESS (27.453s) [512.130008] [122/130] (608s left) gem_exec_schedule (preempt) [512.250659] Starting subtest: preempt [512.252878] Starting dynamic subtest: rcs0 [512.285402] Dynamic subtest rcs0: SUCCESS (0.038s) [512.295403] Starting dynamic subtest: bcs0 [512.320074] Dynamic subtest bcs0: SUCCESS (0.034s) [512.330847] Starting dynamic subtest: vcs0 [512.353438] Dynamic subtest vcs0: SUCCESS (0.032s) [512.363543] Starting dynamic subtest: vcs1 [512.387246] Dynamic subtest vcs1: SUCCESS (0.033s) [512.397379] Starting dynamic subtest: vecs0 [512.420313] Dynamic subtest vecs0: SUCCESS (0.033s) [512.430999] Starting dynamic subtest: ccs0 [512.456850] Dynamic subtest ccs0: SUCCESS (0.035s) [512.459677] Subtest preempt: SUCCESS (0.210s) [514.178479] [123/130] (606s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [514.299411] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [514.301571] Starting dynamic subtest: pipe-A-eDP-1 [546.564253] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.884s) [546.575088] Starting dynamic subtest: pipe-B-eDP-1 [579.508236] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.567s) [579.519079] Starting dynamic subtest: pipe-C-eDP-1 [612.437708] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.458s) [612.447701] Starting dynamic subtest: pipe-D-eDP-1 [645.442050] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.417s) [645.444885] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.329s) [646.649704] [124/130] (592s left) kms_flip (flip-vs-suspend) [646.749367] Starting subtest: flip-vs-suspend [646.752066] Starting dynamic subtest: A-eDP1 [696.337622] Dynamic subtest A-eDP1: SUCCESS (4.262s) [696.355412] Starting dynamic subtest: B-eDP1 [745.337556] Dynamic subtest B-eDP1: SUCCESS (4.290s) [745.355065] Starting dynamic subtest: C-eDP1 [794.345577] Dynamic subtest C-eDP1: SUCCESS (4.305s) [794.356110] Starting dynamic subtest: D-eDP1 [843.325786] Dynamic subtest D-eDP1: SUCCESS (4.279s) [843.330106] Subtest flip-vs-suspend: SUCCESS (17.145s) [844.548905] [125/130] (573s left) kms_async_flips (alternate-sync-async-flip) [844.643939] Starting subtest: alternate-sync-async-flip [845.028265] Starting dynamic subtest: pipe-A-eDP-1 [847.828287] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s) [848.208201] Starting dynamic subtest: pipe-B-eDP-1 [850.963743] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s) [851.332555] Starting dynamic subtest: pipe-C-eDP-1 [854.117014] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.791s) [854.482550] Starting dynamic subtest: pipe-D-eDP-1 [857.245593] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [857.247544] Subtest alternate-sync-async-flip: SUCCESS (12.582s) [858.410577] [126/130] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [858.514861] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [858.519190] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [858.601580] [127/130] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [858.706027] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [858.710486] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [858.826171] [128/130] (559s left) kms_psr (fbc-psr-primary-page-flip) [858.939152] Starting subtest: fbc-psr-primary-page-flip [858.941565] Starting dynamic subtest: eDP-1 [858.946222] Dynamic subtest eDP-1: SKIP (0.000s) [858.950974] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [859.008697] [129/130] (559s left) gem_mmap_gtt (basic-copy) [859.078307] Subtest basic-copy: SKIP (0.000s) [859.142096] [130/130] (559s left) gem_exec_whisper (basic-contexts-forked) [859.208115] Starting subtest: basic-contexts-forked [882.473881] Subtest basic-contexts-forked: SUCCESS (23.258s) [882.650652] Closing watchdogs Done.