[59.414296] Initializing watchdogs
[59.414344]   /dev/watchdog0
[59.429291] [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]
[59.433923] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.436650] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.438603] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-signaled)
[59.494211] Starting subtest: multi-wait-for-submit-signaled
[59.495216] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[59.585404] [002/133] (960s left) kms_lease (lessee-list)
[59.681054] Starting subtest: lessee-list
[59.682039] Starting dynamic subtest: pipe-A-eDP-1
[59.682911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[59.688929] Starting dynamic subtest: pipe-B-eDP-1
[59.689848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[59.695487] Starting dynamic subtest: pipe-C-eDP-1
[59.696373] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[59.702098] Starting dynamic subtest: pipe-D-eDP-1
[59.703140] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[59.704089] Subtest lessee-list: SUCCESS (0.008s)
[59.779134] [003/133] (960s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[59.885929] Starting subtest: cursorB-vs-flipA-toggle
[59.887731] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[60.021611] [004/133] (960s left) kms_async_flips (test-cursor-atomic)
[60.109093] Starting subtest: test-cursor-atomic
[60.498624] Starting dynamic subtest: pipe-A-eDP-1
[61.306639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[61.687152] Starting dynamic subtest: pipe-B-eDP-1
[62.427905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.747s)
[62.793134] Starting dynamic subtest: pipe-C-eDP-1
[63.555087] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[63.924561] Starting dynamic subtest: pipe-D-eDP-1
[64.681380] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.762s)
[64.682360] Subtest test-cursor-atomic: SUCCESS (4.573s)
[65.854790] [005/133] (954s left) kms_psr (fbc-pr-primary-page-flip)
[65.954225] Starting subtest: fbc-pr-primary-page-flip
[65.956102] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[66.017075] [006/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[66.118739] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[66.120647] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[66.205443] [007/133] (953s left) gem_ctx_engines (none)
[66.274788] Starting subtest: none
[66.276903] Subtest none: SUCCESS (0.001s)
[66.465636] [008/133] (953s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[68.019246] Starting subtest: modeset-non-lpsp-stress-no-wait
[68.072846] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.053s)
[68.794221] [009/133] (951s left) kms_vblank (ts-continuation-idle)
[68.889781] Starting subtest: ts-continuation-idle
[68.890788] Starting dynamic subtest: pipe-A-eDP-1
[69.288138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[69.296771] Starting dynamic subtest: pipe-D-eDP-1
[70.405116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s)
[70.406104] Subtest ts-continuation-idle: SUCCESS (1.515s)
[71.273745] [010/133] (948s left) kms_psr (fbc-psr2-suspend)
[71.367123] Starting subtest: fbc-psr2-suspend
[71.368124] Starting dynamic subtest: eDP-1
[71.369785] Dynamic subtest eDP-1: SKIP (0.000s)
[71.371477] Subtest fbc-psr2-suspend: SKIP (0.001s)
[71.430908] [011/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[71.527724] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[71.529584] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[71.615760] [012/133] (948s left) kms_dirtyfb (default-dirtyfb-ioctl)
[71.708083] Starting subtest: default-dirtyfb-ioctl
[71.709163] Starting dynamic subtest: A-eDP-1
[73.313708] Dynamic subtest A-eDP-1: SUCCESS (1.605s)
[73.314629] Subtest default-dirtyfb-ioctl: SUCCESS (1.605s)
[74.099723] [013/133] (946s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[74.181753] Starting subtest: plane-all-transition-nonblocking-fencing
[74.182798] Starting dynamic subtest: pipe-A-eDP-1
[76.677898] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[76.983057] Starting dynamic subtest: pipe-B-eDP-1
[80.245705] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.267s)
[80.551267] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.368s)
[81.362984] [014/133] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[81.474102] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[81.475959] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[81.576688] [015/133] (938s left) syncobj_basic (bad-destroy-pad)
[81.631141] Starting subtest: bad-destroy-pad
[81.632197] Subtest bad-destroy-pad: SUCCESS (0.000s)
[81.730103] [016/133] (938s left) gem_exec_schedule (semaphore-codependency)
[81.800274] Starting subtest: semaphore-codependency
[81.816977] Subtest semaphore-codependency: SUCCESS (0.017s)
[82.153591] [017/133] (938s left) kms_chamelium_audio (dp-audio)
[82.528600] Subtest dp-audio: SKIP (0.000s)
[83.365247] [018/133] (937s left) gem_ctx_shared (exec-shared-gtt)
[83.417662] Starting subtest: exec-shared-gtt
[83.418648] Starting dynamic subtest: rcs0
[83.426739] Dynamic subtest rcs0: SUCCESS (0.009s)
[83.435356] Starting dynamic subtest: bcs0
[83.437553] Dynamic subtest bcs0: SUCCESS (0.010s)
[83.446694] Starting dynamic subtest: vcs0
[83.447538] Dynamic subtest vcs0: SUCCESS (0.008s)
[83.454117] Starting dynamic subtest: vcs1
[83.454953] Dynamic subtest vcs1: SUCCESS (0.006s)
[83.461823] Starting dynamic subtest: vecs0
[83.462716] Dynamic subtest vecs0: SUCCESS (0.006s)
[83.469610] Starting dynamic subtest: ccs0
[83.470391] Dynamic subtest ccs0: SUCCESS (0.006s)
[83.471254] Subtest exec-shared-gtt: SUCCESS (0.047s)
[83.657010] [019/133] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[83.745856] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[83.747753] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[83.844750] [020/133] (936s left) gem_exec_schedule (independent)
[83.893833] Starting subtest: independent
[83.894919] Starting dynamic subtest: rcs0
[85.920949] Dynamic subtest rcs0: SUCCESS (2.018s)
[85.930717] Starting dynamic subtest: vcs0
[87.919818] Dynamic subtest vcs0: SUCCESS (1.997s)
[87.930077] Starting dynamic subtest: vcs1
[89.907793] Dynamic subtest vcs1: SUCCESS (1.986s)
[89.914626] Starting dynamic subtest: vecs0
[91.946388] Dynamic subtest vecs0: SUCCESS (2.037s)
[91.955685] Starting dynamic subtest: ccs0
[93.919717] Dynamic subtest ccs0: SUCCESS (1.972s)
[93.921117] Subtest independent: SUCCESS (10.017s)
[94.205318] [021/133] (926s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[94.296062] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[94.296923] Starting dynamic subtest: pipe-A-default-mode
[95.458924] Dynamic subtest pipe-A-default-mode: SKIP (1.160s)
[95.461653] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.162s)
[95.590790] [022/133] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[95.696802] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[96.333046] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[96.516069] [023/133] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[96.610517] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[96.612402] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[96.694156] [024/133] (923s left) kms_chamelium_frames (dp-crc-multiple)
[97.060356] Subtest dp-crc-multiple: SKIP (0.000s)
[97.824624] [025/133] (922s left) kms_cursor_crc (cursor-offscreen-64x21)
[98.020972] Starting subtest: cursor-offscreen-64x21
[98.063526] Subtest cursor-offscreen-64x21: SKIP (0.041s)
[98.283041] [026/133] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[98.367111] Starting subtest: addfb25-yf-tiled-legacy
[98.367968] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[98.465468] [027/133] (922s left) kms_pm_dc (dc5-retention-flops)
[99.560861] Starting subtest: dc5-retention-flops
[99.562404] Subtest dc5-retention-flops: SKIP (0.000s)
[99.630552] [028/133] (921s left) gem_eio (wait-immediate)
[99.883939] Starting subtest: wait-immediate
[100.276883] Subtest wait-immediate: SUCCESS (0.394s)
[100.431449] [029/133] (920s left) kms_atomic_interruptible (legacy-dpms)
[100.533103] Starting subtest: legacy-dpms
[100.534029] Starting dynamic subtest: pipe-A-eDP-1
[107.978177] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.445s)
[107.978970] Subtest legacy-dpms: SUCCESS (7.446s)
[108.813693] [030/133] (912s left) kms_big_fb (linear-16bpp-rotate-270)
[108.905777] Starting subtest: linear-16bpp-rotate-270
[108.925225] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[109.033076] [031/133] (911s left) i915_drm_fdinfo (virtual-busy-all)
[109.067500] Starting subtest: virtual-busy-all
[109.069421] Subtest virtual-busy-all: SKIP (0.000s)
[109.144172] [032/133] (911s left) sriov_basic (enable-vfs-autoprobe-off)
[109.197804] Starting subtest: enable-vfs-autoprobe-off
[109.198931] Starting dynamic subtest: numvfs-1
[109.233877] Dynamic subtest numvfs-1: FAIL (0.017s)
[109.241959] Starting dynamic subtest: numvfs-2
[109.269600] Dynamic subtest numvfs-2: FAIL (0.004s)
[109.276867] Starting dynamic subtest: numvfs-3
[109.303731] Dynamic subtest numvfs-3: FAIL (0.004s)
[109.310901] Starting dynamic subtest: numvfs-4
[109.338390] Dynamic subtest numvfs-4: FAIL (0.004s)
[109.348195] Starting dynamic subtest: numvfs-5
[109.375369] Dynamic subtest numvfs-5: FAIL (0.004s)
[109.382235] Starting dynamic subtest: numvfs-6
[109.416681] Dynamic subtest numvfs-6: FAIL (0.004s)
[109.423380] Starting dynamic subtest: numvfs-7
[109.449772] Dynamic subtest numvfs-7: FAIL (0.004s)
[109.456353] Starting dynamic subtest: numvfs-random
[109.481992] Dynamic subtest numvfs-random: FAIL (0.004s)
[109.488474] Starting dynamic subtest: numvfs-all
[109.514074] Dynamic subtest numvfs-all: FAIL (0.003s)
[109.514879] Subtest enable-vfs-autoprobe-off: FAIL (0.050s)
[109.540899] [033/133] (911s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[109.591808] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[109.699337] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[109.778744] [034/133] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[109.873616] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[116.961717] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.090s)
[117.066296] [035/133] (903s left) gem_vm_create (invalid-destroy)
[117.126811] Starting subtest: invalid-destroy
[117.128805] Subtest invalid-destroy: SUCCESS (0.002s)
[117.231900] [036/133] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.328682] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[124.018037] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.690s)
[124.140750] [037/133] (896s left) kms_flip (plain-flip-interruptible)
[124.253420] Starting subtest: plain-flip-interruptible
[124.255939] Starting dynamic subtest: A-eDP1
[125.906462] Dynamic subtest A-eDP1: SUCCESS (1.650s)
[125.915684] Starting dynamic subtest: B-eDP1
[127.530129] Dynamic subtest B-eDP1: SUCCESS (1.622s)
[127.537755] Starting dynamic subtest: C-eDP1
[129.153516] Dynamic subtest C-eDP1: SUCCESS (1.623s)
[129.162492] Starting dynamic subtest: D-eDP1
[130.783088] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[130.784120] Subtest plain-flip-interruptible: SUCCESS (6.530s)
[131.951941] [038/133] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[132.037253] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[132.038855] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[132.122928] [039/133] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[132.222850] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[136.016620] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.794s)
[137.155299] [040/133] (884s left) kms_psr (pr-primary-mmap-cpu)
[137.251302] Starting subtest: pr-primary-mmap-cpu
[137.252955] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[137.331923] [041/133] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[137.424302] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[145.195668] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.772s)
[145.289216] [042/133] (875s left) api_intel_allocator (standalone)
[145.342328] Starting subtest: standalone
[145.361297] Subtest standalone: SUCCESS (0.020s)
[145.479376] [043/133] (875s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[145.522407] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[145.523335] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[145.604365] [044/133] (875s left) kms_psr (fbc-pr-cursor-plane-onoff)
[145.687293] Starting subtest: fbc-pr-cursor-plane-onoff
[145.688936] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[145.763734] [045/133] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[145.851052] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[145.852747] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[145.932855] [046/133] (875s left) gem_exec_reloc (basic-write-cpu)
[145.980049] Subtest basic-write-cpu: SKIP (0.000s)
[146.050978] [047/133] (875s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[146.145737] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[146.147557] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[146.235211] [048/133] (875s left) i915_pm_rpm (gem-pread)
[148.057969] Starting subtest: gem-pread
[149.830165] Subtest gem-pread: SUCCESS (1.774s)
[149.912840] [049/133] (871s left) kms_chamelium_hpd (common-hpd-after-suspend)
[150.312139] Subtest common-hpd-after-suspend: SKIP (0.000s)
[151.090433] [050/133] (870s left) gem_exec_fence (long-history)
[151.541966] Starting subtest: long-history
[158.654203] Subtest long-history: SUCCESS (7.104s)
[159.671556] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[159.673869] [051/133] (861s left) kms_prop_blob (invalid-get-prop)
[159.725073] Starting subtest: invalid-get-prop
[159.725931] Subtest invalid-get-prop: SUCCESS (0.000s)
[159.819609] [052/133] (861s left) i915_hangman (gt-engine-error)
[159.886658] Starting subtest: gt-engine-error
[159.887497] Starting dynamic subtest: rcs0
[161.918395] Dynamic subtest rcs0: SUCCESS (2.021s)
[161.930839] Starting dynamic subtest: bcs0
[163.903601] Dynamic subtest bcs0: SUCCESS (1.983s)
[163.914489] Starting dynamic subtest: vcs0
[165.885330] Dynamic subtest vcs0: SUCCESS (1.980s)
[165.897689] Starting dynamic subtest: vcs1
[167.870042] Dynamic subtest vcs1: SUCCESS (1.982s)
[167.880455] Starting dynamic subtest: vecs0
[169.854614] Dynamic subtest vecs0: SUCCESS (1.982s)
[169.864599] Starting dynamic subtest: ccs0
[171.837676] Dynamic subtest ccs0: SUCCESS (1.981s)
[171.838796] Subtest gt-engine-error: SUCCESS (11.942s)
[171.936651] [053/133] (849s left) gem_exec_fence (basic-await)
[172.113655] Starting subtest: basic-await
[172.114958] Starting dynamic subtest: rcs0
[172.184485] Dynamic subtest rcs0: SUCCESS (0.079s)
[172.195050] Starting dynamic subtest: bcs0
[172.260469] Dynamic subtest bcs0: SUCCESS (0.074s)
[172.271225] Starting dynamic subtest: vcs0
[172.335713] Dynamic subtest vcs0: SUCCESS (0.074s)
[172.346405] Starting dynamic subtest: vcs1
[172.409607] Dynamic subtest vcs1: SUCCESS (0.073s)
[172.421962] Starting dynamic subtest: vecs0
[172.485328] Dynamic subtest vecs0: SUCCESS (0.073s)
[172.496092] Starting dynamic subtest: ccs0
[172.565382] Dynamic subtest ccs0: SUCCESS (0.078s)
[172.567250] Subtest basic-await: SUCCESS (0.460s)
[174.019123] [054/133] (847s left) syncobj_timeline (wait-for-submit-delayed-submit)
[174.076017] Starting subtest: wait-for-submit-delayed-submit
[174.181372] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[174.263774] [055/133] (847s left) gem_userptr_blits (sync-overlap)
[174.340591] Starting subtest: sync-overlap
[174.341662] Subtest sync-overlap: SUCCESS (0.000s)
[174.464374] [056/133] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[174.561321] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[182.002853] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.441s)
[182.135855] [057/133] (839s left) gem_mmap_gtt (fault-concurrent-y)
[182.200364] Subtest fault-concurrent-Y: SKIP (0.000s)
[182.264633] [058/133] (839s left) prime_vgem (basic-fence-mmap)
[182.331693] Starting subtest: basic-fence-mmap
[182.333860] Subtest basic-fence-mmap: SKIP (0.000s)
[182.434481] [059/133] (839s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[182.519293] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[182.520329] Starting dynamic subtest: pipe-A-eDP-1
[182.527954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[182.535843] Starting dynamic subtest: pipe-B-eDP-1
[182.543485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[182.550638] Starting dynamic subtest: pipe-C-eDP-1
[182.558424] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[182.565528] Starting dynamic subtest: pipe-D-eDP-1
[182.572897] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[182.573772] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[184.732989] [060/133] (837s left) kms_psr (psr-basic)
[184.830446] Starting subtest: psr-basic
[184.831417] Starting dynamic subtest: eDP-1
[186.422537] Dynamic subtest eDP-1: SUCCESS (1.592s)
[186.423436] Subtest psr-basic: SUCCESS (1.593s)
[187.300730] [061/133] (834s left) kms_color (gamma)
[187.390338] Starting subtest: gamma
[187.391260] Starting dynamic subtest: pipe-A-eDP-1
[188.111502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[188.119841] Starting dynamic subtest: pipe-B-eDP-1
[189.519450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[189.526739] Starting dynamic subtest: pipe-C-eDP-1
[190.893192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[190.900544] Starting dynamic subtest: pipe-D-eDP-1
[192.221705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[192.222849] Subtest gamma: SUCCESS (4.831s)
[193.032321] [062/133] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[193.135196] Starting subtest: compare-crc-sanitycheck-xr24
[193.135985] Starting dynamic subtest: pipe-A-eDP-1
[193.756257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[193.765158] Starting dynamic subtest: pipe-B-eDP-1
[195.012547] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s)
[195.021368] Starting dynamic subtest: pipe-C-eDP-1
[196.301363] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[196.308629] Starting dynamic subtest: pipe-D-eDP-1
[197.502488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[197.503232] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.368s)
[198.347016] [063/133] (823s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[198.445621] Starting subtest: y-tiled-64bpp-rotate-0
[198.447156] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[198.534151] [064/133] (823s left) perf_pmu (busy)
[198.568987] Starting subtest: busy
[198.569819] Starting dynamic subtest: rcs0
[199.159421] Dynamic subtest rcs0: SUCCESS (0.591s)
[199.172359] Starting dynamic subtest: bcs0
[199.721502] Dynamic subtest bcs0: SUCCESS (0.560s)
[199.732970] Starting dynamic subtest: vcs0
[200.927642] Dynamic subtest vcs0: SUCCESS (1.194s)
[200.937770] Starting dynamic subtest: vcs1
[202.910586] Dynamic subtest vcs1: SUCCESS (1.980s)
[202.921083] Starting dynamic subtest: vecs0
[204.895968] Dynamic subtest vecs0: SUCCESS (1.981s)
[204.906464] Starting dynamic subtest: ccs0
[205.454120] Dynamic subtest ccs0: SUCCESS (0.565s)
[205.455537] Subtest busy: SUCCESS (6.887s)
[205.552778] [065/133] (816s left) gem_workarounds (suspend-resume-context)
[205.615402] Starting subtest: suspend-resume-context
[222.310827] Subtest suspend-resume-context: SUCCESS (1.676s)
[229.462097] [066/133] (799s left) kms_plane_multiple (tiling-yf)
[229.559581] Starting subtest: tiling-yf
[229.561251] Subtest tiling-yf: SKIP (0.000s)
[229.631667] [067/133] (799s left) kms_flip (basic-flip-vs-dpms)
[229.718391] Starting subtest: basic-flip-vs-dpms
[229.724327] Starting dynamic subtest: A-eDP1
[232.279329] Dynamic subtest A-eDP1: SUCCESS (2.552s)
[232.288179] Starting dynamic subtest: B-eDP1
[234.504936] Dynamic subtest B-eDP1: SUCCESS (2.223s)
[234.514946] Starting dynamic subtest: C-eDP1
[236.668153] Dynamic subtest C-eDP1: SUCCESS (2.159s)
[236.677188] Starting dynamic subtest: D-eDP1
[238.851739] Dynamic subtest D-eDP1: SUCCESS (2.182s)
[238.855628] Subtest basic-flip-vs-dpms: SUCCESS (9.132s)
[239.648352] [068/133] (789s left) gem_ctx_create (basic)
[239.698714] Starting subtest: basic
[239.699537] Subtest basic: SUCCESS (0.000s)
[239.890828] [069/133] (789s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[239.945313] Starting subtest: multi-wait-all-for-submit-available-submitted
[239.946308] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[240.011100] [070/133] (789s left) gem_lmem_swapping (heavy-verify-multi)
[240.054384] Subtest heavy-verify-multi: SKIP (0.000s)
[240.094687] [071/133] (789s left) api_intel_bb (object-reloc-purge-cache)
[240.141561] Starting subtest: object-reloc-purge-cache
[240.144250] Subtest object-reloc-purge-cache: SKIP (0.003s)
[240.243444] [072/133] (789s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[240.299795] Starting subtest: multi-wait-for-submit-submitted-signaled
[240.300920] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[240.405361] [073/133] (788s left) gem_exec_params (rel-constants-invalid-ring)
[240.470875] Starting subtest: rel-constants-invalid-ring
[240.471781] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[240.572706] [074/133] (788s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[240.665837] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[240.667601] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[240.757980] [075/133] (788s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[240.803515] Starting subtest: yf-tiled-to-vebox-x-tiled
[240.805245] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[240.984870] [076/133] (788s left) i915_pm_rps (waitboost)
[241.040499] Starting subtest: waitboost
[247.404567] Subtest waitboost: SUCCESS (6.352s)
[247.471735] [077/133] (781s left) kms_joiner (invalid-modeset-force-big-joiner)
[247.567970] Starting subtest: invalid-modeset-force-big-joiner
[247.569955] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[247.647792] [078/133] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[247.735551] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[247.737213] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[247.831863] [079/133] (781s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[247.925099] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[247.952522] Starting dynamic subtest: pipe-A-plane-0
[248.385728] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[248.394542] Starting dynamic subtest: pipe-A-plane-3
[248.641800] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[248.658824] Starting dynamic subtest: pipe-A-plane-5
[248.661055] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[249.740792] Starting dynamic subtest: pipe-B-plane-0
[250.165993] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[250.174839] Starting dynamic subtest: pipe-B-plane-3
[250.421718] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[250.438581] Starting dynamic subtest: pipe-B-plane-5
[250.440345] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[250.735005] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.809s)
[252.212746] [080/133] (777s left) perf (short-reads)
[252.339931] Starting subtest: short-reads
[252.354624] Subtest short-reads: SUCCESS (0.015s)
[252.399028] [081/133] (777s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[252.491477] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[252.492282] Starting dynamic subtest: pipe-A
[252.511946] Dynamic subtest pipe-A: SKIP (0.018s)
[252.520786] Starting dynamic subtest: pipe-B
[252.543308] Dynamic subtest pipe-B: SKIP (0.031s)
[252.551757] Starting dynamic subtest: pipe-C
[252.577136] Dynamic subtest pipe-C: SKIP (0.032s)
[252.585672] Starting dynamic subtest: pipe-D
[252.608550] Dynamic subtest pipe-D: SKIP (0.032s)
[252.610161] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.116s)
[252.701817] [082/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[252.791927] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[253.770196] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s)
[253.912031] [083/133] (775s left) kms_cursor_crc (cursor-random-512x512)
[254.166855] Starting subtest: cursor-random-512x512
[254.168529] Subtest cursor-random-512x512: SKIP (0.001s)
[254.325596] [084/133] (775s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[254.435514] Starting subtest: short-flip-before-cursor-toggle
[255.351198] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[256.148497] [085/133] (773s left) gem_exec_params (sol-reset-not-gen7)
[256.199032] Starting subtest: sol-reset-not-gen7
[256.202123] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[256.319187] [086/133] (773s left) kms_addfb_basic (bad-pitch-1024)
[256.369658] Starting subtest: bad-pitch-1024
[256.370612] Subtest bad-pitch-1024: SUCCESS (0.000s)
[256.497122] [087/133] (773s left) gem_exec_params (no-vebox)
[256.551768] Starting subtest: no-vebox
[256.554888] Subtest no-vebox: SUCCESS (0.002s)
[257.973667] [088/133] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[258.067586] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[258.069195] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[258.180804] [089/133] (771s left) kms_rotation_crc (primary-rotation-270)
[258.264584] Starting subtest: primary-rotation-270
[258.266296] Subtest primary-rotation-270: SKIP (0.001s)
[258.336290] [090/133] (771s left) gem_barrier_race (remote-request)
[258.387959] Starting subtest: remote-request
[258.388869] Starting dynamic subtest: rcs0
[263.591974] Dynamic subtest rcs0: SUCCESS (5.203s)
[263.593638] Subtest remote-request: SUCCESS (5.205s)
[263.735306] [091/133] (766s left) syncobj_basic (bad-flags-handle-to-fd)
[263.782003] Starting subtest: bad-flags-handle-to-fd
[263.782872] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[263.869998] [092/133] (766s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[263.950781] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[263.951607] Starting dynamic subtest: pipe-A
[264.291888] Dynamic subtest pipe-A: SUCCESS (0.342s)
[264.300677] Starting dynamic subtest: pipe-B
[265.765940] Dynamic subtest pipe-B: SUCCESS (1.473s)
[265.778027] Starting dynamic subtest: pipe-C
[267.185025] Dynamic subtest pipe-C: SUCCESS (1.417s)
[267.196326] Starting dynamic subtest: pipe-D
[268.642318] Dynamic subtest pipe-D: SUCCESS (1.456s)
[268.643198] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.692s)
[269.784855] [093/133] (760s left) gen9_exec_parse (batch-zero-length)
[269.847670] Subtest batch-zero-length: SKIP (0.000s)
[269.924847] [094/133] (760s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[269.983387] Starting subtest: multi-wait-for-submit-submitted-signaled
[269.984316] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[270.085697] [095/133] (760s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[270.177309] Starting subtest: pr-cursor-plane-move-continuous-sf
[270.179205] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[270.255797] [096/133] (759s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[270.352292] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[270.353954] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[270.472339] [097/133] (759s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[270.571506] Starting subtest: cursor-tearing-framebuffer-change
[270.572350] Starting dynamic subtest: pipe-A-eDP-1
[271.138306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[271.147052] Starting dynamic subtest: pipe-D-eDP-1
[272.330645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[272.331522] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.758s)
[273.165655] [098/133] (757s left) gem_ctx_persistence (legacy-engines-hang)
[273.222316] Starting subtest: legacy-engines-hang
[273.223248] Starting dynamic subtest: render
[273.339012] Dynamic subtest render: SUCCESS (0.116s)
[273.351753] Starting dynamic subtest: bsd1
[273.441911] Dynamic subtest bsd1: SUCCESS (0.100s)
[273.453683] Starting dynamic subtest: bsd2
[273.532973] Dynamic subtest bsd2: SUCCESS (0.088s)
[273.545013] Starting dynamic subtest: blt
[273.556329] Dynamic subtest blt: SUCCESS (0.021s)
[273.566580] Starting dynamic subtest: vebox
[273.682896] Dynamic subtest vebox: SUCCESS (0.124s)
[273.686772] Subtest legacy-engines-hang: SUCCESS (0.462s)
[273.762708] [099/133] (756s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[273.853932] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[273.855865] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[273.951836] [100/133] (756s left) gem_mmap_gtt (cpuset-big-copy)
[274.000938] Subtest cpuset-big-copy: SKIP (0.000s)
[274.062635] [101/133] (756s left) kms_psr (psr-sprite-mmap-gtt)
[274.145498] Starting subtest: psr-sprite-mmap-gtt
[274.146368] Starting dynamic subtest: eDP-1
[275.599735] Dynamic subtest eDP-1: SKIP (1.443s)
[275.601431] Subtest psr-sprite-mmap-gtt: SKIP (1.445s)
[275.766387] [102/133] (754s left) gem_exec_fence (syncobj-timeline-wait)
[276.301253] Starting subtest: syncobj-timeline-wait
[277.973357] Subtest syncobj-timeline-wait: SUCCESS (1.672s)
[279.976976] [103/133] (750s left) syncobj_timeline (signal-point-0)
[280.037296] Starting subtest: signal-point-0
[280.038286] Subtest signal-point-0: SUCCESS (0.000s)
[280.149310] [104/133] (750s left) gem_tiled_partial_pwrite_pread (reads)
[280.201106] Subtest reads: SKIP (0.000s)
[280.273574] [105/133] (750s left) gem_render_copy (yf-tiled-ccs-to-linear)
[280.332732] Starting subtest: yf-tiled-ccs-to-linear
[280.334649] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[280.526899] [106/133] (749s left) gem_readwrite (read-write)
[280.578672] Subtest read-write: SKIP (0.000s)
[280.653767] [107/133] (749s left) gem_mmap_wc (bad-object)
[280.702011] Subtest bad-object: SKIP (0.000s)
[280.762876] [108/133] (749s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[280.855725] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[280.857577] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[280.942691] [109/133] (749s left) gem_exec_balancer (parallel-bb-first)
[281.201068] Starting subtest: parallel-bb-first
[282.231333] Subtest parallel-bb-first: SUCCESS (1.030s)
[282.912082] [110/133] (747s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[283.005743] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[283.007678] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[283.097910] [111/133] (747s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[283.184734] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[283.185592] Starting dynamic subtest: pipe-A-eDP-1
[285.343994] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.159s)
[285.354360] Starting dynamic subtest: pipe-B-eDP-1
[287.681664] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.336s)
[287.691851] Starting dynamic subtest: pipe-C-eDP-1
[289.834719] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.151s)
[289.845125] Starting dynamic subtest: pipe-D-eDP-1
[291.973025] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.137s)
[291.973916] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.789s)
[293.127554] [112/133] (737s left) kms_flip (nonexisting-fb-interruptible)
[293.213989] Starting subtest: nonexisting-fb-interruptible
[293.216102] Starting dynamic subtest: A-eDP1
[294.327476] Dynamic subtest A-eDP1: SUCCESS (1.111s)
[294.344309] Starting dynamic subtest: B-eDP1
[295.463866] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[295.473425] Starting dynamic subtest: C-eDP1
[296.593611] Dynamic subtest C-eDP1: SUCCESS (1.128s)
[296.604292] Starting dynamic subtest: D-eDP1
[297.729733] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[297.734319] Subtest nonexisting-fb-interruptible: SUCCESS (4.520s)
[298.907487] [113/133] (731s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[299.003214] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[299.015795] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.012s)
[299.099760] [114/133] (731s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[299.194601] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[299.195531] Starting dynamic subtest: pipe-A-eDP-1
[299.643961] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[299.653081] Starting dynamic subtest: pipe-B-eDP-1
[301.170838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s)
[301.180095] Starting dynamic subtest: pipe-C-eDP-1
[302.609096] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.437s)
[302.618650] Starting dynamic subtest: pipe-D-eDP-1
[304.009103] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[304.009980] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.805s)
[305.117891] [115/133] (725s left) perf_pmu (busy-idle-no-semaphores)
[305.159121] Starting subtest: busy-idle-no-semaphores
[305.160013] Starting dynamic subtest: rcs0
[305.826564] Dynamic subtest rcs0: SUCCESS (0.658s)
[305.835945] Starting dynamic subtest: bcs0
[306.480223] Dynamic subtest bcs0: SUCCESS (0.651s)
[306.489843] Starting dynamic subtest: vcs0
[307.131577] Dynamic subtest vcs0: SUCCESS (0.649s)
[307.142036] Starting dynamic subtest: vcs1
[308.524249] Dynamic subtest vcs1: SUCCESS (1.390s)
[308.535179] Starting dynamic subtest: vecs0
[310.574116] Dynamic subtest vecs0: SUCCESS (2.047s)
[310.584585] Starting dynamic subtest: ccs0
[312.562959] Dynamic subtest ccs0: SUCCESS (1.986s)
[312.564298] Subtest busy-idle-no-semaphores: SUCCESS (7.395s)
[312.668668] [116/133] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[312.753917] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[312.755757] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[312.845471] [117/133] (718s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[312.969892] Starting subtest: dp-mst-type-0-suspend-resume
[312.971711] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[313.091687] [118/133] (717s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[313.179541] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[319.921293] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.740s)
[320.046322] [119/133] (710s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[320.145218] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[320.146537] Starting dynamic subtest: A-eDP1
[329.086807] Dynamic subtest A-eDP1: SUCCESS (8.940s)
[329.097801] Starting dynamic subtest: B-eDP1
[338.013399] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[338.030713] Starting dynamic subtest: C-eDP1
[346.967437] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[346.976105] Starting dynamic subtest: D-eDP1
[355.811775] Dynamic subtest D-eDP1: SUCCESS (8.843s)
[355.812718] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.635s)
[357.011393] [120/133] (673s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[357.097887] Starting subtest: primary-y-tiled-reflect-x-0
[357.156939] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[357.255420] [121/133] (673s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[357.354969] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[357.356817] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[357.445079] [122/133] (673s left) gem_ctx_isolation (preservation-s3)
[357.499396] Starting subtest: preservation-S3
[357.500446] Starting dynamic subtest: rcs0
[374.348826] Dynamic subtest rcs0: SUCCESS (1.710s)
[374.358929] Starting dynamic subtest: bcs0
[391.375232] Dynamic subtest bcs0: SUCCESS (1.764s)
[391.385054] Starting dynamic subtest: vcs0
[408.349328] Dynamic subtest vcs0: SUCCESS (3.452s)
[408.358990] Starting dynamic subtest: vcs1
[426.361816] Dynamic subtest vcs1: SUCCESS (4.979s)
[426.371545] Starting dynamic subtest: vecs0
[444.361165] Dynamic subtest vecs0: SUCCESS (4.984s)
[444.370781] Starting dynamic subtest: ccs0
[462.345605] Dynamic subtest ccs0: SUCCESS (3.112s)
[462.346473] Subtest preservation-S3: SUCCESS (20.007s)
[469.585412] [123/133] (568s left) gem_exec_store (cachelines)
[469.645236] Starting subtest: cachelines
[469.646289] Starting dynamic subtest: rcs0
[469.726831] Dynamic subtest rcs0: SUCCESS (0.081s)
[469.740136] Starting dynamic subtest: bcs0
[469.782482] Dynamic subtest bcs0: SUCCESS (0.053s)
[469.795764] Starting dynamic subtest: vcs0
[469.839175] Dynamic subtest vcs0: SUCCESS (0.055s)
[469.851078] Starting dynamic subtest: vcs1
[469.901246] Dynamic subtest vcs1: SUCCESS (0.060s)
[469.913322] Starting dynamic subtest: vecs0
[469.959392] Dynamic subtest vecs0: SUCCESS (0.056s)
[469.971152] Starting dynamic subtest: ccs0
[470.013797] Dynamic subtest ccs0: SUCCESS (0.053s)
[470.014931] Subtest cachelines: SUCCESS (0.370s)
[470.211585] [124/133] (567s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[470.312873] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[470.314629] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[471.412871] [125/133] (566s left) gem_exec_reloc (basic-wc-cpu-active)
[471.474950] Subtest basic-wc-cpu-active: SKIP (0.000s)
[471.551852] [126/133] (566s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[471.633033] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[471.633840] Starting dynamic subtest: pipe-A-default-mode
[472.782224] Dynamic subtest pipe-A-default-mode: SKIP (1.145s)
[472.783953] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.147s)
[472.921282] [127/133] (565s left) kms_universal_plane (universal-plane-functional)
[473.010173] Starting subtest: universal-plane-functional
[473.010966] Starting dynamic subtest: pipe-A-eDP-1
[477.005475] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.989s)
[477.014758] Starting dynamic subtest: pipe-B-eDP-1
[481.507842] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.499s)
[481.517976] Starting dynamic subtest: pipe-C-eDP-1
[485.864566] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.352s)
[485.873385] Starting dynamic subtest: pipe-D-eDP-1
[490.298908] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.432s)
[490.299900] Subtest universal-plane-functional: SUCCESS (17.278s)
[491.129278] [128/133] (547s left) device_reset (cold-reset-bound)
[491.184658] Starting subtest: cold-reset-bound
[491.186340] Subtest cold-reset-bound: SKIP (0.000s)
[491.252030] [129/133] (547s left) kms_fb_coherency (memset-crc)
[491.344515] Starting subtest: memset-crc
[491.345496] Starting dynamic subtest: mmap-offset-wc
[491.708650] Dynamic subtest mmap-offset-wc: SUCCESS (0.364s)
[492.023352] Starting dynamic subtest: mmap-offset-uc
[498.274302] Dynamic subtest mmap-offset-uc: SUCCESS (6.264s)
[498.568462] Subtest memset-crc: SUCCESS (7.222s)
[499.406208] [130/133] (538s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[499.501184] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[499.502949] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[499.602329] [131/133] (538s left) syncobj_eventfd (invalid-bad-pad)
[499.662727] Starting subtest: invalid-bad-pad
[499.664158] Subtest invalid-bad-pad: SUCCESS (0.000s)
[499.777182] [132/133] (538s left) gem_exec_nop (basic-parallel)
[499.830502] Starting subtest: basic-parallel
[515.760378] Subtest basic-parallel: SUCCESS (15.917s)
[515.964966] [133/133] (522s left) gem_softpin (reverse)
[516.016345] Starting subtest: reverse
[516.024728] Subtest reverse: SUCCESS (0.008s)
[516.150077] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_engines
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_dirtyfb
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_basic
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_chamelium_audio
results: parsing output: 17/ for test: gem_ctx_shared
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_pm_dc
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_atomic_interruptible
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: sriov_basic
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_vm_create
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_reloc
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_color
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: kms_plane_multiple
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_ctx_create
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: i915_pm_rps
results: parsing output: 76/ for test: kms_joiner
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: gem_barrier_race
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: gen9_exec_parse
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_readwrite
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_ctx_isolation
results: parsing output: 122/ for test: gem_exec_store
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_universal_plane
results: parsing output: 127/ for test: device_reset
results: parsing output: 128/ for test: kms_fb_coherency
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_eventfd
results: parsing output: 131/ for test: gem_exec_nop
results: parsing output: 132/ for test: gem_softpin
Done.