[59.559403] Initializing watchdogs
[59.559447]   /dev/watchdog0
[59.574554] [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.579055] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.581323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.583504] [001/131] (960s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[59.692168] Starting subtest: stress-xrgb8888-xtiled
[65.506535] Subtest stress-xrgb8888-xtiled: SUCCESS (5.845s)
[65.547840] [002/131] (954s left) syncobj_timeline (multi-wait-all-available-submitted)
[65.603604] Starting subtest: multi-wait-all-available-submitted
[65.604438] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[65.698940] [003/131] (954s left) gem_lmem_swapping (smem-oom)
[65.734474] Subtest smem-oom: SKIP (0.000s)
[65.772175] [004/131] (954s left) kms_flip (flip-vs-wf_vblank-interruptible)
[65.871988] Starting subtest: flip-vs-wf_vblank-interruptible
[65.873836] Starting dynamic subtest: A-eDP1
[67.774454] Dynamic subtest A-eDP1: SUCCESS (1.905s)
[67.781077] Starting dynamic subtest: B-eDP1
[69.691640] Dynamic subtest B-eDP1: SUCCESS (1.921s)
[69.699815] Starting dynamic subtest: C-eDP1
[71.606621] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[71.613145] Starting dynamic subtest: D-eDP1
[73.532256] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[73.536324] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.680s)
[74.768347] [005/131] (945s left) gem_sync (basic-each)
[74.825275] Starting subtest: basic-each
[77.131902] Subtest basic-each: SUCCESS (2.310s)
[77.314569] [006/131] (942s left) gem_softpin (allocator-evict)
[77.369610] Starting subtest: allocator-evict
[77.370560] Starting dynamic subtest: rcs0
[101.801589] Dynamic subtest rcs0: SUCCESS (24.426s)
[101.809577] Starting dynamic subtest: bcs0
[126.018725] Dynamic subtest bcs0: SUCCESS (24.214s)
[126.027822] Starting dynamic subtest: vcs0
[149.602721] Dynamic subtest vcs0: SUCCESS (23.582s)
[149.612504] Starting dynamic subtest: vcs1
[173.249021] Dynamic subtest vcs1: SUCCESS (23.646s)
[173.255735] Starting dynamic subtest: vecs0
[197.201861] Dynamic subtest vecs0: SUCCESS (23.951s)
[197.210434] Starting dynamic subtest: ccs0
[220.737340] Dynamic subtest ccs0: SUCCESS (23.534s)
[220.738223] Subtest allocator-evict: SUCCESS (143.357s)
[220.829723] [007/131] (799s left) gem_ctx_persistence (legacy-engines-mixed)
[220.925454] Starting subtest: legacy-engines-mixed
[220.926469] Starting dynamic subtest: render
[221.000328] Dynamic subtest render: SUCCESS (0.074s)
[221.009820] Starting dynamic subtest: bsd1
[221.056780] Dynamic subtest bsd1: SUCCESS (0.055s)
[221.065960] Starting dynamic subtest: bsd2
[221.105179] Dynamic subtest bsd2: SUCCESS (0.048s)
[221.114639] Starting dynamic subtest: blt
[221.162685] Dynamic subtest blt: SUCCESS (0.055s)
[221.171986] Starting dynamic subtest: vebox
[221.209047] Dynamic subtest vebox: SUCCESS (0.045s)
[221.209815] Subtest legacy-engines-mixed: SUCCESS (0.284s)
[221.282733] [008/131] (799s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[221.394640] Starting subtest: yf-tiled-32bpp-rotate-180
[221.396456] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[221.480148] [009/131] (798s left) kms_cursor_crc (cursor-alpha-opaque)
[221.564382] Starting subtest: cursor-alpha-opaque
[221.565341] Starting dynamic subtest: pipe-A-eDP-1
[222.200107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[222.207136] Starting dynamic subtest: pipe-D-eDP-1
[223.439191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[223.440062] Subtest cursor-alpha-opaque: SUCCESS (1.874s)
[224.310867] [010/131] (796s left) syncobj_timeline (wait-all-for-submit-complex)
[224.362543] Starting subtest: wait-all-for-submit-complex
[224.584974] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[224.644405] [011/131] (795s left) sysfs_timeslice_duration (idempotent)
[224.694228] Starting subtest: idempotent
[224.695179] Starting dynamic subtest: vecs0
[224.696097] Dynamic subtest vecs0: SUCCESS (0.000s)
[224.704688] Starting dynamic subtest: ccs0
[224.705586] Dynamic subtest ccs0: SUCCESS (0.000s)
[224.712449] Starting dynamic subtest: vcs0
[224.713366] Dynamic subtest vcs0: SUCCESS (0.000s)
[224.719722] Starting dynamic subtest: bcs0
[224.720619] Dynamic subtest bcs0: SUCCESS (0.000s)
[224.726911] Starting dynamic subtest: rcs0
[224.727773] Dynamic subtest rcs0: SUCCESS (0.000s)
[224.734105] Starting dynamic subtest: vcs1
[224.734919] Dynamic subtest vcs1: SUCCESS (0.000s)
[224.735751] Subtest idempotent: SUCCESS (0.004s)
[224.762509] [012/131] (795s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[224.851320] Starting subtest: fbc-pr-cursor-mmap-cpu
[224.852968] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[224.918411] [013/131] (795s left) gem_mmap_gtt (flink-race)
[224.972172] Subtest flink-race: SKIP (0.000s)
[225.029532] [014/131] (795s left) gem_exec_schedule (deep)
[225.202409] Starting subtest: deep
[225.203450] Starting dynamic subtest: rcs0
[230.685377] Dynamic subtest rcs0: SKIP (5.473s)
[230.692537] Starting dynamic subtest: vcs0
[240.843540] Dynamic subtest vcs0: SUCCESS (10.158s)
[240.853510] Starting dynamic subtest: vcs1
[252.204170] Dynamic subtest vcs1: SUCCESS (11.353s)
[252.212606] Starting dynamic subtest: vecs0
[264.423869] Dynamic subtest vecs0: SUCCESS (12.223s)
[264.438416] Starting dynamic subtest: ccs0
[276.843696] Dynamic subtest ccs0: SUCCESS (12.418s)
[276.844918] Subtest deep: SUCCESS (51.631s)
[278.124501] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[278.126443] [015/131] (742s left) gem_watchdog (default-virtual)
[278.193214] Starting subtest: default-virtual
[284.486037] Subtest default-virtual: SUCCESS (6.284s)
[284.564097] [016/131] (736s left) i915_suspend (forcewake)
[284.612764] Starting subtest: forcewake
[317.727677] Subtest forcewake: SUCCESS (3.861s)
[323.807606] [017/131] (702s left) kms_lease (possible-crtcs-filtering)
[323.887010] Starting subtest: possible-crtcs-filtering
[323.891877] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[323.989889] [018/131] (702s left) kms_vblank (invalid)
[324.068587] Starting subtest: invalid
[324.069455] Starting dynamic subtest: pipe-A-eDP-1
[324.464152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[324.465059] Subtest invalid: SUCCESS (0.410s)
[325.256262] [019/131] (701s left) api_intel_bb (object-reloc-keep-cache)
[325.310152] Starting subtest: object-reloc-keep-cache
[325.313246] Subtest object-reloc-keep-cache: SKIP (0.002s)
[325.417339] [020/131] (701s left) gem_render_copy (y-tiled-to-vebox-linear)
[325.475888] Starting subtest: y-tiled-to-vebox-linear
[325.477395] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[325.651256] [021/131] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[325.740498] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[325.742120] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[325.832766] [022/131] (700s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[325.917043] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[325.918645] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.009624] [023/131] (700s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[326.100573] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[326.111988] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[326.182169] [024/131] (700s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[326.261930] Starting subtest: 2x-flip-vs-rmfb-interruptible
[326.273397] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[326.345657] [025/131] (700s left) gem_lmem_swapping (massive)
[326.382358] Subtest massive: SKIP (0.000s)
[326.413304] [026/131] (700s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[326.510962] Starting subtest: 4-tiled-32bpp-rotate-180
[327.921277] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.446s)
[328.058366] [027/131] (698s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[328.140537] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[328.154869] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[328.226942] [028/131] (698s left) kms_pm_rpm (cursor)
[330.265298] Starting subtest: cursor
[330.267850] Subtest cursor: SKIP (0.000s)
[330.627584] [029/131] (696s left) gem_ctx_isolation (dirty-create)
[330.680965] Starting subtest: dirty-create
[330.682044] Starting dynamic subtest: rcs0
[330.873375] Dynamic subtest rcs0: SUCCESS (0.195s)
[330.881293] Starting dynamic subtest: bcs0
[331.066376] Dynamic subtest bcs0: SUCCESS (0.195s)
[331.081688] Starting dynamic subtest: vcs0
[331.278889] Dynamic subtest vcs0: SUCCESS (0.215s)
[331.289481] Starting dynamic subtest: vcs1
[333.353754] Dynamic subtest vcs1: SUCCESS (2.101s)
[333.363343] Starting dynamic subtest: vecs0
[335.312960] Dynamic subtest vecs0: SUCCESS (1.978s)
[335.323541] Starting dynamic subtest: ccs0
[337.383989] Dynamic subtest ccs0: SUCCESS (2.086s)
[337.385053] Subtest dirty-create: SUCCESS (6.774s)
[337.628315] [030/131] (689s left) syncobj_timeline (device-signal-unordered)
[337.685435] Starting subtest: device-signal-unordered
[337.686591] Subtest device-signal-unordered: SUCCESS (0.001s)
[337.778677] [031/131] (689s left) kms_frontbuffer_tracking (fbc-tiling-4)
[337.868688] Starting subtest: fbc-tiling-4
[342.082488] Subtest fbc-tiling-4: SUCCESS (4.235s)
[343.235522] [032/131] (683s left) fbdev (write)
[343.281652] Starting subtest: write
[343.657440] Subtest write: SUCCESS (0.367s)
[343.705693] [033/131] (683s left) gem_exec_schedule (preempt-user)
[343.768990] Starting subtest: preempt-user
[343.770178] Starting dynamic subtest: rcs0
[343.793656] Dynamic subtest rcs0: SUCCESS (0.024s)
[343.804403] Starting dynamic subtest: bcs0
[343.812413] Dynamic subtest bcs0: SUCCESS (0.019s)
[343.820653] Starting dynamic subtest: vcs0
[343.833303] Dynamic subtest vcs0: SUCCESS (0.020s)
[343.842442] Starting dynamic subtest: vcs1
[343.855133] Dynamic subtest vcs1: SUCCESS (0.022s)
[343.863561] Starting dynamic subtest: vecs0
[343.874016] Dynamic subtest vecs0: SUCCESS (0.019s)
[343.881990] Starting dynamic subtest: ccs0
[343.895297] Dynamic subtest ccs0: SUCCESS (0.021s)
[343.896274] Subtest preempt-user: SUCCESS (0.127s)
[345.237872] [034/131] (681s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[345.636230] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[346.417209] [035/131] (680s left) kms_flip (absolute-wf_vblank)
[346.508628] Starting subtest: absolute-wf_vblank
[346.511022] Starting dynamic subtest: A-eDP1
[355.218852] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[355.227093] Starting dynamic subtest: B-eDP1
[363.958338] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[363.969381] Starting dynamic subtest: C-eDP1
[372.691714] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[372.702305] Starting dynamic subtest: D-eDP1
[381.421063] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[381.422254] Subtest absolute-wf_vblank: SUCCESS (34.894s)
[382.602351] [036/131] (644s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[382.727515] Starting subtest: verify-pxp-execution-after-suspend-resume
[389.757517] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.034s)
[398.985485] [037/131] (637s left) gem_exec_reloc (basic-gtt-wc)
[399.067304] Subtest basic-gtt-wc: SKIP (0.000s)
[399.139626] [038/131] (637s left) syncobj_wait (invalid-signal-one-illegal-handle)
[399.194532] Starting subtest: invalid-signal-one-illegal-handle
[399.195710] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[399.290622] [039/131] (637s left) api_intel_allocator (default-alignment)
[399.336282] Starting subtest: default-alignment
[399.337991] Subtest default-alignment: SUCCESS (0.003s)
[399.458111] [040/131] (637s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[399.548617] Starting subtest: fbc-psr2-sprite-mmap-gtt
[399.549553] Starting dynamic subtest: eDP-1
[399.551404] Dynamic subtest eDP-1: SKIP (0.000s)
[399.553023] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[399.621257] [041/131] (636s left) syncobj_wait (single-wait-for-submit-submitted)
[399.674017] Starting subtest: single-wait-for-submit-submitted
[399.782132] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[399.866251] [042/131] (636s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[399.960072] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[399.961826] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[400.051477] [043/131] (636s left) kms_chamelium_frames (dp-frame-dump)
[400.438374] Subtest dp-frame-dump: SKIP (0.000s)
[401.205733] [044/131] (635s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[401.296908] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[401.297725] Starting dynamic subtest: pipe-A-eDP-1
[401.306040] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.314054] Starting dynamic subtest: pipe-B-eDP-1
[401.321531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.329149] Starting dynamic subtest: pipe-C-eDP-1
[401.336773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.344407] Starting dynamic subtest: pipe-D-eDP-1
[401.352258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.353890] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[403.598564] [045/131] (633s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[403.696868] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[403.697639] Starting dynamic subtest: pipe-A-default-mode
[406.429407] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[406.430477] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.733s)
[407.289643] [046/131] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[407.388426] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[407.390280] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[407.486428] [047/131] (629s left) gem_exec_balancer (indices)
[407.543089] Starting subtest: indices
[410.103730] Subtest indices: SUCCESS (2.551s)
[410.410579] [048/131] (626s left) gem_pread (uncached)
[410.451609] Subtest uncached: SKIP (0.000s)
[410.504186] [049/131] (626s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[410.600757] Starting subtest: bad-pixel-format-yf-tiled-ccs
[410.601673] Starting dynamic subtest: pipe-A-eDP-1
[410.610084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.618366] Starting dynamic subtest: pipe-B-eDP-1
[410.626425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.634140] Starting dynamic subtest: pipe-C-eDP-1
[410.642028] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.649859] Starting dynamic subtest: pipe-D-eDP-1
[410.658060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.659671] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[412.847585] [050/131] (623s left) gem_ppgtt (blt-vs-render-ctxn)
[412.893951] Starting subtest: blt-vs-render-ctxN
[445.678259] Subtest blt-vs-render-ctxN: SUCCESS (32.778s)
[445.803327] [051/131] (591s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[445.928653] Starting subtest: random-ccs-data-y-tiled-ccs
[445.929550] Starting dynamic subtest: pipe-A-eDP-1
[445.938875] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[445.947493] Starting dynamic subtest: pipe-B-eDP-1
[445.956837] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[445.965668] Starting dynamic subtest: pipe-C-eDP-1
[445.974795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[445.982725] Starting dynamic subtest: pipe-D-eDP-1
[445.992795] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[445.994586] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[448.101083] [052/131] (588s left) kms_invalid_mode (clock-too-high)
[448.199265] Starting subtest: clock-too-high
[448.200138] Starting dynamic subtest: pipe-A-eDP-1
[448.201871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.211577] Starting dynamic subtest: pipe-B-eDP-1
[448.213947] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.222006] Starting dynamic subtest: pipe-C-eDP-1
[448.223690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.231595] Starting dynamic subtest: pipe-D-eDP-1
[448.233493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.235225] Subtest clock-too-high: SKIP (0.004s)
[448.271049] [053/131] (588s left) gem_exec_whisper (basic-contexts-forked-all)
[448.330762] Starting subtest: basic-contexts-forked-all
[467.341896] Subtest basic-contexts-forked-all: SUCCESS (19.005s)
[467.516995] [054/131] (569s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[467.621915] Starting subtest: pr-primary-plane-update-sf-dmg-area
[467.623781] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[467.703447] [055/131] (569s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[467.784943] Starting subtest: addfb25-y-tiled-small-legacy
[467.786562] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[467.875748] [056/131] (569s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[467.925954] Starting subtest: multi-wait-for-submit-submitted-signaled
[467.927016] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[468.017463] [057/131] (569s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[468.097859] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[468.100033] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[468.167872] [058/131] (568s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[468.285244] Starting subtest: basic-flip-before-cursor-atomic
[469.234722] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.949s)
[470.028414] [059/131] (567s left) kms_async_flips (test-time-stamp)
[470.111930] Starting subtest: test-time-stamp
[470.498060] Starting dynamic subtest: pipe-A-eDP-1
[471.333694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.834s)
[471.712610] Starting dynamic subtest: pipe-B-eDP-1
[472.462069] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[472.850165] Starting dynamic subtest: pipe-C-eDP-1
[473.604692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[473.971306] Starting dynamic subtest: pipe-D-eDP-1
[474.733921] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[474.735027] Subtest test-time-stamp: SUCCESS (4.623s)
[475.897461] [060/131] (561s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[476.008084] Starting subtest: cursorA-vs-flipA-atomic-transitions
[487.179955] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.172s)
[488.023619] [061/131] (549s left) kms_psr (psr2-sprite-mmap-gtt)
[488.128910] Starting subtest: psr2-sprite-mmap-gtt
[488.129718] Starting dynamic subtest: eDP-1
[489.533394] Dynamic subtest eDP-1: SKIP (1.394s)
[489.535804] Subtest psr2-sprite-mmap-gtt: SKIP (1.397s)
[489.689660] [062/131] (547s left) core_getversion (all-cards)
[489.726750] Starting subtest: all-cards
[489.735869] Subtest all-cards: SUCCESS (0.012s)
[489.775274] [063/131] (547s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[489.859368] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[496.585427] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.728s)
[496.685970] [064/131] (540s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[496.769306] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[496.771081] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[496.862997] [065/131] (540s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[496.949031] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[496.949912] Starting dynamic subtest: pipe-A-eDP-1
[496.971971] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[496.981633] Starting dynamic subtest: pipe-B-eDP-1
[497.003135] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[497.012069] Starting dynamic subtest: pipe-C-eDP-1
[497.031286] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[497.040066] Starting dynamic subtest: pipe-D-eDP-1
[497.059766] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[497.061282] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[499.160718] [066/131] (538s left) kms_getfb (getfb-repeated-different-handles)
[499.246165] Starting subtest: getfb-repeated-different-handles
[499.247108] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[499.339428] [067/131] (538s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[499.433611] Starting subtest: x-tiled-8bpp-rotate-270
[499.458933] Subtest x-tiled-8bpp-rotate-270: SKIP (0.025s)
[499.571774] [068/131] (537s left) kms_draw_crc (draw-method-mmap-cpu)
[499.668929] Starting subtest: draw-method-mmap-cpu
[499.669808] Starting dynamic subtest: xrgb8888-untiled
[499.915095] Dynamic subtest xrgb8888-untiled: SUCCESS (0.246s)
[499.923941] Starting dynamic subtest: rgb565-untiled
[500.137219] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[500.147456] Starting dynamic subtest: xrgb2101010-untiled
[500.359592] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[500.369006] Starting dynamic subtest: xbgr16161616f-untiled
[500.581688] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[500.592119] Starting dynamic subtest: xrgb8888-xtiled
[500.726062] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[500.734775] Starting dynamic subtest: rgb565-xtiled
[500.860119] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[500.870624] Starting dynamic subtest: xrgb2101010-xtiled
[500.992799] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.130s)
[501.002816] Starting dynamic subtest: xbgr16161616f-xtiled
[501.126041] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[501.135105] Starting dynamic subtest: xrgb8888-4tiled
[501.270470] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[501.280496] Starting dynamic subtest: rgb565-4tiled
[501.414792] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[501.428535] Starting dynamic subtest: xrgb2101010-4tiled
[501.548181] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[501.558767] Starting dynamic subtest: xbgr16161616f-4tiled
[501.681778] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[501.682581] Subtest draw-method-mmap-cpu: SUCCESS (2.014s)
[501.771789] [069/131] (535s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[501.864091] Starting subtest: primary-yf-tiled-reflect-x-180
[501.923286] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[502.022231] [070/131] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[502.118206] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[502.120077] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[502.214735] [071/131] (535s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[502.310216] Starting subtest: psr-farfromfence-mmap-gtt
[502.311956] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[502.405094] [072/131] (535s left) core_auth (basic-auth)
[502.455262] Starting subtest: basic-auth
[502.456379] Subtest basic-auth: SUCCESS (0.001s)
[502.568438] [073/131] (535s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[502.673823] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[502.675592] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[502.773459] [074/131] (534s left) i915_drm_fdinfo (memory-info-shared)
[502.815479] Starting subtest: memory-info-shared
[502.816460] Starting dynamic subtest: smem0
[502.883511] Dynamic subtest smem0: SUCCESS (0.067s)
[502.884962] Subtest memory-info-shared: SUCCESS (0.068s)
[502.968693] [075/131] (534s left) gem_exec_reloc (basic-write-cpu)
[503.026537] Subtest basic-write-cpu: SKIP (0.000s)
[503.105106] [076/131] (534s left) gem_create (create-ext-cpu-access-big)
[503.275517] Starting subtest: create-ext-cpu-access-big
[503.277722] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[503.341627] [077/131] (534s left) kms_scaling_modes (scaling-mode-center)
[503.428122] Starting subtest: scaling-mode-center
[503.429030] Starting dynamic subtest: pipe-A-eDP-1
[503.525785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[503.539469] Starting dynamic subtest: pipe-B-eDP-1
[504.693586] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s)
[504.704385] Starting dynamic subtest: pipe-C-eDP-1
[505.812974] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[505.824189] Starting dynamic subtest: pipe-D-eDP-1
[506.944259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[506.945246] Subtest scaling-mode-center: SUCCESS (3.518s)
[508.107347] [078/131] (529s left) kms_psr (pr-cursor-plane-onoff)
[508.197206] Starting subtest: pr-cursor-plane-onoff
[508.198781] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[508.270396] [079/131] (529s left) gem_exec_reloc (basic-write-read-noreloc)
[508.324166] Subtest basic-write-read-noreloc: SKIP (0.000s)
[508.389997] [080/131] (529s left) kms_big_fb (linear-16bpp-rotate-90)
[508.484565] Starting subtest: linear-16bpp-rotate-90
[508.504298] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[508.615569] [081/131] (529s left) kms_flip (plain-flip-interruptible)
[508.710871] Starting subtest: plain-flip-interruptible
[508.713392] Starting dynamic subtest: A-eDP1
[510.413114] Dynamic subtest A-eDP1: SUCCESS (1.700s)
[510.425154] Starting dynamic subtest: B-eDP1
[512.046339] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[512.057966] Starting dynamic subtest: C-eDP1
[513.671729] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[513.684266] Starting dynamic subtest: D-eDP1
[515.311206] Dynamic subtest D-eDP1: SUCCESS (1.635s)
[515.313248] Subtest plain-flip-interruptible: SUCCESS (6.603s)
[516.464664] [082/131] (521s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[516.556689] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[516.558546] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[516.656643] [083/131] (521s left) gem_mmap_gtt (basic-copy)
[516.720046] Subtest basic-copy: SKIP (0.000s)
[516.772540] [084/131] (521s left) kms_cursor_crc (cursor-random-256x256)
[517.014351] Starting subtest: cursor-random-256x256
[517.019046] Starting dynamic subtest: pipe-A-eDP-1
[520.363375] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.345s)
[520.393877] Starting dynamic subtest: pipe-D-eDP-1
[524.349133] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.964s)
[524.350322] Subtest cursor-random-256x256: SUCCESS (7.337s)
[525.228636] [085/131] (512s left) gem_exec_balancer (parallel-keep-in-fence)
[525.508220] Starting subtest: parallel-keep-in-fence
[526.807973] Subtest parallel-keep-in-fence: SUCCESS (1.300s)
[526.905529] [086/131] (511s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[527.023504] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[527.025416] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[528.149123] [087/131] (510s left) syncobj_basic (illegal-fd-to-handle)
[528.199030] Starting subtest: illegal-fd-to-handle
[528.199924] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[528.294481] [088/131] (509s left) kms_plane_multiple (2x-tiling-y)
[528.375034] Starting subtest: 2x-tiling-y
[528.376661] Subtest 2x-tiling-y: SKIP (0.000s)
[528.446174] [089/131] (509s left) i915_hangman (engine-engine-error)
[528.500264] Starting subtest: engine-engine-error
[528.501167] Starting dynamic subtest: rcs0
[530.104580] Dynamic subtest rcs0: SUCCESS (1.595s)
[530.116230] Starting dynamic subtest: bcs0
[532.152350] Dynamic subtest bcs0: SUCCESS (2.046s)
[532.165268] Starting dynamic subtest: vcs0
[534.135751] Dynamic subtest vcs0: SUCCESS (1.981s)
[534.150692] Starting dynamic subtest: vcs1
[536.120723] Dynamic subtest vcs1: SUCCESS (1.982s)
[536.132681] Starting dynamic subtest: vecs0
[538.103589] Dynamic subtest vecs0: SUCCESS (1.981s)
[538.120106] Starting dynamic subtest: ccs0
[540.152399] Dynamic subtest ccs0: SUCCESS (2.046s)
[540.153731] Subtest engine-engine-error: SUCCESS (11.649s)
[540.268164] [090/131] (498s left) perf_pmu (frequency)
[540.304262] Starting subtest: frequency
[540.308654] Starting dynamic subtest: gt0
[542.435061] Dynamic subtest gt0: SUCCESS (2.124s)
[542.446178] Starting dynamic subtest: idle-gt0
[542.949986] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[542.961141] Starting dynamic subtest: gt1
[547.164631] Dynamic subtest gt1: SUCCESS (4.213s)
[547.175926] Starting dynamic subtest: idle-gt1
[547.672050] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[547.673104] Subtest frequency: SUCCESS (7.365s)
[547.782653] [091/131] (490s left) gem_mmap (short-mmap)
[547.837252] Subtest short-mmap: SKIP (0.000s)
[547.934751] [092/131] (490s left) i915_pm_rpm (system-suspend)
[549.460250] Starting subtest: system-suspend
[568.517051] Subtest system-suspend: SUCCESS (3.267s)
[574.942753] [093/131] (469s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[575.034078] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[575.035715] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[575.099784] [094/131] (469s left) kms_addfb_basic (addfb25-modifier-no-flag)
[575.188681] Starting subtest: addfb25-modifier-no-flag
[575.189742] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[575.278257] [095/131] (469s left) kms_content_protection (dp-mst-lic-type-1)
[575.413841] Starting subtest: dp-mst-lic-type-1
[575.416666] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[575.521225] [096/131] (469s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[575.567872] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[575.669242] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[575.743098] [097/131] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[575.833612] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[582.814649] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.133s)
[582.933402] [098/131] (461s left) prime_mmap (test_refcounting)
[582.994889] Starting subtest: test_refcounting
[582.996293] Starting dynamic subtest: test_refcounting-smem
[583.026055] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[583.027654] Subtest test_refcounting: SUCCESS (0.033s)
[583.114253] [099/131] (461s left) kms_cursor_edge_walk (128x128-top-edge)
[583.214918] Starting subtest: 128x128-top-edge
[583.216351] Starting dynamic subtest: pipe-A-eDP-1
[586.684278] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[586.693828] Starting dynamic subtest: pipe-D-eDP-1
[589.863542] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.199s)
[589.864704] Subtest 128x128-top-edge: SUCCESS (6.705s)
[590.658361] [100/131] (454s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[590.747963] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[590.749544] Starting dynamic subtest: pipe-A
[591.803547] Dynamic subtest pipe-A: SUCCESS (1.061s)
[591.812835] Starting dynamic subtest: pipe-B
[593.944563] Dynamic subtest pipe-B: SUCCESS (2.148s)
[593.954083] Starting dynamic subtest: pipe-C
[595.137164] Dynamic subtest pipe-C: SUCCESS (1.196s)
[595.146612] Starting dynamic subtest: pipe-D
[596.278842] Dynamic subtest pipe-D: SUCCESS (1.144s)
[596.280442] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.552s)
[597.493422] [101/131] (447s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[597.605265] Starting subtest: flip-vs-cursor-crc-atomic
[598.277554] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.674s)
[599.106422] [102/131] (445s left) gem_ppgtt (flink-and-close-vma-leak)
[599.165925] Starting subtest: flink-and-close-vma-leak
[599.208362] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[599.322210] [103/131] (445s left) prime_mmap (test_invalid_sync_flags)
[599.374475] Starting subtest: test_invalid_sync_flags
[599.375586] Starting dynamic subtest: test_invalid_sync_flags-smem
[599.376725] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[599.377819] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[599.458541] [104/131] (445s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[599.545539] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[599.547391] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[599.647670] [105/131] (445s left) kms_big_fb (y-tiled-addfb)
[599.757777] Starting subtest: y-tiled-addfb
[599.760306] Subtest y-tiled-addfb: SKIP (0.000s)
[599.852955] [106/131] (445s left) kms_cursor_legacy (torture-bo)
[599.975335] Starting subtest: torture-bo
[599.976352] Starting dynamic subtest: pipe-A
[605.650652] Dynamic subtest pipe-A: SUCCESS (5.674s)
[605.667139] Starting dynamic subtest: pipe-B
[611.532327] Dynamic subtest pipe-B: SUCCESS (5.885s)
[611.542204] Starting dynamic subtest: pipe-C
[617.811906] Dynamic subtest pipe-C: SUCCESS (6.276s)
[617.828144] Starting dynamic subtest: pipe-D
[624.015359] Dynamic subtest pipe-D: SUCCESS (6.202s)
[624.032235] Starting dynamic subtest: all-pipes
[631.218181] Dynamic subtest all-pipes: SUCCESS (7.193s)
[631.219266] Subtest torture-bo: SUCCESS (31.240s)
[631.363916] [107/131] (413s left) kms_rotation_crc (primary-rotation-270)
[631.464213] Starting subtest: primary-rotation-270
[631.466474] Subtest primary-rotation-270: SKIP (0.001s)
[631.536361] [108/131] (413s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[631.594525] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[631.647073] [109/131] (413s left) gem_softpin (noreloc)
[631.699228] Starting subtest: noreloc
[637.182367] Subtest noreloc: SUCCESS (5.438s)
[637.240172] [110/131] (407s left) perf_pmu (multi-client)
[637.279346] Starting subtest: multi-client
[637.280273] Starting dynamic subtest: rcs0
[638.324915] Dynamic subtest rcs0: SUCCESS (1.034s)
[638.338745] Starting dynamic subtest: bcs0
[639.377713] Dynamic subtest bcs0: SUCCESS (1.051s)
[639.390196] Starting dynamic subtest: vcs0
[640.432814] Dynamic subtest vcs0: SUCCESS (1.053s)
[640.446211] Starting dynamic subtest: vcs1
[641.986680] Dynamic subtest vcs1: SUCCESS (1.551s)
[641.996707] Starting dynamic subtest: vecs0
[643.970220] Dynamic subtest vecs0: SUCCESS (1.981s)
[643.980157] Starting dynamic subtest: ccs0
[645.954894] Dynamic subtest ccs0: SUCCESS (1.982s)
[645.956388] Subtest multi-client: SUCCESS (8.671s)
[646.067153] [111/131] (399s left) gem_shrink (reclaim)
[646.127495] Starting subtest: reclaim
[648.644584] Subtest reclaim: SUCCESS (2.461s)
[648.714181] [112/131] (396s left) gem_mmap (pf-nonblock)
[648.777523] Subtest pf-nonblock: SKIP (0.000s)
[648.831511] [113/131] (396s left) kms_vrr (flip-dpms)
[648.929476] Starting subtest: flip-dpms
[648.932285] Subtest flip-dpms: SKIP (0.000s)
[649.007443] [114/131] (396s left) kms_frontbuffer_tracking (fbc-1p-rte)
[649.116600] Starting subtest: fbc-1p-rte
[654.595408] Subtest fbc-1p-rte: SUCCESS (5.481s)
[655.810397] [115/131] (389s left) gem_exec_schedule (preempt-hang)
[655.988887] Starting subtest: preempt-hang
[655.990249] Starting dynamic subtest: rcs0
[656.201380] Dynamic subtest rcs0: SUCCESS (0.222s)
[656.210411] Starting dynamic subtest: bcs0
[656.420821] Dynamic subtest bcs0: SUCCESS (0.219s)
[656.430420] Starting dynamic subtest: vcs0
[656.633606] Dynamic subtest vcs0: SUCCESS (0.212s)
[656.648919] Starting dynamic subtest: vcs1
[656.850145] Dynamic subtest vcs1: SUCCESS (0.214s)
[656.860307] Starting dynamic subtest: vecs0
[657.069856] Dynamic subtest vecs0: SUCCESS (0.218s)
[657.081672] Starting dynamic subtest: ccs0
[657.295385] Dynamic subtest ccs0: SUCCESS (0.224s)
[657.296605] Subtest preempt-hang: SUCCESS (1.316s)
[657.999111] [116/131] (387s left) gen7_exec_parse (oacontrol-tracking)
[658.047572] Subtest oacontrol-tracking: SKIP (0.000s)
[658.102764] [117/131] (387s left) kms_flip (flip-vs-blocking-wf-vblank)
[658.192764] Starting subtest: flip-vs-blocking-wf-vblank
[658.193987] Starting dynamic subtest: A-eDP1
[667.163674] Dynamic subtest A-eDP1: SUCCESS (8.973s)
[667.173227] Starting dynamic subtest: B-eDP1
[676.101929] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[676.112244] Starting dynamic subtest: C-eDP1
[685.053718] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[685.064898] Starting dynamic subtest: D-eDP1
[693.951521] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[693.954791] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.758s)
[695.171341] [118/131] (350s left) gem_exec_fence (invalid-fence-array)
[695.642699] Starting subtest: invalid-fence-array
[695.646525] Subtest invalid-fence-array: SUCCESS (0.003s)
[697.047744] [119/131] (348s left) syncobj_wait (multi-wait-for-submit-signaled)
[697.097247] Starting subtest: multi-wait-for-submit-signaled
[697.098508] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[697.194891] [120/131] (348s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[697.284488] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[697.286474] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[697.364802] [121/131] (348s left) prime_busy (after)
[697.418909] Starting subtest: after
[697.422362] Starting dynamic subtest: rcs0
[697.452624] Dynamic subtest rcs0: SUCCESS (0.030s)
[697.463329] Starting dynamic subtest: bcs0
[697.494468] Dynamic subtest bcs0: SUCCESS (0.041s)
[697.505679] Starting dynamic subtest: vcs0
[697.535940] Dynamic subtest vcs0: SUCCESS (0.041s)
[697.546696] Starting dynamic subtest: vcs1
[697.577403] Dynamic subtest vcs1: SUCCESS (0.041s)
[697.587170] Starting dynamic subtest: vecs0
[697.619328] Dynamic subtest vecs0: SUCCESS (0.041s)
[697.629184] Starting dynamic subtest: ccs0
[697.660444] Dynamic subtest ccs0: SUCCESS (0.040s)
[697.769727] Subtest after: SUCCESS (0.349s)
[697.842556] [122/131] (347s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[697.939137] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[697.940924] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[698.035047] [123/131] (347s left) kms_vrr (max-min)
[698.125495] Starting subtest: max-min
[698.128473] Subtest max-min: SKIP (0.000s)
[698.209576] [124/131] (347s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[698.301178] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[698.302290] Starting dynamic subtest: pipe-A
[698.416634] Dynamic subtest pipe-A: SKIP (0.107s)
[698.426666] Starting dynamic subtest: pipe-B
[699.567543] Dynamic subtest pipe-B: SKIP (1.157s)
[699.576857] Starting dynamic subtest: pipe-C
[700.777332] Dynamic subtest pipe-C: SUCCESS (1.211s)
[700.795553] Starting dynamic subtest: pipe-D
[702.005309] Dynamic subtest pipe-D: SUCCESS (1.225s)
[702.006631] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.706s)
[703.199147] [125/131] (342s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[703.285597] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[710.762855] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.479s)
[710.886380] [126/131] (334s left) kms_psr (fbc-pr-primary-render)
[710.971245] Starting subtest: fbc-pr-primary-render
[710.973383] Subtest fbc-pr-primary-render: SKIP (0.000s)
[711.041433] [127/131] (334s left) gem_ctx_param (basic-default)
[711.097738] Starting subtest: basic-default
[711.099513] Subtest basic-default: SUCCESS (0.000s)
[711.180413] [128/131] (334s left) sw_sync (sync_busy_fork)
[711.213173] Starting subtest: sync_busy_fork
[712.233694] Subtest sync_busy_fork: SUCCESS (1.012s)
[712.287689] [129/131] (333s left) gem_mmap_gtt (basic-write-read-distinct)
[712.351201] Subtest basic-write-read-distinct: SKIP (0.000s)
[712.410123] [130/131] (333s left) gem_exec_params (rsvd2-dirt)
[712.457619] Starting subtest: rsvd2-dirt
[712.459909] Subtest rsvd2-dirt: SKIP (0.000s)
[712.547185] [131/131] (333s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[712.642972] Starting subtest: plane-ctm3x4-lut1d
[712.801775] Starting dynamic subtest: pipe-A-plane-0
[712.978800] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[712.988329] Starting dynamic subtest: pipe-A-plane-1
[713.123682] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[713.136638] Starting dynamic subtest: pipe-A-plane-2
[713.268283] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[714.453746] Starting dynamic subtest: pipe-B-plane-0
[714.611544] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[714.621268] Starting dynamic subtest: pipe-B-plane-1
[714.778555] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[714.788164] Starting dynamic subtest: pipe-B-plane-2
[714.944549] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[716.160662] Starting dynamic subtest: pipe-C-plane-0
[716.307543] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[716.316917] Starting dynamic subtest: pipe-C-plane-1
[716.452233] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[716.461554] Starting dynamic subtest: pipe-C-plane-2
[716.596419] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[717.801060] Starting dynamic subtest: pipe-D-plane-0
[717.948138] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[717.957126] Starting dynamic subtest: pipe-D-plane-1
[718.103584] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[718.113030] Starting dynamic subtest: pipe-D-plane-2
[718.248170] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[718.547104] Subtest plane-ctm3x4-lut1d: SUCCESS (5.905s)
[719.364986] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_stress
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_sync
results: parsing output: 5/ for test: gem_softpin
results: parsing output: 6/ for test: gem_ctx_persistence
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: sysfs_timeslice_duration
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: gem_watchdog
results: parsing output: 15/ for test: i915_suspend
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_pm_rpm
results: parsing output: 28/ for test: gem_ctx_isolation
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_chamelium_frames
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gem_pread
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_ppgtt
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: core_getversion
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: core_auth
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: i915_drm_fdinfo
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_scaling_modes
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: syncobj_basic
results: parsing output: 87/ for test: kms_plane_multiple
results: parsing output: 88/ for test: i915_hangman
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: gem_mmap
results: parsing output: 91/ for test: i915_pm_rpm
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: prime_mmap
results: parsing output: 98/ for test: kms_cursor_edge_walk
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_ppgtt
results: parsing output: 102/ for test: prime_mmap
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: gem_shrink
results: parsing output: 111/ for test: gem_mmap
results: parsing output: 112/ for test: kms_vrr
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: gen7_exec_parse
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: prime_busy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_vrr
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: sw_sync
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_color_pipeline
Done.