[60.440357] Initializing watchdogs
[60.440406]   /dev/watchdog0
[60.456219] [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]
[60.461045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.463946] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.466210] [001/133] (960s left) gem_exec_flush (basic-batch-kernel-default-uc)
[60.525782] Starting subtest: basic-batch-kernel-default-uc
[66.981605] Subtest basic-batch-kernel-default-uc: SUCCESS (6.456s)
[67.213117] [002/133] (953s left) kms_cursor_edge_walk (64x64-top-edge)
[67.442162] Starting subtest: 64x64-top-edge
[67.443249] Starting dynamic subtest: pipe-A-eDP-1
[70.880515] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[70.889193] Starting dynamic subtest: pipe-D-eDP-1
[74.008603] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[74.009599] Subtest 64x64-top-edge: SUCCESS (6.567s)
[74.796648] [003/133] (946s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[74.891608] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[81.929724] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (7.037s)
[82.056466] [004/133] (939s left) gem_wait (invalid-flags)
[82.115960] Starting subtest: invalid-flags
[82.116951] Subtest invalid-flags: SUCCESS (0.000s)
[82.332491] [005/133] (938s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[82.436379] Starting subtest: y-tiled-8bpp-rotate-180
[82.438516] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[82.527460] [006/133] (938s left) kms_fence_pin_leak
[82.678242] [007/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[82.757608] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[82.759214] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[82.844357] [008/133] (938s left) syncobj_wait (multi-wait-all-signaled)
[82.902803] Starting subtest: multi-wait-all-signaled
[82.903766] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[83.006984] [009/133] (938s left) gem_busy (parallel)
[83.182290] Starting subtest: parallel
[83.183147] Starting dynamic subtest: rcs0
[84.892620] Dynamic subtest rcs0: SUCCESS (1.706s)
[84.899398] Starting dynamic subtest: bcs0
[86.942142] Dynamic subtest bcs0: SUCCESS (2.048s)
[86.949674] Starting dynamic subtest: vcs0
[88.924628] Dynamic subtest vcs0: SUCCESS (1.981s)
[88.934102] Starting dynamic subtest: vcs1
[90.910443] Dynamic subtest vcs1: SUCCESS (1.984s)
[90.918391] Starting dynamic subtest: vecs0
[92.893323] Dynamic subtest vecs0: SUCCESS (1.982s)
[92.902621] Starting dynamic subtest: ccs0
[94.941475] Dynamic subtest ccs0: SUCCESS (2.047s)
[94.942561] Subtest parallel: SUCCESS (11.754s)
[95.174448] [010/133] (926s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[95.278811] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[96.334589] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.057s)
[96.487612] [011/133] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[96.576807] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[96.578729] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[96.659930] [012/133] (924s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[96.754933] Starting subtest: fbc-indfb-scaledprimary
[99.711022] Subtest fbc-indfb-scaledprimary: SUCCESS (2.956s)
[100.825263] [013/133] (920s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[100.904089] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[100.906031] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[100.978243] [014/133] (920s left) kms_psr (fbc-psr-primary-mmap-cpu)
[101.072297] Starting subtest: fbc-psr-primary-mmap-cpu
[101.073367] Starting dynamic subtest: eDP-1
[101.075496] Dynamic subtest eDP-1: SKIP (0.000s)
[101.077396] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[101.140691] [015/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[101.234218] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[101.236038] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.341903] [016/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[101.442761] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[101.445263] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[101.533107] [017/133] (919s left) syncobj_basic (create-signaled)
[101.583842] Starting subtest: create-signaled
[101.584732] Subtest create-signaled: SUCCESS (0.000s)
[101.675040] [018/133] (919s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[101.761885] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[101.762770] Starting dynamic subtest: pipe-A-eDP-1
[101.771408] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.777801] Starting dynamic subtest: pipe-B-eDP-1
[101.786494] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.792741] Starting dynamic subtest: pipe-C-eDP-1
[101.800844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.806655] Starting dynamic subtest: pipe-D-eDP-1
[101.814987] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.816696] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[103.998145] [019/133] (917s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[104.086535] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[104.098885] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[104.186436] [020/133] (917s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[104.275407] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[104.660184] Starting dynamic subtest: pipe-A-eDP-1
[107.487676] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.818s)
[107.841441] Starting dynamic subtest: pipe-B-eDP-1
[110.612974] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[110.975458] Starting dynamic subtest: pipe-C-eDP-1
[113.751753] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[114.113012] Starting dynamic subtest: pipe-D-eDP-1
[116.886590] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[116.887537] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.603s)
[118.061400] [021/133] (903s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[118.156573] Starting subtest: psr-rgb565-draw-mmap-cpu
[125.025071] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.870s)
[125.119158] [022/133] (896s left) gem_exec_balancer (bonded-semaphore)
[125.196796] Starting subtest: bonded-semaphore
[125.198815] Subtest bonded-semaphore: SKIP (0.000s)
[125.527128] [023/133] (896s left) gem_exec_alignment (forked)
[125.595361] Starting subtest: forked
[165.573992] Subtest forked: SUCCESS (39.931s)
[166.075524] [024/133] (855s left) dmabuf_sync_file (import-basic)
[166.260083] Starting subtest: import-basic
[166.262232] Subtest import-basic: SUCCESS (0.003s)
[166.310940] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[166.312591] [025/133] (855s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[166.418255] Starting subtest: x-tiled-32bpp-rotate-0
[167.910661] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.493s)
[168.029766] [026/133] (853s left) kms_prop_blob (invalid-set-prop-any)
[168.086225] Starting subtest: invalid-set-prop-any
[168.087199] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[168.178452] [027/133] (853s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[168.274628] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[168.275518] Starting dynamic subtest: pipe-A
[168.615648] Dynamic subtest pipe-A: SUCCESS (0.342s)
[168.623166] Starting dynamic subtest: pipe-B
[170.064383] Dynamic subtest pipe-B: SUCCESS (1.448s)
[170.076863] Starting dynamic subtest: pipe-C
[171.501355] Dynamic subtest pipe-C: SUCCESS (1.436s)
[171.509069] Starting dynamic subtest: pipe-D
[172.928349] Dynamic subtest pipe-D: SUCCESS (1.426s)
[172.929337] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.655s)
[174.097913] [028/133] (847s left) kms_chamelium_color (ctm-green-to-red)
[174.200953] Subtest ctm-green-to-red: SKIP (0.000s)
[174.243752] [029/133] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[174.342667] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[174.344597] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[174.441987] [030/133] (847s left) gem_busy (close-race)
[174.493967] Starting subtest: close-race
[197.918567] Subtest close-race: SUCCESS (23.414s)
[198.261135] [031/133] (823s left) vgem_basic (sysfs)
[198.349859] Starting subtest: sysfs
[198.350747] Subtest sysfs: SUCCESS (0.000s)
[198.419418] [032/133] (823s left) kms_pm_backlight (fade-with-suspend)
[198.512217] Starting subtest: fade-with-suspend
[215.131118] Starting dynamic subtest: eDP-1
[217.609960] Dynamic subtest eDP-1: SUCCESS (2.484s)
[217.611020] Subtest fade-with-suspend: SUCCESS (4.227s)
[223.502698] [033/133] (803s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[223.605327] Starting subtest: fbc-psr2-primary-mmap-gtt
[223.606248] Starting dynamic subtest: eDP-1
[223.608188] Dynamic subtest eDP-1: SKIP (0.000s)
[223.610007] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[223.681083] [034/133] (803s left) kms_feature_discovery (display-1x)
[223.782182] Starting subtest: display-1x
[223.783090] Subtest display-1x: SUCCESS (0.000s)
[223.860379] [035/133] (803s left) gem_mmap_wc (copy)
[223.913382] Subtest copy: SKIP (0.000s)
[223.966549] [036/133] (803s left) kms_vrr (lobf)
[224.047566] Starting subtest: lobf
[224.049197] Subtest lobf: SKIP (0.000s)
[224.118575] [037/133] (803s left) gem_flink_race (flink_close)
[224.148740] Starting subtest: flink_close
[229.249299] Subtest flink_close: SUCCESS (5.097s)
[229.325608] [038/133] (797s left) kms_invalid_mode (int-max-clock)
[229.417596] Starting subtest: int-max-clock
[229.418574] Starting dynamic subtest: pipe-A-eDP-1
[229.701629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[229.709902] Starting dynamic subtest: pipe-B-eDP-1
[229.710845] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[229.718058] Starting dynamic subtest: pipe-C-eDP-1
[229.719160] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[229.726513] Starting dynamic subtest: pipe-D-eDP-1
[229.727419] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[229.728301] Subtest int-max-clock: SUCCESS (0.290s)
[230.582769] [039/133] (796s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[230.647393] Starting subtest: basic-batch-kernel-default-cmd
[230.649299] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[230.849827] [040/133] (796s left) gem_exec_schedule (out-order)
[230.932624] Starting subtest: out-order
[230.933542] Starting dynamic subtest: rcs0
[231.036882] Dynamic subtest rcs0: SUCCESS (0.104s)
[231.047014] Starting dynamic subtest: vcs0
[231.122329] Dynamic subtest vcs0: SUCCESS (0.085s)
[231.133842] Starting dynamic subtest: vcs1
[231.214660] Dynamic subtest vcs1: SUCCESS (0.092s)
[231.225671] Starting dynamic subtest: vecs0
[231.296192] Dynamic subtest vecs0: SUCCESS (0.079s)
[231.308122] Starting dynamic subtest: ccs0
[231.378758] Dynamic subtest ccs0: SUCCESS (0.082s)
[231.380137] Subtest out-order: SUCCESS (0.447s)
[232.899309] [041/133] (794s left) kms_atomic_transition (modeset-transition-nonblocking)
[233.000617] Starting subtest: modeset-transition-nonblocking
[233.001490] Starting dynamic subtest: 1x-outputs
[244.098811] Dynamic subtest 1x-outputs: SUCCESS (11.095s)
[244.099962] Subtest modeset-transition-nonblocking: SUCCESS (11.097s)
[244.965064] [042/133] (782s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[245.052420] Starting subtest: plane-downscale-factor-0-5-with-rotation
[245.053252] Starting dynamic subtest: pipe-A
[245.070650] Dynamic subtest pipe-A: SKIP (0.017s)
[245.078479] Starting dynamic subtest: pipe-B
[245.101696] Dynamic subtest pipe-B: SKIP (0.030s)
[245.109395] Starting dynamic subtest: pipe-C
[245.132476] Dynamic subtest pipe-C: SKIP (0.031s)
[245.140292] Starting dynamic subtest: pipe-D
[245.167154] Dynamic subtest pipe-D: SKIP (0.034s)
[245.168880] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.114s)
[245.276836] [043/133] (782s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[245.850038] Starting subtest: syncobj-timeline-invalid-wait
[245.851665] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[246.838435] [044/133] (780s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[246.938469] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[246.940308] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[248.082881] [045/133] (779s left) gem_userptr_blits (unsync-unmap-after-close)
[248.137620] Subtest unsync-unmap-after-close: SKIP (0.000s)
[248.246494] [046/133] (779s left) kms_psr (psr-sprite-plane-move)
[248.330504] Starting subtest: psr-sprite-plane-move
[248.331309] Starting dynamic subtest: eDP-1
[250.139313] Dynamic subtest eDP-1: SUCCESS (1.808s)
[250.140203] Subtest psr-sprite-plane-move: SUCCESS (1.809s)
[250.964787] [047/133] (776s left) syncobj_wait (signal)
[251.008806] Starting subtest: signal
[251.009790] Subtest signal: SUCCESS (0.000s)
[251.115811] [048/133] (776s left) kms_psr2_su (page_flip-p010)
[251.173671] Subtest page_flip-P010: SKIP (0.000s)
[251.231297] [049/133] (776s left) gem_mmap_gtt (big-copy-xy)
[251.281384] Subtest big-copy-XY: SKIP (0.000s)
[251.340232] [050/133] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[251.428473] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[258.652147] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.223s)
[258.758630] [051/133] (769s left) gem_ctx_persistence (saturated-hostile)
[258.811452] Starting subtest: saturated-hostile
[258.812590] Starting dynamic subtest: rcs0
[259.629257] Dynamic subtest rcs0: SUCCESS (0.817s)
[259.642488] Starting dynamic subtest: bcs0
[260.418734] Dynamic subtest bcs0: SUCCESS (0.787s)
[260.430019] Starting dynamic subtest: vcs0
[261.210658] Dynamic subtest vcs0: SUCCESS (0.790s)
[261.220590] Starting dynamic subtest: vcs1
[262.008938] Dynamic subtest vcs1: SUCCESS (0.797s)
[262.020113] Starting dynamic subtest: vecs0
[262.795021] Dynamic subtest vecs0: SUCCESS (0.784s)
[262.806767] Starting dynamic subtest: ccs0
[263.626698] Dynamic subtest ccs0: SUCCESS (0.830s)
[263.628306] Subtest saturated-hostile: SUCCESS (4.815s)
[263.702009] [052/133] (764s left) gem_eio (wait-1us)
[263.893075] Starting subtest: wait-1us
[264.195512] Subtest wait-1us: SUCCESS (0.303s)
[264.325339] [053/133] (763s left) kms_psr (psr-basic)
[264.412663] Starting subtest: psr-basic
[264.413574] Starting dynamic subtest: eDP-1
[266.077359] Dynamic subtest eDP-1: SUCCESS (1.664s)
[266.078197] Subtest psr-basic: SUCCESS (1.665s)
[266.969365] [054/133] (760s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[267.061187] Starting subtest: flip-vs-dpms-on-nop-interruptible
[267.062318] Starting dynamic subtest: A-eDP1
[268.954105] Dynamic subtest A-eDP1: SUCCESS (1.891s)
[268.963675] Starting dynamic subtest: B-eDP1
[270.786385] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[270.796704] Starting dynamic subtest: C-eDP1
[272.616465] Dynamic subtest C-eDP1: SUCCESS (1.827s)
[272.625681] Starting dynamic subtest: D-eDP1
[274.458015] Dynamic subtest D-eDP1: SUCCESS (1.839s)
[274.459567] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.398s)
[275.638248] [055/133] (752s left) kms_lease (lease-get)
[275.742633] Starting subtest: lease-get
[275.743582] Starting dynamic subtest: pipe-A-eDP-1
[275.744441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[275.756282] Starting dynamic subtest: pipe-B-eDP-1
[275.757121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[275.764999] Starting dynamic subtest: pipe-C-eDP-1
[275.765844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[275.773328] Starting dynamic subtest: pipe-D-eDP-1
[275.774092] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[275.774902] Subtest lease-get: SUCCESS (0.011s)
[275.868266] [056/133] (752s left) api_intel_bb (blit-reloc-purge-cache)
[275.932874] Starting subtest: blit-reloc-purge-cache
[275.934824] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[276.038358] [057/133] (751s left) gem_exec_schedule (u-semaphore-codependency)
[276.093992] Starting subtest: u-semaphore-codependency
[276.108357] Subtest u-semaphore-codependency: SUCCESS (0.014s)
[276.441251] [058/133] (751s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[276.490309] Starting subtest: etime-multi-wait-all-for-submit-submitted
[276.608378] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[276.684991] [059/133] (751s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[276.774348] Starting subtest: plane-lut1d-pre-ctm3x4
[276.944819] Starting dynamic subtest: pipe-A-plane-0
[277.189452] Dynamic subtest pipe-A-plane-0: FAIL (0.183s)
[277.197635] Starting dynamic subtest: pipe-A-plane-1
[277.372231] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[277.381379] Starting dynamic subtest: pipe-A-plane-2
[277.544165] Dynamic subtest pipe-A-plane-2: FAIL (0.165s)
[278.659453] Starting dynamic subtest: pipe-B-plane-0
[278.914438] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[278.923380] Starting dynamic subtest: pipe-B-plane-1
[279.087626] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[279.096393] Starting dynamic subtest: pipe-B-plane-2
[279.273894] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[280.362983] Starting dynamic subtest: pipe-C-plane-0
[280.642010] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[280.653984] Starting dynamic subtest: pipe-C-plane-1
[280.815475] Dynamic subtest pipe-C-plane-1: FAIL (0.144s)
[280.827882] Starting dynamic subtest: pipe-C-plane-2
[280.988238] Dynamic subtest pipe-C-plane-2: FAIL (0.166s)
[281.987513] Starting dynamic subtest: pipe-D-plane-0
[282.296354] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[282.305051] Starting dynamic subtest: pipe-D-plane-1
[282.484191] Dynamic subtest pipe-D-plane-1: FAIL (0.144s)
[282.492538] Starting dynamic subtest: pipe-D-plane-2
[282.683086] Dynamic subtest pipe-D-plane-2: FAIL (0.331s)
[282.918413] Subtest plane-lut1d-pre-ctm3x4: FAIL (6.141s)
[283.771183] [060/133] (744s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[283.856758] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[283.859098] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[283.951615] [061/133] (744s left) gem_pxp (protected-raw-src-copy-not-readible)
[284.062281] Starting subtest: protected-raw-src-copy-not-readible
[284.122987] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.062s)
[284.239354] [062/133] (743s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[284.339564] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[285.407327] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.068s)
[285.538146] [063/133] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[285.629751] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[285.631739] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[285.739284] [064/133] (742s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[285.797285] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[285.798257] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[285.885115] [065/133] (742s left) prime_vgem (coherency-blt)
[285.956240] Starting subtest: coherency-blt
[287.135763] Subtest coherency-blt: SUCCESS (1.169s)
[287.270400] [066/133] (741s left) kms_vblank (wait-forked)
[287.348720] Starting subtest: wait-forked
[287.349793] Starting dynamic subtest: pipe-A-eDP-1
[289.159116] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[289.171423] Starting dynamic subtest: pipe-D-eDP-1
[291.672181] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.511s)
[291.673340] Subtest wait-forked: SUCCESS (4.324s)
[292.524557] [067/133] (735s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[292.637053] Starting subtest: basic-busy-flip-before-cursor-atomic
[292.638805] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[292.779856] [068/133] (735s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[292.875938] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[292.877750] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[292.960430] [069/133] (735s left) i915_hangman (error-state-basic)
[293.025395] Starting subtest: error-state-basic
[293.172847] Subtest error-state-basic: SUCCESS (0.147s)
[293.255856] [070/133] (735s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[293.352053] Starting subtest: 4-tiled-64bpp-rotate-0
[294.899213] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.547s)
[295.067039] [071/133] (733s left) gen9_exec_parse (bb-start-out)
[295.122307] Subtest bb-start-out: SKIP (0.000s)
[295.196742] [072/133] (733s left) syncobj_basic (bad-create-flags)
[295.240227] Starting subtest: bad-create-flags
[295.241096] Subtest bad-create-flags: SUCCESS (0.000s)
[295.331257] [073/133] (733s left) perf_pmu (enable-race)
[295.371138] Starting subtest: enable-race
[295.371992] Starting dynamic subtest: rcs0
[308.155063] Dynamic subtest rcs0: SUCCESS (12.769s)
[308.165593] Starting dynamic subtest: bcs0
[320.904497] Dynamic subtest bcs0: SUCCESS (12.744s)
[320.915402] Starting dynamic subtest: vcs0
[336.756298] Dynamic subtest vcs0: SUCCESS (15.857s)
[336.767487] Starting dynamic subtest: vcs1
[352.756083] Dynamic subtest vcs1: SUCCESS (15.996s)
[352.767663] Starting dynamic subtest: vecs0
[368.820526] Dynamic subtest vecs0: SUCCESS (16.061s)
[368.830468] Starting dynamic subtest: ccs0
[381.568939] Dynamic subtest ccs0: SUCCESS (12.744s)
[381.569920] Subtest enable-race: SUCCESS (86.186s)
[381.665939] [074/133] (646s left) perf (blocking)
[381.789817] Starting subtest: blocking
[381.790614] Starting dynamic subtest: 0-rcs0
[391.820262] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[391.831570] Starting dynamic subtest: 1-vcs1
[401.846669] Dynamic subtest 1-vcs1: SUCCESS (10.024s)
[401.847912] Subtest blocking: SUCCESS (20.048s)
[401.885297] [075/133] (626s left) sw_sync (alloc_fence_invalid_timeline)
[401.917782] Starting subtest: alloc_fence_invalid_timeline
[401.918691] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[401.975653] [076/133] (626s left) kms_pm_rpm (modeset-pc8-residency-stress)
[403.899981] Starting subtest: modeset-pc8-residency-stress
[403.902084] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[404.273619] [077/133] (624s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[404.355113] Starting subtest: flip-vs-dpms-off-vs-modeset
[404.357381] Starting dynamic subtest: A-eDP1
[408.099656] Dynamic subtest A-eDP1: SUCCESS (3.742s)
[408.108800] Starting dynamic subtest: B-eDP1
[411.297853] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[411.308667] Starting dynamic subtest: C-eDP1
[414.415568] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[414.424292] Starting dynamic subtest: D-eDP1
[417.525262] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[417.527233] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.171s)
[418.331085] [078/133] (610s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[418.439888] Starting subtest: yf-tiled-64bpp-rotate-0
[418.441669] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[418.521380] [079/133] (610s left) syncobj_basic (bad-destroy)
[418.574915] Starting subtest: bad-destroy
[418.576002] Subtest bad-destroy: SUCCESS (0.000s)
[418.700768] [080/133] (610s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[418.825834] Starting subtest: dp-mst-type-0-suspend-resume
[418.827884] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[418.948420] [081/133] (609s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[419.035885] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[419.037771] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[419.125808] [082/133] (609s left) kms_psr (pr-dpms)
[419.213203] Starting subtest: pr-dpms
[419.215143] Subtest pr-dpms: SKIP (0.000s)
[419.282931] [083/133] (609s left) syncobj_timeline (invalid-signal-illegal-handle)
[419.335783] Starting subtest: invalid-signal-illegal-handle
[419.336837] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[419.431140] [084/133] (609s left) gem_exec_suspend (basic-s4-devices)
[419.499959] Starting subtest: basic-S4-devices
[419.501129] Starting dynamic subtest: smem
[430.773640] Dynamic subtest smem: SUCCESS (11.262s)
[430.776001] Subtest basic-S4-devices: SUCCESS (11.264s)
[436.968594] [085/133] (598s left) gem_exec_whisper (basic-fds-forked)
[437.048968] Starting subtest: basic-fds-forked
[461.275562] Subtest basic-fds-forked: SUCCESS (24.210s)
[461.447694] [086/133] (573s left) kms_flip (plain-flip-ts-check-interruptible)
[461.536760] Starting subtest: plain-flip-ts-check-interruptible
[461.539060] Starting dynamic subtest: A-eDP1
[470.404448] Dynamic subtest A-eDP1: SUCCESS (8.840s)
[470.416863] Starting dynamic subtest: B-eDP1
[479.229666] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[479.240397] Starting dynamic subtest: C-eDP1
[488.060942] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[488.073485] Starting dynamic subtest: D-eDP1
[496.889853] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[496.890853] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.321s)
[498.064897] [087/133] (537s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[498.153941] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[504.890798] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.738s)
[504.977138] [088/133] (530s left) kms_properties (crtc-properties-atomic)
[505.064454] Starting subtest: crtc-properties-atomic
[505.065426] Starting dynamic subtest: pipe-A-eDP-1
[505.508770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[505.519542] Starting dynamic subtest: pipe-B-eDP-1
[506.650305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[506.661076] Starting dynamic subtest: pipe-C-eDP-1
[507.777735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[507.787528] Starting dynamic subtest: pipe-D-eDP-1
[508.914151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[508.915070] Subtest crtc-properties-atomic: SUCCESS (3.850s)
[509.717498] [089/133] (525s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[509.814119] Starting subtest: primary-y-tiled-reflect-x-0
[509.874545] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[509.985335] [090/133] (525s left) api_intel_bb (object-reloc-purge-cache)
[510.042142] Starting subtest: object-reloc-purge-cache
[510.044494] Subtest object-reloc-purge-cache: SKIP (0.003s)
[510.155947] [091/133] (525s left) gem_lmem_swapping (heavy-verify-random-ccs)
[510.224008] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[510.267157] [092/133] (525s left) gem_render_copy (y-tiled)
[510.318119] Starting subtest: y-tiled
[510.319998] Subtest y-tiled: SKIP (0.000s)
[510.495826] [093/133] (524s left) i915_pm_rc6_residency (media-rc6-accuracy)
[510.555593] Starting subtest: media-rc6-accuracy
[510.557457] Subtest media-rc6-accuracy: SKIP (0.000s)
[510.665633] [094/133] (524s left) gem_wait (write-wait)
[510.722782] Starting subtest: write-wait
[510.723896] Starting dynamic subtest: all-engines
[511.813435] Dynamic subtest all-engines: SUCCESS (1.090s)
[511.831969] Starting dynamic subtest: rcs0
[512.877003] Dynamic subtest rcs0: SUCCESS (1.061s)
[512.898312] Starting dynamic subtest: bcs0
[513.941520] Dynamic subtest bcs0: SUCCESS (1.061s)
[513.959784] Starting dynamic subtest: vcs0
[514.997052] Dynamic subtest vcs0: SUCCESS (1.054s)
[515.015564] Starting dynamic subtest: vcs1
[516.051399] Dynamic subtest vcs1: SUCCESS (1.052s)
[516.069541] Starting dynamic subtest: vecs0
[517.105512] Dynamic subtest vecs0: SUCCESS (1.052s)
[517.123201] Starting dynamic subtest: ccs0
[518.163067] Dynamic subtest ccs0: SUCCESS (1.055s)
[518.164431] Subtest write-wait: SUCCESS (7.440s)
[518.358182] [095/133] (517s left) perf (short-reads)
[518.456184] Starting subtest: short-reads
[518.469791] Subtest short-reads: SUCCESS (0.014s)
[518.512366] [096/133] (516s left) syncobj_timeline (multi-wait-signaled)
[518.563138] Starting subtest: multi-wait-signaled
[518.564070] Subtest multi-wait-signaled: SUCCESS (0.001s)
[518.661818] [097/133] (516s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[518.764834] Starting subtest: nonblocking-crc-frame-sequence
[518.765636] Starting dynamic subtest: pipe-A-eDP-1
[519.520665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[519.530467] Starting dynamic subtest: pipe-B-eDP-1
[520.922279] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[520.933247] Starting dynamic subtest: pipe-C-eDP-1
[522.302929] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[522.312674] Starting dynamic subtest: pipe-D-eDP-1
[523.626945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[523.627811] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.863s)
[524.429567] [098/133] (511s left) kms_vblank (query-forked)
[524.524806] Starting subtest: query-forked
[524.525682] Starting dynamic subtest: pipe-A-eDP-1
[526.365044] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.840s)
[526.377692] Starting dynamic subtest: pipe-D-eDP-1
[528.865242] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[528.866368] Subtest query-forked: SUCCESS (4.341s)
[529.700640] [099/133] (505s left) gem_mmap_wc (invalid-flags)
[529.744550] Subtest invalid-flags: SKIP (0.000s)
[529.807670] [100/133] (505s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[529.905719] Starting subtest: fb-8bpc-vs-panel-6bpc
[529.906647] Starting dynamic subtest: pipe-A-eDP-1
[531.313091] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.407s)
[531.313928] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.408s)
[532.174578] [101/133] (503s left) gem_create (hog-create)
[532.236503] Starting subtest: hog-create
[532.237707] Starting dynamic subtest: smem0
[565.754837] Dynamic subtest smem0: SUCCESS (33.507s)
[565.756092] Subtest hog-create: SUCCESS (33.509s)
[565.931608] [102/133] (469s left) kms_cursor_crc (cursor-onscreen-32x10)
[566.091541] Starting subtest: cursor-onscreen-32x10
[566.135585] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[566.418081] [103/133] (469s left) kms_atomic_transition (plane-all-transition)
[566.501866] Starting subtest: plane-all-transition
[566.502916] Starting dynamic subtest: pipe-A-eDP-1
[568.997519] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[569.318483] Starting dynamic subtest: pipe-B-eDP-1
[572.513315] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.203s)
[572.815009] Subtest plane-all-transition: SUCCESS (6.312s)
[573.656112] [104/133] (462s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[573.748716] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[573.749702] Starting dynamic subtest: pipe-A-eDP-1
[573.771852] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[573.782195] Starting dynamic subtest: pipe-B-eDP-1
[573.804678] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[573.814401] Starting dynamic subtest: pipe-C-eDP-1
[573.837428] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[573.847605] Starting dynamic subtest: pipe-D-eDP-1
[573.869445] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[573.871056] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.012s)
[576.018391] [105/133] (459s left) i915_drm_fdinfo (busy-idle)
[576.061518] Starting subtest: busy-idle
[576.062455] Starting dynamic subtest: rcs0
[576.088668] Dynamic subtest rcs0: SKIP (0.026s)
[576.100888] Starting dynamic subtest: bcs0
[576.102862] Dynamic subtest bcs0: SKIP (0.000s)
[576.112434] Starting dynamic subtest: vcs0
[576.114183] Dynamic subtest vcs0: SKIP (0.000s)
[576.123632] Starting dynamic subtest: vcs1
[576.125603] Dynamic subtest vcs1: SKIP (0.000s)
[576.135270] Starting dynamic subtest: vecs0
[576.137075] Dynamic subtest vecs0: SKIP (0.000s)
[576.146374] Starting dynamic subtest: ccs0
[576.148132] Dynamic subtest ccs0: SKIP (0.000s)
[576.150161] Subtest busy-idle: SKIP (0.031s)
[576.183129] [106/133] (459s left) gem_exec_reloc (basic-write-cpu-active)
[576.256451] Subtest basic-write-cpu-active: SKIP (0.000s)
[576.323847] [107/133] (459s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[576.425249] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[576.426370] Starting dynamic subtest: pipe-A-default-mode
[579.146843] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[579.147743] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.723s)
[580.018765] [108/133] (455s left) gem_mmap_offset (clear-via-pagefault)
[580.084155] Starting subtest: clear-via-pagefault
[580.085575] Starting dynamic subtest: smem0
[613.858783] Dynamic subtest smem0: SUCCESS (33.761s)
[613.859869] Subtest clear-via-pagefault: SUCCESS (33.763s)
[613.959534] [109/133] (421s left) gem_ctx_isolation (preservation)
[614.023891] Starting subtest: preservation
[614.024835] Starting dynamic subtest: rcs0
[614.179276] Dynamic subtest rcs0: SUCCESS (0.154s)
[614.192239] Starting dynamic subtest: bcs0
[614.325254] Dynamic subtest bcs0: SUCCESS (0.145s)
[614.339983] Starting dynamic subtest: vcs0
[614.476907] Dynamic subtest vcs0: SUCCESS (0.150s)
[614.487048] Starting dynamic subtest: vcs1
[615.915927] Dynamic subtest vcs1: SUCCESS (1.437s)
[615.926970] Starting dynamic subtest: vecs0
[617.895037] Dynamic subtest vecs0: SUCCESS (1.979s)
[617.906266] Starting dynamic subtest: ccs0
[619.883270] Dynamic subtest ccs0: SUCCESS (1.986s)
[619.885025] Subtest preservation: SUCCESS (5.858s)
[620.126425] [110/133] (415s left) kms_flip (2x-flip-vs-panning)
[620.214500] Starting subtest: 2x-flip-vs-panning
[620.225280] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[620.303951] [111/133] (415s left) gem_softpin (zero)
[620.355231] Starting subtest: zero
[620.359731] Subtest zero: SUCCESS (0.005s)
[620.465026] [112/133] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[620.546701] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[627.977245] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.431s)
[628.113019] [113/133] (407s left) kms_getfb (getfb-handle-protection)
[628.211755] Starting subtest: getfb-handle-protection
[628.233838] Subtest getfb-handle-protection: SUCCESS (0.023s)
[628.350646] [114/133] (407s left) i915_suspend (forcewake)
[628.406341] Starting subtest: forcewake
[661.150059] Subtest forcewake: SUCCESS (3.069s)
[668.245068] [115/133] (374s left) gem_exec_fence (expired-history)
[668.724858] Starting subtest: expired-history
[676.105087] Subtest expired-history: SUCCESS (7.360s)
[676.759878] [116/133] (366s left) gem_flink_basic (bad-open)
[676.816803] Starting subtest: bad-open
[676.817815] Subtest bad-open: SUCCESS (0.000s)
[676.923940] [117/133] (366s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[677.030183] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[677.030970] Starting dynamic subtest: pipe-A-eDP-1
[710.413460] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.690s)
[710.424073] Starting dynamic subtest: pipe-B-eDP-1
[745.316722] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.433s)
[745.326708] Starting dynamic subtest: pipe-C-eDP-1
[780.313385] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.396s)
[780.324516] Starting dynamic subtest: pipe-D-eDP-1
[815.319013] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.462s)
[815.319912] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (16.987s)
[822.568869] [118/133] (226s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[822.744455] Starting subtest: cursor-rapid-movement-32x32
[822.806303] Subtest cursor-rapid-movement-32x32: SKIP (0.060s)
[823.079101] [119/133] (226s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[823.165641] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[823.166848] Starting dynamic subtest: pipe-A-eDP-1
[823.265475] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[823.276839] Starting dynamic subtest: pipe-B-eDP-1
[824.417227] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s)
[824.419026] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.250s)
[825.606256] [120/133] (223s left) sw_sync (timeline_closed)
[825.643284] Starting subtest: timeline_closed
[825.644204] Subtest timeline_closed: SUCCESS (0.000s)
[825.690431] [121/133] (223s left) gem_mmap_gtt (bad-object)
[825.745739] Subtest bad-object: SKIP (0.000s)
[825.807619] [122/133] (223s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[825.860753] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[825.862547] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[826.054958] [123/133] (223s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[826.177713] Starting subtest: basic-flip-after-cursor-legacy
[827.094603] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.914s)
[827.939887] [124/133] (221s left) kms_chamelium_frames (dp-crc-single)
[828.324467] Subtest dp-crc-single: SKIP (0.000s)
[829.150378] [125/133] (220s left) gem_mmap_offset (pf-nonblock)
[829.193562] Starting subtest: pf-nonblock
[829.198981] Subtest pf-nonblock: SUCCESS (0.006s)
[829.328127] [126/133] (220s left) kms_chamelium_hpd (dp-hpd-fast)
[829.724090] Subtest dp-hpd-fast: SKIP (0.000s)
[830.495001] [127/133] (219s left) syncobj_timeline (single-wait-all-available-submitted)
[830.551987] Starting subtest: single-wait-all-available-submitted
[830.552858] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[830.639435] [128/133] (219s left) kms_properties (plane-properties-legacy)
[830.723522] Starting subtest: plane-properties-legacy
[830.725593] Starting dynamic subtest: pipe-A-eDP-1
[831.281792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[831.291847] Starting dynamic subtest: pipe-B-eDP-1
[832.602154] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.318s)
[832.611974] Starting dynamic subtest: pipe-C-eDP-1
[833.843842] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[833.855526] Starting dynamic subtest: pipe-D-eDP-1
[835.082236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[835.083137] Subtest plane-properties-legacy: SUCCESS (4.355s)
[835.881171] [129/133] (213s left) syncobj_timeline (wait-for-submit-delayed-submit)
[835.934223] Starting subtest: wait-for-submit-delayed-submit
[836.038047] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[836.124758] [130/133] (213s left) kms_plane_multiple (tiling-none)
[836.215421] Starting subtest: tiling-none
[836.216367] Starting dynamic subtest: pipe-A-eDP-1
[839.905996] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.687s)
[839.918450] Starting dynamic subtest: pipe-B-eDP-1
[844.231033] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.321s)
[844.240712] Starting dynamic subtest: pipe-C-eDP-1
[848.576886] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.343s)
[848.586606] Starting dynamic subtest: pipe-D-eDP-1
[853.027801] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.448s)
[853.028742] Subtest tiling-none: SUCCESS (16.804s)
[853.838661] [131/133] (195s left) gem_pipe_control_store_loop (fresh-buffer)
[853.899690] Starting subtest: fresh-buffer
[856.097813] Subtest fresh-buffer: SUCCESS (2.152s)
[856.171447] [132/133] (193s left) gem_exec_gttfill (multigpu-basic)
[856.330447] Starting subtest: multigpu-basic
[869.849975] Subtest multigpu-basic: SUCCESS (13.506s)
[869.892796] [133/133] (180s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[870.034573] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[876.673735] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.636s)
[876.792317] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_flush
results: parsing output: 1/ for test: kms_cursor_edge_walk
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_fence_pin_leak
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gem_busy
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_basic
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: gem_exec_alignment
results: parsing output: 23/ for test: dmabuf_sync_file
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_chamelium_color
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_busy
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: kms_pm_backlight
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_feature_discovery
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: gem_flink_race
results: parsing output: 37/ for test: kms_invalid_mode
results: parsing output: 38/ for test: gem_exec_flush
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_psr2_su
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_color_pipeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: syncobj_basic
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: syncobj_basic
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_suspend
results: parsing output: 84/ for test: gem_exec_whisper
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_properties
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: i915_pm_rc6_residency
results: parsing output: 93/ for test: gem_wait
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_pipe_crc_basic
results: parsing output: 97/ for test: kms_vblank
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_dither
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: gem_ctx_isolation
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_getfb
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: gem_flink_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_chamelium_frames
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_plane_multiple
results: parsing output: 130/ for test: gem_pipe_control_store_loop
results: parsing output: 131/ for test: gem_exec_gttfill
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.