[57.169986] Initializing watchdogs
[57.170062]   /dev/watchdog0
[57.184617] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.188424] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.190703] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.194451] [001/132] (960s left) kms_chamelium_hpd (dp-hpd-fast)
[57.596728] Subtest dp-hpd-fast: SKIP (0.000s)
[58.447949] [002/132] (959s left) i915_hangman (gt-error-state-capture)
[58.523680] Starting subtest: gt-error-state-capture
[58.526096] Starting dynamic subtest: rcs0
[69.817367] Dynamic subtest rcs0: SUCCESS (11.256s)
[69.828671] Starting dynamic subtest: bcs0
[81.847849] Dynamic subtest bcs0: SUCCESS (12.019s)
[81.858065] Starting dynamic subtest: vcs0
[92.791601] Dynamic subtest vcs0: SUCCESS (10.937s)
[92.803087] Starting dynamic subtest: vcs1
[104.759557] Dynamic subtest vcs1: SUCCESS (11.964s)
[104.769304] Starting dynamic subtest: vecs0
[113.783629] Dynamic subtest vecs0: SUCCESS (9.021s)
[113.792818] Starting dynamic subtest: ccs0
[125.816519] Dynamic subtest ccs0: SUCCESS (12.030s)
[125.819512] Subtest gt-error-state-capture: SUCCESS (67.234s)
[125.895186] [003/132] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[125.986835] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[125.991217] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[126.071563] [004/132] (891s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[126.171773] Starting subtest: short-busy-flip-before-cursor-toggle
[126.176426] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[126.309216] [005/132] (891s left) gem_exec_reloc (basic-write-wc-active)
[126.377248] Subtest basic-write-wc-active: SKIP (0.000s)
[126.444314] [006/132] (891s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[126.537389] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[126.541580] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[126.626270] [007/132] (891s left) gem_userptr_blits (sync-overlap)
[126.692035] Starting subtest: sync-overlap
[126.693945] Subtest sync-overlap: SUCCESS (0.000s)
[126.830901] [008/132] (891s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[126.917521] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[126.921077] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[127.016802] [009/132] (891s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[127.097861] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[127.101486] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[127.162822] [010/132] (890s left) kms_atomic_interruptible (legacy-dpms)
[127.239916] Starting subtest: legacy-dpms
[127.242069] Starting dynamic subtest: pipe-A-eDP-1
[134.651798] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[134.654632] Subtest legacy-dpms: SUCCESS (7.410s)
[135.469766] [011/132] (882s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[135.558405] Starting subtest: fbc-rgb565-draw-mmap-gtt
[135.562482] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[135.645284] [012/132] (882s left) syncobj_wait (reset-signaled)
[135.706127] Starting subtest: reset-signaled
[135.708524] Subtest reset-signaled: SUCCESS (0.000s)
[135.805481] [013/132] (882s left) kms_addfb_basic (legacy-format)
[135.861775] Starting subtest: legacy-format
[135.884306] Subtest legacy-format: SUCCESS (0.022s)
[135.999046] [014/132] (882s left) gem_exec_schedule (preempt-queue-contexts-chain)
[136.068857] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[136.357507] [015/132] (881s left) kms_plane (pixel-format-yf-tiled-modifier)
[136.430038] Starting subtest: pixel-format-yf-tiled-modifier
[136.434465] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[136.511226] [016/132] (881s left) prime_vgem (fence-flip-hang)
[136.640100] Subtest fence-flip-hang: SKIP (0.000s)
[136.738015] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[136.743893] [017/132] (881s left) gem_eio (kms)
[136.942918] Starting subtest: kms
[152.680707] Subtest kms: SUCCESS (15.734s)
[153.860629] [018/132] (864s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[153.956398] Starting subtest: cursorA-vs-flipA-legacy
[165.083334] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.125s)
[165.882436] [019/132] (852s left) gem_exec_reloc (basic-wc-gtt-active)
[165.944388] Subtest basic-wc-gtt-active: SKIP (0.000s)
[166.019390] [020/132] (852s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[166.092880] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[166.095169] Starting dynamic subtest: pipe-A
[166.429367] Dynamic subtest pipe-A: SUCCESS (0.338s)
[166.438144] Starting dynamic subtest: pipe-B
[167.885059] Dynamic subtest pipe-B: SUCCESS (1.455s)
[167.892812] Starting dynamic subtest: pipe-C
[169.323211] Dynamic subtest pipe-C: SUCCESS (1.438s)
[169.331377] Starting dynamic subtest: pipe-D
[170.744824] Dynamic subtest pipe-D: SUCCESS (1.420s)
[170.747056] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.653s)
[171.905110] [021/132] (846s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[172.142489] Starting subtest: cursor-rapid-movement-256x256
[172.147246] Starting dynamic subtest: pipe-A-eDP-1
[172.700328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[172.729782] Starting dynamic subtest: pipe-D-eDP-1
[173.922938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[173.924970] Subtest cursor-rapid-movement-256x256: SUCCESS (1.778s)
[174.769630] [022/132] (843s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[174.857550] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[182.199519] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.345s)
[182.310087] [023/132] (836s left) gem_close_race (basic-threads)
[182.374763] Starting subtest: basic-threads
[183.759929] Subtest basic-threads: SUCCESS (1.385s)
[183.948710] [024/132] (834s left) api_intel_bb (add-remove-objects)
[183.998116] Starting subtest: add-remove-objects
[184.003033] Subtest add-remove-objects: SUCCESS (0.006s)
[184.131920] [025/132] (834s left) perf (enable-disable)
[184.262193] Starting subtest: enable-disable
[184.264455] Starting dynamic subtest: 0-rcs0
[186.514664] Dynamic subtest 0-rcs0: SUCCESS (2.252s)
[186.523225] Starting dynamic subtest: 1-vecs0
[190.961822] Dynamic subtest 1-vecs0: SUCCESS (4.445s)
[190.964122] Subtest enable-disable: SUCCESS (6.698s)
[191.010105] [026/132] (827s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[191.101851] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[197.777433] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.679s)
[197.906528] [027/132] (820s left) kms_psr (fbc-pr-basic)
[197.998256] Starting subtest: fbc-pr-basic
[198.002861] Subtest fbc-pr-basic: SKIP (0.000s)
[198.092104] [028/132] (820s left) gem_exec_balancer (bonded-pair)
[198.145060] Starting subtest: bonded-pair
[198.149427] Subtest bonded-pair: SKIP (0.000s)
[198.447250] [029/132] (820s left) syncobj_timeline (wait-zero-handles)
[198.497199] Starting subtest: wait-zero-handles
[198.499475] Subtest wait-zero-handles: SUCCESS (0.000s)
[198.593569] [030/132] (820s left) kms_atomic (plane-invalid-params-fence)
[198.669292] Starting subtest: plane-invalid-params-fence
[198.671573] Starting dynamic subtest: pipe-A-eDP-1
[199.025612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[199.027932] Subtest plane-invalid-params-fence: SUCCESS (0.356s)
[199.821910] [031/132] (819s left) gem_exercise_blt (fast-copy)
[199.882384] Starting subtest: fast-copy
[199.884788] Starting dynamic subtest: linear-smem-smem
[199.905572] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[199.915637] Starting dynamic subtest: xmajor-smem-smem
[199.925844] Dynamic subtest xmajor-smem-smem: SUCCESS (0.020s)
[199.933425] Starting dynamic subtest: tile4-smem-smem
[199.942398] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[199.949936] Starting dynamic subtest: tile64-smem-smem
[199.959416] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[199.961685] Subtest fast-copy: SUCCESS (0.078s)
[200.075170] [032/132] (818s left) gem_exec_reloc (basic-write-gtt-noreloc)
[200.132147] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[200.207953] [033/132] (818s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[200.317386] Starting subtest: flip-vs-cursor-varying-size
[209.145637] Subtest flip-vs-cursor-varying-size: SUCCESS (8.824s)
[209.955225] [034/132] (809s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[210.056098] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[211.443546] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.387s)
[212.237601] [035/132] (806s left) gem_exec_flush (basic-wb-ro-before-default)
[212.300233] Starting subtest: basic-wb-ro-before-default
[217.762451] Subtest basic-wb-ro-before-default: SUCCESS (5.462s)
[217.946809] [036/132] (801s left) kms_addfb_basic (bad-pitch-1024)
[218.006591] Starting subtest: bad-pitch-1024
[218.008568] Subtest bad-pitch-1024: SUCCESS (0.000s)
[218.139840] [037/132] (801s left) gem_softpin (noreloc)
[218.199060] Starting subtest: noreloc
[223.591039] Subtest noreloc: SUCCESS (5.390s)
[223.712398] [038/132] (795s left) gem_pxp (regular-baseline-src-copy-readible)
[223.826027] Starting subtest: regular-baseline-src-copy-readible
[223.888608] Subtest regular-baseline-src-copy-readible: SUCCESS (0.064s)
[224.016472] [039/132] (795s left) gem_create (hog-create)
[224.068277] Starting subtest: hog-create
[224.070505] Starting dynamic subtest: smem0
[257.884715] Dynamic subtest smem0: SUCCESS (33.813s)
[257.887794] Subtest hog-create: SUCCESS (33.815s)
[258.067430] [040/132] (761s left) kms_pm_backlight (fade-with-suspend)
[258.156284] Starting subtest: fade-with-suspend
[274.025299] Starting dynamic subtest: eDP-1
[277.462680] Dynamic subtest eDP-1: SUCCESS (3.335s)
[277.465153] Subtest fade-with-suspend: SUCCESS (4.690s)
[277.838900] [041/132] (741s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[277.938037] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[277.942579] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[278.007652] [042/132] (741s left) kms_psr (psr-dpms)
[278.081555] Starting subtest: psr-dpms
[278.083820] Starting dynamic subtest: eDP-1
[281.051493] Dynamic subtest eDP-1: SUCCESS (2.906s)
[281.053769] Subtest psr-dpms: SUCCESS (2.908s)
[281.937872] [043/132] (737s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[282.025414] Starting subtest: yf-tiled-64bpp-rotate-270
[282.029884] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[282.126310] [044/132] (737s left) sriov_basic (enable-vfs-autoprobe-on)
[282.189879] Starting subtest: enable-vfs-autoprobe-on
[282.192480] Starting dynamic subtest: numvfs-1
[282.275681] Dynamic subtest numvfs-1: FAIL (0.032s)
[282.290539] Starting dynamic subtest: numvfs-2
[282.361216] Dynamic subtest numvfs-2: FAIL (0.003s)
[282.370592] Starting dynamic subtest: numvfs-3
[282.440908] Dynamic subtest numvfs-3: FAIL (0.003s)
[282.450995] Starting dynamic subtest: numvfs-4
[282.520315] Dynamic subtest numvfs-4: FAIL (0.003s)
[282.529072] Starting dynamic subtest: numvfs-5
[282.598708] Dynamic subtest numvfs-5: FAIL (0.003s)
[282.609080] Starting dynamic subtest: numvfs-6
[282.679311] Dynamic subtest numvfs-6: FAIL (0.003s)
[282.687586] Starting dynamic subtest: numvfs-7
[282.758800] Dynamic subtest numvfs-7: FAIL (0.003s)
[282.768305] Starting dynamic subtest: numvfs-random
[282.841717] Dynamic subtest numvfs-random: FAIL (0.003s)
[282.851534] Starting dynamic subtest: numvfs-all
[282.916987] Dynamic subtest numvfs-all: FAIL (0.490s)
[282.918939] Subtest enable-vfs-autoprobe-on: FAIL (0.554s)
[282.955975] [045/132] (736s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[283.058321] Starting subtest: compare-crc-sanitycheck-xr24
[283.062317] Starting dynamic subtest: pipe-A-eDP-1
[283.718860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.648s)
[283.729005] Starting dynamic subtest: pipe-B-eDP-1
[285.065998] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.331s)
[285.075773] Starting dynamic subtest: pipe-C-eDP-1
[286.338046] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.258s)
[286.347472] Starting dynamic subtest: pipe-D-eDP-1
[287.573629] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[287.576154] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.467s)
[288.435624] [046/132] (731s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[288.517362] Starting subtest: plane-primary-toggle-with-vblank-wait
[288.519717] Starting dynamic subtest: pipe-A-eDP-1
[288.692136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[289.012974] Starting dynamic subtest: pipe-B-eDP-1
[289.932343] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.922s)
[290.249728] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.721s)
[291.110873] [047/132] (728s left) syncobj_timeline (invalid-transfer-illegal-handle)
[291.173779] Starting subtest: invalid-transfer-illegal-handle
[291.175856] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[291.274798] [048/132] (728s left) kms_cursor_crc (cursor-offscreen-64x64)
[291.441086] Starting subtest: cursor-offscreen-64x64
[291.446343] Starting dynamic subtest: pipe-A-eDP-1
[293.374420] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s)
[293.401959] Starting dynamic subtest: pipe-D-eDP-1
[296.038412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s)
[296.040888] Subtest cursor-offscreen-64x64: SUCCESS (4.579s)
[296.894184] [049/132] (722s left) kms_force_connector_basic (force-load-detect)
[296.947120] Subtest force-load-detect: SKIP (0.000s)
[297.009659] [050/132] (722s left) kms_content_protection (dp-mst-type-0)
[297.141063] Starting subtest: dp-mst-type-0
[297.145665] Subtest dp-mst-type-0: SKIP (0.000s)
[297.276641] [051/132] (722s left) gem_ccs (ctrl-surf-copy-new-ctx)
[297.330071] Starting subtest: ctrl-surf-copy-new-ctx
[297.334280] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[297.433382] [052/132] (722s left) kms_fbcon_fbt (psr-suspend)
[297.492698] Starting subtest: psr-suspend
[347.041174] Subtest psr-suspend: SUCCESS (19.570s)
[347.144891] [053/132] (672s left) gem_exec_whisper (basic-contexts)
[347.214390] Starting subtest: basic-contexts
[353.126626] Subtest basic-contexts: SUCCESS (5.819s)
[353.308732] [054/132] (666s left) gem_exec_fence (keep-in-fence)
[353.490413] Starting subtest: keep-in-fence
[353.492827] Starting dynamic subtest: rcs0
[353.562767] Dynamic subtest rcs0: SUCCESS (0.071s)
[353.575554] Starting dynamic subtest: bcs0
[353.619169] Dynamic subtest bcs0: SUCCESS (0.054s)
[353.631125] Starting dynamic subtest: vcs0
[355.207700] Dynamic subtest vcs0: SUCCESS (1.571s)
[355.220911] Starting dynamic subtest: vcs1
[357.189855] Dynamic subtest vcs1: SUCCESS (1.965s)
[357.202670] Starting dynamic subtest: vecs0
[359.174510] Dynamic subtest vecs0: SUCCESS (1.971s)
[359.187381] Starting dynamic subtest: ccs0
[359.415534] Dynamic subtest ccs0: SUCCESS (0.238s)
[359.418013] Subtest keep-in-fence: SUCCESS (5.886s)
[361.244205] [055/132] (658s left) kms_prop_blob (invalid-get-prop-any)
[361.295669] Starting subtest: invalid-get-prop-any
[361.297852] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[361.380905] [056/132] (658s left) perf (blocking-parameterized)
[361.467303] Starting subtest: blocking-parameterized
[381.488378] Subtest blocking-parameterized: SUCCESS (19.991s)
[381.537878] [057/132] (638s left) kms_vblank (query-busy-hang)
[381.615605] Starting subtest: query-busy-hang
[381.617869] Starting dynamic subtest: pipe-A-eDP-1
[408.014003] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.387s)
[408.031971] Starting dynamic subtest: pipe-D-eDP-1
[422.982963] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.960s)
[422.985258] Subtest query-busy-hang: SUCCESS (41.351s)
[423.782438] [058/132] (596s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[423.870610] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[423.872832] Starting dynamic subtest: pipe-A-eDP-1
[424.599914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[424.611313] Starting dynamic subtest: pipe-B-eDP-1
[426.409231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.808s)
[426.421669] Starting dynamic subtest: pipe-C-eDP-1
[428.229968] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.819s)
[428.240485] Starting dynamic subtest: pipe-D-eDP-1
[429.975178] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.742s)
[429.977511] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.095s)
[431.124997] [059/132] (588s left) gem_tiled_pread_basic (basic)
[431.178550] Subtest basic: SKIP (0.000s)
[431.250376] [060/132] (588s left) prime_mmap (test_forked_cpu_write)
[431.301766] Starting subtest: test_forked_cpu_write
[431.303704] Starting dynamic subtest: test_forked_cpu_write-smem
[431.308995] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[431.311344] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[431.431008] [061/132] (588s left) kms_chamelium_frames (dp-crc-single)
[431.817029] Subtest dp-crc-single: SKIP (0.000s)
[432.650322] [062/132] (587s left) kms_vblank (wait-forked-busy-hang)
[432.731718] Starting subtest: wait-forked-busy-hang
[432.733606] Starting dynamic subtest: pipe-A-eDP-1
[458.952760] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.222s)
[458.967315] Starting dynamic subtest: pipe-D-eDP-1
[483.922007] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.966s)
[483.923960] Subtest wait-forked-busy-hang: SUCCESS (51.192s)
[484.720394] [063/132] (535s left) kms_psr (fbc-psr-primary-render)
[484.798386] Starting subtest: fbc-psr-primary-render
[484.800599] Starting dynamic subtest: eDP-1
[484.804742] Dynamic subtest eDP-1: SKIP (0.000s)
[484.809054] Subtest fbc-psr-primary-render: SKIP (0.001s)
[484.876561] [064/132] (535s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[484.928087] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[484.930429] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[485.028862] [065/132] (535s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[485.105396] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[491.838490] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.735s)
[491.938891] [066/132] (528s left) i915_pm_rpm (system-suspend-devices)
[493.449709] Starting subtest: system-suspend-devices
[501.100970] Subtest system-suspend-devices: SUCCESS (7.650s)
[501.488076] [067/132] (518s left) gem_workarounds (reset-fd)
[501.567028] Starting subtest: reset-fd
[501.721727] Subtest reset-fd: SUCCESS (0.153s)
[501.860551] [068/132] (518s left) gem_exec_create (forked)
[501.917051] Starting subtest: forked
[501.919392] Starting dynamic subtest: smem
[523.143807] Dynamic subtest smem: SUCCESS (21.223s)
[523.146803] Subtest forked: SUCCESS (21.225s)
[523.332546] [069/132] (497s left) gem_exec_flush (basic-batch-kernel-default-uc)
[523.389811] Starting subtest: basic-batch-kernel-default-uc
[530.138438] Subtest basic-batch-kernel-default-uc: SUCCESS (6.748s)
[530.352822] [070/132] (490s left) kms_psr (psr-cursor-mmap-cpu)
[530.420598] Starting subtest: psr-cursor-mmap-cpu
[530.422869] Starting dynamic subtest: eDP-1
[532.163329] Dynamic subtest eDP-1: SUCCESS (1.741s)
[532.165683] Subtest psr-cursor-mmap-cpu: SUCCESS (1.742s)
[533.021954] [071/132] (487s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[533.114738] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[537.246472] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.134s)
[538.422268] [072/132] (482s left) gem_mmap_offset (clear)
[538.480580] Starting subtest: clear
[538.482990] Starting dynamic subtest: smem0
[563.334053] Dynamic subtest smem0: SUCCESS (24.847s)
[563.336297] Subtest clear: SUCCESS (24.848s)
[563.471388] [073/132] (457s left) i915_power (sanity)
[563.575565] Starting subtest: sanity
[567.623060] Subtest sanity: SUCCESS (4.043s)
[569.268818] [074/132] (451s left) gem_lmem_swapping (random-engines)
[569.334538] Subtest random-engines: SKIP (0.000s)
[569.379219] [075/132] (451s left) gem_softpin (zero)
[569.439641] Starting subtest: zero
[569.450848] Subtest zero: SUCCESS (0.011s)
[569.588869] [076/132] (451s left) vgem_basic (dmabuf-fence-before)
[569.628546] Starting subtest: dmabuf-fence-before
[569.630764] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[569.692591] [077/132] (451s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[569.786280] Starting subtest: 4-tiled-32bpp-rotate-180
[571.280333] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.492s)
[571.430878] [078/132] (449s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[571.511680] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[571.515328] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[571.621990] [079/132] (449s left) gem_ringfill (legacy-basic)
[577.164155] Starting subtest: legacy-basic
[577.166827] Starting dynamic subtest: default
[577.217126] Dynamic subtest default: SUCCESS (0.055s)
[577.230273] Starting dynamic subtest: render
[577.259500] Dynamic subtest render: SUCCESS (0.040s)
[577.270512] Starting dynamic subtest: bsd
[577.303552] Dynamic subtest bsd: SUCCESS (0.041s)
[577.315197] Starting dynamic subtest: bsd1
[577.344123] Dynamic subtest bsd1: SUCCESS (0.038s)
[577.358084] Starting dynamic subtest: bsd2
[577.388784] Dynamic subtest bsd2: SUCCESS (0.042s)
[577.403161] Starting dynamic subtest: blt
[577.435762] Dynamic subtest blt: SUCCESS (0.045s)
[577.447254] Starting dynamic subtest: vebox
[577.480075] Dynamic subtest vebox: SUCCESS (0.042s)
[577.482569] Subtest legacy-basic: SUCCESS (0.321s)
[577.561980] [080/132] (443s left) kms_psr (pr-sprite-mmap-cpu)
[577.654173] Starting subtest: pr-sprite-mmap-cpu
[577.658126] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[577.728720] [081/132] (443s left) gem_exec_schedule (manyslice)
[577.798505] Starting subtest: manyslice
[577.800702] Starting dynamic subtest: rcs0
[582.919489] Dynamic subtest rcs0: SUCCESS (5.127s)
[582.932793] Starting dynamic subtest: bcs0
[589.522516] Dynamic subtest bcs0: SUCCESS (6.601s)
[589.540680] Starting dynamic subtest: vcs0
[594.588206] Dynamic subtest vcs0: SUCCESS (5.063s)
[594.602346] Starting dynamic subtest: vcs1
[600.664047] Dynamic subtest vcs1: SUCCESS (6.072s)
[600.677959] Starting dynamic subtest: vecs0
[606.223688] Dynamic subtest vecs0: SUCCESS (5.559s)
[606.234416] Starting dynamic subtest: ccs0
[612.880075] Dynamic subtest ccs0: SUCCESS (6.652s)
[612.882696] Subtest manyslice: SUCCESS (35.084s)
[613.185946] [082/132] (407s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[613.275838] Starting subtest: yf-tiled-16bpp-rotate-0
[613.280179] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[613.371858] [083/132] (407s left) syncobj_eventfd (binary-wait-signaled)
[613.439522] Starting subtest: binary-wait-signaled
[613.441780] Subtest binary-wait-signaled: SUCCESS (0.000s)
[613.548910] [084/132] (407s left) i915_drm_fdinfo (context-close-stress)
[613.583345] Starting subtest: context-close-stress
[624.335596] Subtest context-close-stress: SUCCESS (10.745s)
[624.404258] [085/132] (396s left) kms_cursor_crc (cursor-tearing-position-change)
[624.650764] Starting subtest: cursor-tearing-position-change
[624.653100] Starting dynamic subtest: pipe-A-eDP-1
[625.219702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[625.234155] Starting dynamic subtest: pipe-D-eDP-1
[626.459470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[626.461922] Subtest cursor-tearing-position-change: SUCCESS (1.809s)
[627.299079] [086/132] (393s left) gem_ctx_persistence (legacy-engines-mixed)
[627.349182] Starting subtest: legacy-engines-mixed
[627.351253] Starting dynamic subtest: render
[627.433960] Dynamic subtest render: SUCCESS (0.086s)
[627.448030] Starting dynamic subtest: bsd1
[627.486414] Dynamic subtest bsd1: SUCCESS (0.050s)
[627.498192] Starting dynamic subtest: bsd2
[627.541429] Dynamic subtest bsd2: SUCCESS (0.053s)
[627.554161] Starting dynamic subtest: blt
[627.594168] Dynamic subtest blt: SUCCESS (0.050s)
[627.608649] Starting dynamic subtest: vebox
[627.647096] Dynamic subtest vebox: SUCCESS (0.050s)
[627.649508] Subtest legacy-engines-mixed: SUCCESS (0.301s)
[627.728591] [087/132] (393s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[627.814696] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[627.816925] Starting dynamic subtest: pipe-A-eDP-1
[627.836822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[627.849067] Starting dynamic subtest: pipe-B-eDP-1
[627.868090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[627.877885] Starting dynamic subtest: pipe-C-eDP-1
[627.897176] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[627.906613] Starting dynamic subtest: pipe-D-eDP-1
[627.926064] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[627.928256] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[630.059547] [088/132] (391s left) gem_userptr_blits (unsync-unmap-after-close)
[630.133359] Subtest unsync-unmap-after-close: SKIP (0.000s)
[630.262775] [089/132] (391s left) gem_exec_params (invalid-ring2)
[630.327818] Starting subtest: invalid-ring2
[630.330164] Subtest invalid-ring2: SUCCESS (0.000s)
[630.429351] [090/132] (390s left) api_intel_bb (object-reloc-purge-cache)
[630.485432] Starting subtest: object-reloc-purge-cache
[630.489837] Subtest object-reloc-purge-cache: SKIP (0.003s)
[630.600737] [091/132] (390s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[630.680029] Starting subtest: psr-rgb101010-draw-mmap-gtt
[630.684201] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[630.774560] [092/132] (390s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[630.873903] Starting subtest: cursorB-vs-flipB-varying-size
[630.878495] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[631.022072] [093/132] (390s left) kms_flip (flip-vs-rmfb)
[631.093722] Starting subtest: flip-vs-rmfb
[631.095544] Starting dynamic subtest: A-eDP1
[639.747395] Dynamic subtest A-eDP1: SUCCESS (8.652s)
[639.760560] Starting dynamic subtest: B-eDP1
[648.381769] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[648.394348] Starting dynamic subtest: C-eDP1
[657.005297] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[657.017302] Starting dynamic subtest: D-eDP1
[665.646780] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[665.651073] Subtest flip-vs-rmfb: SUCCESS (34.550s)
[666.838642] [094/132] (354s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[666.958259] Starting subtest: multiplane-atomic-fence-wait
[667.275025] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[668.374661] [095/132] (353s left) kms_lease (cursor-implicit-plane)
[668.456220] Starting subtest: cursor-implicit-plane
[668.458792] Starting dynamic subtest: pipe-A-eDP-1
[668.916900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[668.927258] Starting dynamic subtest: pipe-B-eDP-1
[670.087779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[670.098648] Starting dynamic subtest: pipe-C-eDP-1
[671.192797] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s)
[671.204189] Starting dynamic subtest: pipe-D-eDP-1
[672.327801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[672.329993] Subtest cursor-implicit-plane: SUCCESS (3.872s)
[673.170787] [096/132] (348s left) kms_hdr (static-toggle)
[673.244632] Starting subtest: static-toggle
[673.251263] Subtest static-toggle: SKIP (0.000s)
[673.321548] [097/132] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[673.402029] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[673.406422] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[673.495902] [098/132] (348s left) kms_plane_multiple (2x-tiling-yf)
[673.572266] Starting subtest: 2x-tiling-yf
[673.576538] Subtest 2x-tiling-yf: SKIP (0.000s)
[673.655182] [099/132] (348s left) gem_userptr_blits (usage-restrictions)
[673.723522] Starting subtest: usage-restrictions
[673.725481] Subtest usage-restrictions: SUCCESS (0.000s)
[673.838370] [100/132] (347s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[673.911523] Starting subtest: x-tiled-8bpp-rotate-90
[673.933745] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[674.049831] [101/132] (347s left) kms_properties (crtc-properties-atomic)
[674.119582] Starting subtest: crtc-properties-atomic
[674.121515] Starting dynamic subtest: pipe-A-eDP-1
[674.558661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[674.569429] Starting dynamic subtest: pipe-B-eDP-1
[675.741035] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s)
[675.755501] Starting dynamic subtest: pipe-C-eDP-1
[676.875802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[676.889950] Starting dynamic subtest: pipe-D-eDP-1
[677.993888] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[677.996135] Subtest crtc-properties-atomic: SUCCESS (3.873s)
[678.795738] [102/132] (343s left) gem_exec_params (no-vebox)
[678.862275] Starting subtest: no-vebox
[678.864761] Subtest no-vebox: SUCCESS (0.002s)
[680.205803] [103/132] (341s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[680.285676] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[683.866171] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.584s)
[685.020998] [104/132] (336s left) gem_mmap_wc (pf-nonblock)
[685.079277] Subtest pf-nonblock: SKIP (0.000s)
[685.144596] [105/132] (336s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[685.220052] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[685.222238] Starting dynamic subtest: pipe-A-default-mode
[686.358629] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[686.362747] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.136s)
[686.504289] [106/132] (335s left) gem_exec_reloc (basic-scanout)
[686.565881] Subtest basic-scanout: SKIP (0.000s)
[686.644463] [107/132] (335s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[686.732159] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[686.736670] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[686.841963] [108/132] (335s left) syncobj_timeline (single-wait-all-signaled)
[686.898356] Starting subtest: single-wait-all-signaled
[686.900680] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[687.020853] [109/132] (335s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[687.097724] Starting subtest: fbc-psr2-cursor-mmap-cpu
[687.100038] Starting dynamic subtest: eDP-1
[687.104182] Dynamic subtest eDP-1: SKIP (0.000s)
[687.108410] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[687.174582] [110/132] (335s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[687.245966] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[687.248193] Starting dynamic subtest: pipe-A-eDP-1
[687.269856] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[687.281722] Starting dynamic subtest: pipe-B-eDP-1
[687.300495] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[687.309471] Starting dynamic subtest: pipe-C-eDP-1
[687.328043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[687.337030] Starting dynamic subtest: pipe-D-eDP-1
[687.355851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[687.359232] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[689.500530] [111/132] (332s left) kms_big_fb (linear-16bpp-rotate-180)
[689.595599] Starting subtest: linear-16bpp-rotate-180
[691.042498] Subtest linear-16bpp-rotate-180: SUCCESS (1.446s)
[691.154529] [112/132] (331s left) gen9_exec_parse (bb-large)
[691.217138] Subtest bb-large: SKIP (0.000s)
[691.287165] [113/132] (331s left) kms_color (ctm-0-75)
[691.362952] Starting subtest: ctm-0-75
[691.364939] Starting dynamic subtest: pipe-A-eDP-1
[696.268078] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.897s)
[696.292984] Starting dynamic subtest: pipe-B-eDP-1
[701.907990] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.644s)
[701.918744] Starting dynamic subtest: pipe-C-eDP-1
[707.251782] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.341s)
[707.263071] Starting dynamic subtest: pipe-D-eDP-1
[712.564675] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.311s)
[712.567203] Subtest ctm-0-75: SUCCESS (21.197s)
[713.393387] [114/132] (309s left) prime_vgem (coherency-gtt)
[713.476697] Starting subtest: coherency-gtt
[713.481498] Subtest coherency-gtt: SKIP (0.000s)
[713.573281] [115/132] (308s left) gem_exec_balancer (waits)
[713.631662] Starting subtest: waits
[720.138566] Subtest waits: SUCCESS (6.506s)
[720.445764] [116/132] (302s left) kms_flip (blocking-absolute-wf_vblank)
[720.529745] Starting subtest: blocking-absolute-wf_vblank
[720.532090] Starting dynamic subtest: A-eDP1
[729.268437] Dynamic subtest A-eDP1: SUCCESS (8.738s)
[729.298339] Starting dynamic subtest: B-eDP1
[737.992057] Dynamic subtest B-eDP1: SUCCESS (8.718s)
[738.003342] Starting dynamic subtest: C-eDP1
[746.727316] Dynamic subtest C-eDP1: SUCCESS (8.730s)
[746.759134] Starting dynamic subtest: D-eDP1
[755.550360] Dynamic subtest D-eDP1: SUCCESS (8.818s)
[755.555169] Subtest blocking-absolute-wf_vblank: SUCCESS (35.017s)
[756.769861] [117/132] (265s left) dumb_buffer (create-clear)
[756.832679] Starting subtest: create-clear
[791.402570] Subtest create-clear: SUCCESS (34.556s)
[791.482003] [118/132] (231s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[791.557500] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[791.559739] Starting dynamic subtest: pipe-A-eDP-1
[792.417950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[792.428938] Starting dynamic subtest: pipe-B-eDP-1
[794.050958] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.630s)
[794.062840] Starting dynamic subtest: pipe-C-eDP-1
[795.603263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.552s)
[795.613972] Starting dynamic subtest: pipe-D-eDP-1
[797.169443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.565s)
[797.171585] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.604s)
[798.410225] [119/132] (224s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[798.486040] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[807.802807] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.315s)
[807.942766] [120/132] (214s left) kms_plane (plane-panning-bottom-right)
[808.020294] Starting subtest: plane-panning-bottom-right
[808.022619] Starting dynamic subtest: pipe-A
[809.683490] Dynamic subtest pipe-A: SUCCESS (1.659s)
[809.697298] Starting dynamic subtest: pipe-B
[812.073142] Dynamic subtest pipe-B: SUCCESS (2.389s)
[812.075527] Subtest plane-panning-bottom-right: SUCCESS (4.052s)
[812.873737] [121/132] (209s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[812.945919] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[812.948283] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[813.054523] [122/132] (209s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[813.131846] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[813.136218] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[813.236787] [123/132] (209s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[813.322947] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[813.327026] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[813.420659] [124/132] (209s left) kms_fence_pin_leak
[813.563653] [125/132] (209s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[813.631678] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[813.634036] Starting dynamic subtest: pipe-A-eDP-1
[813.643510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[813.656331] Starting dynamic subtest: pipe-B-eDP-1
[813.664946] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[813.674898] Starting dynamic subtest: pipe-C-eDP-1
[813.683181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[813.693229] Starting dynamic subtest: pipe-D-eDP-1
[813.701587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[813.705593] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[815.849531] [126/132] (207s left) gem_exec_reloc (basic-cpu)
[815.910189] Subtest basic-cpu: SKIP (0.000s)
[815.983889] [127/132] (207s left) kms_rotation_crc (primary-rotation-270)
[816.051692] Starting subtest: primary-rotation-270
[816.055700] Subtest primary-rotation-270: SKIP (0.001s)
[816.126075] [128/132] (206s left) perf_pmu (event-wait)
[816.164744] Starting subtest: event-wait
[816.166933] Starting dynamic subtest: rcs0
[816.170967] Dynamic subtest rcs0: SKIP (0.000s)
[816.175042] Subtest event-wait: SKIP (0.001s)
[816.256920] [129/132] (206s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[816.357647] Starting subtest: cursorA-vs-flipA-atomic-transitions
[827.524557] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.163s)
[828.378788] [130/132] (194s left) gem_ctx_isolation (dirty-create)
[828.461894] Starting subtest: dirty-create
[828.464203] Starting dynamic subtest: rcs0
[828.651523] Dynamic subtest rcs0: SUCCESS (0.192s)
[828.665140] Starting dynamic subtest: bcs0
[828.854902] Dynamic subtest bcs0: SUCCESS (0.202s)
[828.865298] Starting dynamic subtest: vcs0
[829.058262] Dynamic subtest vcs0: SUCCESS (0.202s)
[829.070112] Starting dynamic subtest: vcs1
[830.377188] Dynamic subtest vcs1: SUCCESS (1.317s)
[830.388664] Starting dynamic subtest: vecs0
[832.400798] Dynamic subtest vecs0: SUCCESS (2.022s)
[832.411942] Starting dynamic subtest: ccs0
[834.391190] Dynamic subtest ccs0: SUCCESS (1.989s)
[834.393633] Subtest dirty-create: SUCCESS (5.931s)
[834.614790] [131/132] (188s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[834.697188] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[841.814505] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.118s)
[841.954151] [132/132] (181s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[842.032545] Starting subtest: fbcpsr-slowdraw
[867.106079] Subtest fbcpsr-slowdraw: SUCCESS (25.068s)
[867.251354] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: i915_hangman
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_atomic_interruptible
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_close_race
results: parsing output: 23/ for test: api_intel_bb
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_atomic
results: parsing output: 30/ for test: gem_exercise_blt
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_flush
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: gem_create
results: parsing output: 39/ for test: kms_pm_backlight
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sriov_basic
results: parsing output: 44/ for test: kms_pipe_crc_basic
results: parsing output: 45/ for test: kms_atomic_transition
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_force_connector_basic
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: gem_ccs
results: parsing output: 51/ for test: kms_fbcon_fbt
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_prop_blob
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_tiled_pread_basic
results: parsing output: 59/ for test: prime_mmap
results: parsing output: 60/ for test: kms_chamelium_frames
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rpm
results: parsing output: 66/ for test: gem_workarounds
results: parsing output: 67/ for test: gem_exec_create
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: i915_power
results: parsing output: 73/ for test: gem_lmem_swapping
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_ringfill
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: i915_drm_fdinfo
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_explicit_fence
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: kms_hdr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane_multiple
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_properties
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: prime_vgem
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: dumb_buffer
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_fence_pin_leak
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gem_ctx_isolation
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.