[42.705709] Initializing watchdogs
[42.705844]   /dev/watchdog0
[42.719783] [001/144] (960s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[43.115139] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[43.120201] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[43.949633] [002/144] (959s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[44.024840] Starting subtest: fbc-tiling-linear
[46.708227] Subtest fbc-tiling-linear: SUCCESS (2.690s)
[46.839184] [003/144] (956s left) kms_psr (psr-primary-render)
[46.919054] Starting subtest: psr-primary-render
[46.921284] Starting dynamic subtest: eDP-1
[48.729963] Dynamic subtest eDP-1: SUCCESS (1.809s)
[48.732713] Subtest psr-primary-render: SUCCESS (1.810s)
[49.634254] [004/144] (953s left) gem_exec_reloc (basic-write-read-noreloc)
[49.701543] Subtest basic-write-read-noreloc: SKIP (0.000s)
[49.759743] [005/144] (953s left) kms_hdr (bpc-switch)
[49.821548] Starting subtest: bpc-switch
[50.994602] Starting dynamic subtest: pipe-A-eDP-1
[54.706385] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.711s)
[54.708843] Subtest bpc-switch: SUCCESS (4.883s)
[54.808348] [006/144] (948s left) i915_fb_tiling
[54.884861] [007/144] (948s left) gem_userptr_blits (stress-mm)
[54.963921] Starting subtest: stress-mm
[60.331452] Subtest stress-mm: SUCCESS (5.369s)
[60.429771] [008/144] (942s left) perf (invalid-oa-exponent)
[60.565643] Starting subtest: invalid-oa-exponent
[60.579572] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[60.600736] [009/144] (942s left) gem_userptr_blits (forbidden-operations)
[60.652674] Starting subtest: forbidden-operations
[60.657218] Subtest forbidden-operations: SKIP (0.000s)
[60.771867] [010/144] (942s left) kms_chamelium_hpd (dp-hpd-storm)
[61.155863] Subtest dp-hpd-storm: SKIP (0.000s)
[62.022128] [011/144] (941s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[62.099044] Starting subtest: psr-rgb565-draw-mmap-wc
[66.858070] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.761s)
[66.961719] [012/144] (936s left) kms_psr (psr-sprite-plane-onoff)
[67.064721] Starting subtest: psr-sprite-plane-onoff
[67.067504] Starting dynamic subtest: eDP-1
[68.929346] Dynamic subtest eDP-1: SUCCESS (1.864s)
[68.932159] Subtest psr-sprite-plane-onoff: SUCCESS (1.865s)
[69.853587] [013/144] (933s left) gem_lmem_swapping (basic)
[69.920281] Subtest basic: SKIP (0.000s)
[69.938356] [014/144] (933s left) v3d/v3d_wait_bo (map-bo-0ns)
[70.008495] Subtest map-bo-0ns: SKIP (0.000s)
[70.053086] [015/144] (933s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[70.121372] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[70.126035] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[70.208997] [016/144] (933s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[70.307320] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[70.312037] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[70.394061] [017/144] (933s left) syncobj_wait (reset-multiple-signaled)
[70.450707] Starting subtest: reset-multiple-signaled
[70.453154] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[70.510165] [018/144] (933s left) i915_pm_rc6_residency (media-rc6-accuracy)
[70.564687] Starting subtest: media-rc6-accuracy
[70.569635] Subtest media-rc6-accuracy: SKIP (0.000s)
[70.620316] [019/144] (933s left) gem_ctx_freq (sysfs)
[70.683734] Starting subtest: sysfs
[70.686375] Starting dynamic subtest: gt0
[76.192421] Dynamic subtest gt0: SUCCESS (5.508s)
[76.207117] Starting dynamic subtest: gt1
[117.417055] Dynamic subtest gt1: SUCCESS (41.223s)
[117.419966] Subtest sysfs: SUCCESS (46.732s)
[117.485212] [020/144] (886s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-mc-ccs)
[117.874350] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs
[117.880396] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[118.755286] [021/144] (884s left) kms_flip (plain-flip-interruptible)
[118.823448] Starting subtest: plain-flip-interruptible
[118.825485] Starting dynamic subtest: A-eDP1
[120.598554] Dynamic subtest A-eDP1: SUCCESS (1.773s)
[120.613798] Starting dynamic subtest: B-eDP1
[122.368652] Dynamic subtest B-eDP1: SUCCESS (1.769s)
[122.384889] Starting dynamic subtest: C-eDP1
[124.149963] Dynamic subtest C-eDP1: SUCCESS (1.781s)
[124.166392] Starting dynamic subtest: D-eDP1
[125.889802] Dynamic subtest D-eDP1: SUCCESS (1.739s)
[125.898828] Subtest plain-flip-interruptible: SUCCESS (7.075s)
[127.138791] [022/144] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[127.246588] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[127.251990] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[127.340328] [023/144] (876s left) gem_ctx_param (invalid-get-ringsize)
[127.406324] Starting subtest: invalid-get-ringsize
[127.408754] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[127.467956] [024/144] (876s left) v3d/v3d_perfmon (create-single-perfmon)
[127.564167] Subtest create-single-perfmon: SKIP (0.000s)
[127.613967] [025/144] (876s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-ccs)
[128.011029] Starting subtest: pipe-C-bad-rotation-90-y-tiled-ccs
[128.016403] Subtest pipe-C-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[128.867433] [026/144] (874s left) gem_blits (basic)
[128.936805] Starting subtest: basic
[130.198586] Subtest basic: SUCCESS (1.261s)
[130.290165] [027/144] (873s left) gem_lmem_swapping (random)
[130.337546] Subtest random: SKIP (0.000s)
[130.378298] [028/144] (873s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[130.769054] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[132.751311] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.983s)
[133.993089] [029/144] (869s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[134.073536] Starting subtest: fbcpsr-stridechange
[138.390793] Subtest fbcpsr-stridechange: SUCCESS (4.319s)
[138.503998] [030/144] (865s left) syncobj_timeline (host-signal-ordered)
[138.559709] Starting subtest: host-signal-ordered
[138.561979] Subtest host-signal-ordered: SUCCESS (0.000s)
[138.620535] [031/144] (865s left) prime_mmap_coherency (write)
[138.679780] Starting subtest: write
[144.062761] Subtest write: SUCCESS (5.381s)
[144.300333] [032/144] (859s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[144.373245] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[144.378474] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[144.446438] [033/144] (859s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[144.892047] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[145.874767] Subtest pipe-D-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.983s)
[147.107773] [034/144] (856s left) gem_exec_params (invalid-fence-in-submit)
[147.167373] Starting subtest: invalid-fence-in-submit
[147.173315] Subtest invalid-fence-in-submit: SUCCESS (0.006s)
[147.251248] [035/144] (856s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[147.313193] Starting subtest: yf-tiled-ccs-to-yf-tiled
[147.317985] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[147.495211] [036/144] (856s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[147.596305] Starting subtest: 2x-long-cursor-vs-flip-legacy
[147.601274] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s)
[147.737473] [037/144] (856s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[147.809886] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[147.815066] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[147.887429] [038/144] (856s left) kms_properties (connector-properties-atomic)
[147.972090] Starting subtest: connector-properties-atomic
[148.408779] Subtest connector-properties-atomic: SUCCESS (0.429s)
[149.284667] [039/144] (854s left) gem_userptr_blits (stress-mm-invalidate-close)
[149.386105] Starting subtest: stress-mm-invalidate-close
[151.624437] Subtest stress-mm-invalidate-close: SUCCESS (2.237s)
[152.331705] [040/144] (851s left) perf_pmu (pmu-read)
[152.404694] Starting subtest: pmu-read
[152.407200] Subtest pmu-read: SUCCESS (0.002s)
[152.474776] [041/144] (851s left) kms_big_fb (yf-tiled-addfb)
[152.550570] Starting subtest: yf-tiled-addfb
[152.555292] Subtest yf-tiled-addfb: SKIP (0.000s)
[152.610997] [042/144] (851s left) kms_ccs (pipe-a-bad-pixel-format-yf-tiled-ccs)
[152.685757] Starting subtest: pipe-A-bad-pixel-format-yf-tiled-ccs
[152.691263] Subtest pipe-A-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[153.843410] [043/144] (850s left) v3d/v3d_get_bo_offset (get-bad-handle)
[153.937196] Subtest get-bad-handle: SKIP (0.000s)
[153.989643] [044/144] (850s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-rc-ccs)
[154.397693] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs
[154.404584] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[155.304101] [045/144] (849s left) gem_exec_whisper (basic-contexts-all)
[155.359748] Starting subtest: basic-contexts-all
[173.527618] Subtest basic-contexts-all: SUCCESS (18.165s)
[173.705094] [046/144] (830s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[173.768073] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[173.770479] Starting dynamic subtest: pipe-A-default-mode
[174.985376] Dynamic subtest pipe-A-default-mode: SKIP (1.215s)
[174.990267] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.216s)
[175.123052] [047/144] (829s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-mc-ccs)
[175.508860] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs
[175.514165] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[176.419609] [048/144] (828s left) gem_userptr_blits (userfault)
[176.472800] Starting subtest: userfault
[176.476329] Subtest userfault: SUCCESS (0.008s)
[176.592599] [049/144] (827s left) drm_read (empty-nonblock)
[176.713455] Starting subtest: empty-nonblock
[176.716372] Subtest empty-nonblock: SUCCESS (0.000s)
[176.824984] [050/144] (827s left) gem_ctx_persistence (idempotent)
[176.897994] Starting subtest: idempotent
[176.901052] Subtest idempotent: SUCCESS (0.000s)
[176.968313] [051/144] (827s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[177.078943] Starting subtest: plane-use-after-nonblocking-unbind
[177.081425] Starting dynamic subtest: pipe-A-eDP-1
[177.147284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[177.465724] Starting dynamic subtest: pipe-B-eDP-1
[178.316193] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.866s)
[178.617798] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.536s)
[179.557081] [052/144] (825s left) gem_exec_reloc (basic-range-active)
[179.637067] Subtest basic-range-active: SKIP (0.000s)
[179.695979] [053/144] (824s left) perf (gen12-group-concurrent-oa-buffer-read)
[179.819548] Starting subtest: gen12-group-concurrent-oa-buffer-read
[189.857568] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.037s)
[189.895051] [054/144] (814s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[190.246759] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[191.109704] [055/144] (813s left) vgem_basic (bad-flag)
[191.207659] Starting subtest: bad-flag
[191.210040] Subtest bad-flag: SUCCESS (0.000s)
[191.256466] [056/144] (813s left) i915_pm_rps (thresholds-park)
[191.318587] Starting subtest: thresholds-park
[191.321335] Starting dynamic subtest: gt0
[191.326092] Dynamic subtest gt0: SKIP (0.004s)
[191.341685] Starting dynamic subtest: gt1
[191.346923] Dynamic subtest gt1: SKIP (0.000s)
[191.352257] Subtest thresholds-park: SKIP (0.005s)
[191.396542] [057/144] (813s left) kms_vblank (wait-busy-hang)
[191.518355] Starting subtest: wait-busy-hang
[191.520910] Starting dynamic subtest: pipe-A-eDP-1
[205.305360] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.785s)
[205.321047] Starting dynamic subtest: pipe-D-eDP-1
[220.382552] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.069s)
[220.385263] Subtest wait-busy-hang: SUCCESS (28.863s)
[221.284989] [058/144] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[221.375368] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[221.379843] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.459563] [059/144] (783s left) kms_ccs (pipe-c-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[221.870971] Starting subtest: pipe-C-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[221.873491] Subtest pipe-C-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[222.757589] [060/144] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[222.844237] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[227.758095] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.917s)
[227.862525] [061/144] (776s left) syncobj_timeline (multi-wait-for-submit-signaled)
[227.941553] Starting subtest: multi-wait-for-submit-signaled
[227.944017] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[228.012969] [062/144] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[228.091453] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[231.138767] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (3.052s)
[231.244324] [063/144] (773s left) kms_ccs (pipe-d-bad-pixel-format-yf-tiled-ccs)
[231.661052] Starting subtest: pipe-D-bad-pixel-format-yf-tiled-ccs
[231.666776] Subtest pipe-D-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[232.485756] [064/144] (772s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[232.645449] Starting subtest: cursor-rapid-movement-64x64
[232.655131] Starting dynamic subtest: pipe-A-eDP-1
[233.236212] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.580s)
[233.273364] Starting dynamic subtest: pipe-D-eDP-1
[234.529411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[234.532652] Subtest cursor-rapid-movement-64x64: SUCCESS (1.881s)
[235.402262] [065/144] (769s left) gem_ctx_param (invalid-ctx-get)
[235.441995] Starting subtest: invalid-ctx-get
[235.444675] Subtest invalid-ctx-get: SUCCESS (0.000s)
[235.501574] [066/144] (769s left) gem_exec_schedule (preempt-user)
[235.581761] Starting subtest: preempt-user
[235.584192] Starting dynamic subtest: rcs0
[235.586714] Dynamic subtest rcs0: SUCCESS (0.020s)
[235.603830] Starting dynamic subtest: bcs0
[235.606307] Dynamic subtest bcs0: SUCCESS (0.014s)
[235.617436] Starting dynamic subtest: vcs0
[235.622842] Dynamic subtest vcs0: SUCCESS (0.020s)
[235.636491] Starting dynamic subtest: vcs1
[235.642170] Dynamic subtest vcs1: SUCCESS (0.020s)
[235.652338] Starting dynamic subtest: vecs0
[235.657309] Dynamic subtest vecs0: SUCCESS (0.016s)
[235.664769] Starting dynamic subtest: ccs0
[235.676539] Dynamic subtest ccs0: SUCCESS (0.019s)
[235.679171] Subtest preempt-user: SUCCESS (0.112s)
[237.457987] [067/144] (767s left) api_intel_bb (crc32)
[237.514527] Starting subtest: crc32
[237.517054] Starting dynamic subtest: rcs0-smem0
[237.817729] Dynamic subtest rcs0-smem0: SUCCESS (0.305s)
[237.834888] Starting dynamic subtest: bcs0-smem0
[238.184286] Dynamic subtest bcs0-smem0: SUCCESS (0.366s)
[238.201455] Starting dynamic subtest: vcs0-smem0
[238.579412] Dynamic subtest vcs0-smem0: SUCCESS (0.393s)
[238.596327] Starting dynamic subtest: vcs1-smem0
[238.960554] Dynamic subtest vcs1-smem0: SUCCESS (0.380s)
[238.979395] Starting dynamic subtest: vecs0-smem0
[239.328542] Dynamic subtest vecs0-smem0: SUCCESS (0.366s)
[239.344454] Starting dynamic subtest: ccs0-smem0
[239.730451] Dynamic subtest ccs0-smem0: SUCCESS (0.400s)
[239.733847] Subtest crc32: SUCCESS (2.219s)
[239.836620] [068/144] (765s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[240.264139] Starting subtest: pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs-cc
[240.272494] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[241.124951] [069/144] (763s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-ccs)
[241.536725] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-ccs
[241.542469] Subtest pipe-C-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[242.409974] [070/144] (762s left) kms_draw_crc (draw-method-mmap-gtt)
[242.500403] Starting subtest: draw-method-mmap-gtt
[242.505363] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[242.591784] [071/144] (762s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[242.677801] Starting subtest: primary-y-tiled-reflect-x-90
[242.681833] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[242.745651] [072/144] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[242.822337] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[242.826165] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[242.919962] [073/144] (762s left) drm_fdinfo (virtual-busy-idle)
[242.978031] Starting subtest: virtual-busy-idle
[242.982446] Subtest virtual-busy-idle: SKIP (0.000s)
[243.041881] [074/144] (762s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[243.112104] Starting subtest: y-tiled-to-vebox-y-tiled
[243.116817] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[243.294598] [075/144] (761s left) gem_exec_fair (basic-sync)
[243.378511] Subtest basic-sync: SKIP (0.000s)
[243.425655] [076/144] (761s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[243.522418] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[244.626176] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.107s)
[244.754040] [077/144] (760s left) gem_workarounds (basic-read-fd)
[244.799291] Starting subtest: basic-read-fd
[244.811218] Subtest basic-read-fd: SUCCESS (0.011s)
[244.909702] [078/144] (760s left) gem_flink_basic (double-flink)
[244.959152] Starting subtest: double-flink
[244.961068] Subtest double-flink: SUCCESS (0.000s)
[245.045550] [079/144] (760s left) sysfs_heartbeat_interval (idempotent)
[245.111684] Starting subtest: idempotent
[245.113951] Starting dynamic subtest: vecs0
[245.116216] Dynamic subtest vecs0: SUCCESS (0.001s)
[245.122850] Starting dynamic subtest: ccs0
[245.124607] Dynamic subtest ccs0: SUCCESS (0.001s)
[245.133277] Starting dynamic subtest: vcs0
[245.134991] Dynamic subtest vcs0: SUCCESS (0.000s)
[245.143115] Starting dynamic subtest: bcs0
[245.144981] Dynamic subtest bcs0: SUCCESS (0.000s)
[245.152814] Starting dynamic subtest: rcs0
[245.155071] Dynamic subtest rcs0: SUCCESS (0.000s)
[245.170116] Starting dynamic subtest: vcs1
[245.172324] Dynamic subtest vcs1: SUCCESS (0.000s)
[245.174547] Subtest idempotent: SUCCESS (0.005s)
[245.198536] [080/144] (760s left) kms_color (ctm-blue-to-red)
[245.268122] Starting subtest: ctm-blue-to-red
[245.270301] Starting dynamic subtest: pipe-A
[245.992668] Dynamic subtest pipe-A: SUCCESS (0.724s)
[246.009225] Starting dynamic subtest: pipe-B
[247.495171] Dynamic subtest pipe-B: SUCCESS (1.500s)
[247.510451] Starting dynamic subtest: pipe-C
[248.969337] Dynamic subtest pipe-C: SUCCESS (1.472s)
[248.983397] Starting dynamic subtest: pipe-D
[250.427563] Dynamic subtest pipe-D: SUCCESS (1.456s)
[250.429642] Subtest ctm-blue-to-red: SUCCESS (5.158s)
[251.365879] [081/144] (754s left) kms_content_protection (uevent)
[251.463741] Starting subtest: uevent
[255.032994] Subtest uevent: SKIP (3.567s)
[256.294110] [082/144] (749s left) kms_plane_multiple (tiling-yf)
[256.381329] Starting subtest: tiling-yf
[256.386379] Subtest tiling-yf: SKIP (0.000s)
[256.447091] [083/144] (749s left) prime_vgem (basic-fence-flip)
[256.516198] Starting subtest: basic-fence-flip
[256.822573] Subtest basic-fence-flip: SUCCESS (0.309s)
[256.926884] [084/144] (748s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[257.019143] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[258.085051] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[258.185048] [085/144] (747s left) kms_vblank (accuracy-idle)
[258.230445] Starting subtest: accuracy-idle
[258.232544] Starting dynamic subtest: pipe-A-eDP-1
[259.986299] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[260.007888] Starting dynamic subtest: pipe-D-eDP-1
[262.521088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[262.523667] Subtest accuracy-idle: SUCCESS (4.293s)
[263.463458] [086/144] (742s left) kms_plane_scaling (2x-scaler-multi-pipe)
[263.531407] Starting subtest: 2x-scaler-multi-pipe
[263.536473] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[263.608258] [087/144] (741s left) gem_softpin (noreloc-s3)
[263.669760] Starting subtest: noreloc-S3
[285.042625] Subtest noreloc-S3: SUCCESS (5.380s)
[285.140895] [088/144] (736s left) gem_mmap_gtt (zero-extend)
[285.212229] Subtest zero-extend: SKIP (0.000s)
[285.258662] [089/144] (736s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[285.325672] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[285.328179] Starting dynamic subtest: pipe-A-eDP-1
[285.391584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s)
[285.413969] Starting dynamic subtest: pipe-B-eDP-1
[286.617643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[286.639356] Starting dynamic subtest: pipe-C-eDP-1
[287.824348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[287.843696] Starting dynamic subtest: pipe-D-eDP-1
[289.040279] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[289.043451] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.715s)
[290.267981] [090/144] (731s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[290.362324] Starting subtest: cursorA-vs-flipB-legacy
[290.367851] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[290.456728] [091/144] (731s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[290.515669] Starting subtest: etime-multi-wait-all-submitted-signaled
[290.621180] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[290.695186] [092/144] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[290.802395] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[290.807212] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[290.890355] [093/144] (730s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[293.484388] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[293.554358] [094/144] (728s left) gem_exec_reloc (basic-wc)
[293.627518] Subtest basic-wc: SKIP (0.000s)
[293.686539] [095/144] (728s left) gen9_exec_parse (bb-chained)
[293.761682] Subtest bb-chained: SKIP (0.000s)
[293.805375] [096/144] (728s left) gem_softpin (allocator-nopin)
[293.850521] Starting subtest: allocator-nopin
[293.916747] Subtest allocator-nopin: SUCCESS (0.071s)
[294.030819] [097/144] (727s left) intel_hwmon (hwmon-write)
[294.079826] Subtest hwmon-write: SKIP (0.000s)
[294.108791] [098/144] (727s left) gem_ctx_sseu (invalid-sseu)
[294.175618] Subtest invalid-sseu: SKIP (0.000s)
[294.215580] [099/144] (727s left) gem_exec_balancer (hog)
[294.271093] Starting subtest: hog
[294.275682] Subtest hog: SKIP (0.000s)
[294.526271] [100/144] (727s left) vc4/vc4_wait_bo (unused-bo-0ns)
[294.637917] Subtest unused-bo-0ns: SKIP (0.000s)
[294.691930] [101/144] (727s left) kms_legacy_colorkey (basic)
[294.745596] Starting subtest: basic
[294.748074] Starting dynamic subtest: pipe-A
[294.787290] Dynamic subtest pipe-A: SUCCESS (0.045s)
[294.798142] Starting dynamic subtest: pipe-B
[294.800689] Dynamic subtest pipe-B: SUCCESS (0.000s)
[294.818216] Starting dynamic subtest: pipe-C
[294.820276] Dynamic subtest pipe-C: SUCCESS (0.001s)
[294.831223] Starting dynamic subtest: pipe-D
[294.833271] Dynamic subtest pipe-D: SUCCESS (0.000s)
[294.835236] Subtest basic: SUCCESS (0.050s)
[294.853309] [102/144] (727s left) perf (sysctl-defaults)
[294.935460] Starting subtest: sysctl-defaults
[294.938316] Subtest sysctl-defaults: SUCCESS (0.000s)
[294.995811] [103/144] (727s left) gem_exec_schedule (pi-ringfull)
[295.181582] Starting subtest: pi-ringfull
[295.184203] Starting dynamic subtest: rcs0
[295.270301] Dynamic subtest rcs0: SUCCESS (0.091s)
[295.298503] Starting dynamic subtest: bcs0
[295.355440] Dynamic subtest bcs0: SUCCESS (0.083s)
[295.382052] Starting dynamic subtest: vcs0
[295.439072] Dynamic subtest vcs0: SUCCESS (0.082s)
[295.466712] Starting dynamic subtest: vcs1
[295.526216] Dynamic subtest vcs1: SUCCESS (0.085s)
[295.552522] Starting dynamic subtest: vecs0
[295.610366] Dynamic subtest vecs0: SUCCESS (0.083s)
[295.636887] Starting dynamic subtest: ccs0
[295.695466] Dynamic subtest ccs0: SUCCESS (0.083s)
[295.698630] Subtest pi-ringfull: SUCCESS (0.518s)
[295.917637] [104/144] (726s left) kms_pm_rpm (fences)
[297.622550] Starting subtest: fences
[297.628263] Subtest fences: SKIP (0.000s)
[298.213834] [105/144] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[298.282446] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[298.286279] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.355319] [106/144] (723s left) v3d/v3d_submit_cl (single-out-sync)
[298.433705] Subtest single-out-sync: SKIP (0.000s)
[298.475926] [107/144] (723s left) kms_cursor_legacy (forked-move)
[298.544374] Starting subtest: forked-move
[298.546703] Starting dynamic subtest: pipe-A
[304.074160] Dynamic subtest pipe-A: SUCCESS (5.526s)
[304.094212] Starting dynamic subtest: pipe-B
[309.653788] Dynamic subtest pipe-B: SUCCESS (5.578s)
[309.673826] Starting dynamic subtest: pipe-C
[315.224096] Dynamic subtest pipe-C: SUCCESS (5.568s)
[315.242322] Starting dynamic subtest: pipe-D
[320.787402] Dynamic subtest pipe-D: SUCCESS (5.560s)
[320.805843] Starting dynamic subtest: all-pipes
[326.360915] Dynamic subtest all-pipes: SUCCESS (5.571s)
[326.363989] Subtest forked-move: SUCCESS (27.813s)
[326.526350] [108/144] (695s left) dmabuf_sync_file (import-multiple-read-only)
[326.599041] Starting subtest: import-multiple-read-only
[326.604616] Subtest import-multiple-read-only: SUCCESS (0.008s)
[326.667889] [109/144] (695s left) gem_partial_pwrite_pread (reads-display)
[326.721840] Subtest reads-display: SKIP (0.000s)
[326.776181] [110/144] (695s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[326.857718] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[327.849806] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.992s)
[328.734736] [111/144] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[328.840351] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[328.844708] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[328.936270] [112/144] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[329.027498] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[329.032392] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[329.125328] [113/144] (693s left) prime_busy (before)
[329.185635] Starting subtest: before
[329.192803] Starting dynamic subtest: rcs0
[329.226950] Dynamic subtest rcs0: SUCCESS (0.033s)
[329.240705] Starting dynamic subtest: bcs0
[329.268788] Dynamic subtest bcs0: SUCCESS (0.040s)
[329.287247] Starting dynamic subtest: vcs0
[329.313704] Dynamic subtest vcs0: SUCCESS (0.040s)
[329.330934] Starting dynamic subtest: vcs1
[329.352513] Dynamic subtest vcs1: SUCCESS (0.040s)
[329.370821] Starting dynamic subtest: vecs0
[329.395078] Dynamic subtest vecs0: SUCCESS (0.041s)
[329.413931] Starting dynamic subtest: ccs0
[329.436332] Dynamic subtest ccs0: SUCCESS (0.040s)
[329.549063] Subtest before: SUCCESS (0.364s)
[329.615428] [114/144] (692s left) kms_cursor_crc (cursor-offscreen-512x512)
[329.786876] Starting subtest: cursor-offscreen-512x512
[329.791871] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[329.913967] [115/144] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[330.002898] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[334.568334] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (4.572s)
[334.681266] [116/144] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[334.767078] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[339.593610] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.830s)
[339.714691] [117/144] (682s left) kms_psr (fbc-pr-primary-blt)
[339.822342] Starting subtest: fbc-pr-primary-blt
[339.827179] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[339.922758] [118/144] (682s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[340.004187] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[341.214317] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (1.045s)
[341.243367] [119/144] (681s left) kms_feature_discovery (display-4x)
[341.328786] Starting subtest: display-4x
[341.333370] Subtest display-4x: SKIP (0.000s)
[341.395204] [120/144] (681s left) syncobj_timeline (invalid-transfer-bad-pad)
[341.451101] Starting subtest: invalid-transfer-bad-pad
[341.453104] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[341.509563] [121/144] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[341.568442] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[341.572857] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[341.657547] [122/144] (680s left) gem_exec_reloc (basic-write-read)
[341.729929] Subtest basic-write-read: SKIP (0.000s)
[341.786911] [123/144] (680s left) kms_psr2_sf (fbc-cursor-plane-move-continuous-exceed-fully-sf)
[347.005638] Starting subtest: fbc-cursor-plane-move-continuous-exceed-fully-sf
[347.008737] Starting dynamic subtest: pipe-A-eDP-1
[347.835438] Dynamic subtest pipe-A-eDP-1: SKIP (0.824s)
[347.852450] Starting dynamic subtest: pipe-B-eDP-1
[349.037146] Dynamic subtest pipe-B-eDP-1: SKIP (1.199s)
[349.042742] Subtest fbc-cursor-plane-move-continuous-exceed-fully-sf: SKIP (2.030s)
[350.301564] [124/144] (672s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[350.374590] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[350.378906] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[350.477621] [125/144] (672s left) kms_flip (flip-vs-expired-vblank-interruptible)
[350.548640] Starting subtest: flip-vs-expired-vblank-interruptible
[350.551068] Starting dynamic subtest: A-eDP1
[359.314321] Dynamic subtest A-eDP1: SUCCESS (8.763s)
[359.333938] Starting dynamic subtest: B-eDP1
[368.079584] Dynamic subtest B-eDP1: SUCCESS (8.762s)
[368.099350] Starting dynamic subtest: C-eDP1
[376.835898] Dynamic subtest C-eDP1: SUCCESS (8.755s)
[376.857207] Starting dynamic subtest: D-eDP1
[385.605313] Dynamic subtest D-eDP1: SUCCESS (8.768s)
[385.613494] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (35.065s)
[386.849666] [126/144] (635s left) kms_rotation_crc (sprite-rotation-180)
[386.937716] Starting subtest: sprite-rotation-180
[393.339788] Subtest sprite-rotation-180: SUCCESS (6.403s)
[394.657487] [127/144] (628s left) kms_psr (pr-cursor-mmap-cpu)
[394.745733] Starting subtest: pr-cursor-mmap-cpu
[394.750850] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[394.847196] [128/144] (627s left) kms_prop_blob (invalid-set-prop-any)
[394.888418] Starting subtest: invalid-set-prop-any
[394.890340] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[394.934065] [129/144] (627s left) kms_ccs (pipe-b-ccs-on-another-bo-yf-tiled-ccs)
[395.322505] Starting subtest: pipe-B-ccs-on-another-bo-yf-tiled-ccs
[395.328511] Subtest pipe-B-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[396.194276] [130/144] (626s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-ccs)
[396.610190] Starting subtest: pipe-D-bad-rotation-90-y-tiled-ccs
[396.616143] Subtest pipe-D-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[397.463012] [131/144] (625s left) gem_exec_create (legacy)
[397.520857] Starting subtest: legacy
[397.523775] Starting dynamic subtest: smem
[399.616943] Dynamic subtest smem: SUCCESS (2.095s)
[399.620230] Subtest legacy: SUCCESS (2.097s)
[399.803592] [132/144] (623s left) kms_lease (multimaster-lease)
[399.869839] Starting subtest: multimaster-lease
[399.872453] Subtest multimaster-lease: SUCCESS (0.001s)
[399.932125] [133/144] (622s left) api_intel_bb (object-reloc-keep-cache)
[399.991384] Starting subtest: object-reloc-keep-cache
[399.998991] Subtest object-reloc-keep-cache: SKIP (0.006s)
[400.091612] [134/144] (622s left) perf (create-destroy-userspace-config)
[400.201441] Starting subtest: create-destroy-userspace-config
[400.226082] Subtest create-destroy-userspace-config: SUCCESS (0.024s)
[400.255165] [135/144] (622s left) kms_psr (fbc-psr2-suspend)
[400.314518] Starting subtest: fbc-psr2-suspend
[400.316893] Starting dynamic subtest: eDP-1
[400.321621] Dynamic subtest eDP-1: SKIP (0.000s)
[400.326168] Subtest fbc-psr2-suspend: SKIP (0.001s)
[400.415989] [136/144] (622s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[400.513113] Starting subtest: basic-flip-after-cursor-legacy
[401.474105] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.961s)
[402.401643] [137/144] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[402.481968] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[402.486742] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[402.567974] [138/144] (620s left) kms_atomic_transition (modeset-transition-fencing)
[402.632797] Starting subtest: modeset-transition-fencing
[402.635103] Starting dynamic subtest: 1x-outputs
[414.709320] Dynamic subtest 1x-outputs: SUCCESS (12.076s)
[415.012510] Subtest modeset-transition-fencing: SUCCESS (12.378s)
[415.902760] [139/144] (607s left) kms_psr (psr2-cursor-plane-onoff)
[415.958689] Starting subtest: psr2-cursor-plane-onoff
[415.961110] Starting dynamic subtest: eDP-1
[417.738525] Dynamic subtest eDP-1: SUCCESS (1.781s)
[417.741228] Subtest psr2-cursor-plane-onoff: SUCCESS (1.783s)
[418.656764] [140/144] (604s left) prime_self_import (export-vs-gem_close-race)
[418.715384] Starting subtest: export-vs-gem_close-race
[423.750522] Subtest export-vs-gem_close-race: SUCCESS (5.040s)
[423.815763] [141/144] (599s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[423.921757] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[423.924262] Starting dynamic subtest: pipe-A-eDP-1
[423.991835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.072s)
[424.007618] Starting dynamic subtest: pipe-B-eDP-1
[425.243515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.247s)
[425.263931] Starting dynamic subtest: pipe-C-eDP-1
[426.446806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[426.465546] Starting dynamic subtest: pipe-D-eDP-1
[427.663078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[427.665557] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.746s)
[428.896282] [142/144] (594s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[429.305379] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[429.311218] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[430.142150] [143/144] (593s left) gem_partial_pwrite_pread (writes-after-reads-display)
[430.222298] Subtest writes-after-reads-display: SKIP (0.000s)
[430.283639] [144/144] (592s left) syncobj_basic (bad-fd-to-handle)
[430.348681] Starting subtest: bad-fd-to-handle
[430.351294] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[430.409008] Closing watchdogs
Done.