[58.216557] Initializing watchdogs
[58.216599]   /dev/watchdog0
[58.230185] [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]
[58.234853] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.237530] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.240836] [001/133] (960s left) perf (i915-ref-count)
[58.345075] Starting subtest: i915-ref-count
[58.406876] Subtest i915-ref-count: SUCCESS (0.060s)
[58.468977] [002/133] (960s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[58.573970] Starting subtest: fbc-pr-cursor-mmap-cpu
[58.577750] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[58.638742] [003/133] (960s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[58.777802] Starting subtest: cursor-rapid-movement-32x32
[58.826374] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[59.091524] [004/133] (959s left) gem_eio (in-flight-10ms)
[59.252378] Starting subtest: in-flight-10ms
[67.328624] Subtest in-flight-10ms: SUCCESS (8.104s)
[67.478883] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[67.481959] [005/133] (951s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[67.549762] Subtest untiled-to-tiled: SKIP (0.000s)
[67.628590] [006/133] (951s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[67.704358] Starting subtest: mixed-tiled-to-y-tiled-ccs
[67.708981] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[67.888948] [007/133] (951s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[68.003026] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[69.178513] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.179s)
[69.289954] [008/133] (949s left) perf_pmu (busy-idle)
[69.331062] Starting subtest: busy-idle
[69.332868] Starting dynamic subtest: rcs0
[70.020277] Dynamic subtest rcs0: SUCCESS (0.690s)
[70.033263] Starting dynamic subtest: bcs0
[70.681556] Dynamic subtest bcs0: SUCCESS (0.660s)
[70.692231] Starting dynamic subtest: vcs0
[72.317547] Dynamic subtest vcs0: SUCCESS (1.635s)
[72.328739] Starting dynamic subtest: vcs1
[74.300646] Dynamic subtest vcs1: SUCCESS (1.984s)
[74.312412] Starting dynamic subtest: vecs0
[76.284661] Dynamic subtest vecs0: SUCCESS (1.984s)
[76.295938] Starting dynamic subtest: ccs0
[76.951870] Dynamic subtest ccs0: SUCCESS (0.668s)
[76.954476] Subtest busy-idle: SUCCESS (7.629s)
[77.053947] [009/133] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[77.154360] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[83.873106] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.722s)
[84.027479] [010/133] (935s left) sw_sync (sync_merge_invalid)
[84.064731] Starting subtest: sync_merge_invalid
[84.090242] Subtest sync_merge_invalid: SUCCESS (0.025s)
[84.170938] [011/133] (934s left) kms_atomic (atomic-plane-damage)
[84.271968] Starting subtest: atomic-plane-damage
[84.316928] Starting dynamic subtest: pipe-A-eDP-1
[84.844149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s)
[84.846474] Subtest atomic-plane-damage: SUCCESS (0.573s)
[85.731340] [012/133] (933s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[85.831255] Starting subtest: psr-2p-pri-indfb-multidraw
[85.835513] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[85.916989] [013/133] (933s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[86.028888] Starting subtest: cursorA-vs-flipA-atomic-transitions
[97.182453] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.151s)
[98.053446] [014/133] (921s left) i915_pm_rpm (debugfs-read)
[99.593890] Starting subtest: debugfs-read
[100.752919] Subtest debugfs-read: SUCCESS (1.160s)
[101.144206] [015/133] (918s left) gem_flink_race (flink_close)
[101.178253] Starting subtest: flink_close
[106.288802] Subtest flink_close: SUCCESS (5.110s)
[106.366124] [016/133] (913s left) gem_exec_params (cliprects_ptr-dirt)
[106.433444] Starting subtest: cliprects_ptr-dirt
[106.435749] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[106.548067] [017/133] (912s left) kms_plane_scaling (intel-max-src-size)
[106.653088] Starting subtest: intel-max-src-size
[106.659767] Subtest intel-max-src-size: SKIP (0.000s)
[106.760888] [018/133] (912s left) kms_big_fb (linear-16bpp-rotate-90)
[106.863474] Starting subtest: linear-16bpp-rotate-90
[106.885477] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[107.001528] [019/133] (912s left) api_intel_bb (lot-of-buffers)
[107.061967] Starting subtest: lot-of-buffers
[108.108491] Subtest lot-of-buffers: SUCCESS (1.047s)
[108.513055] [020/133] (911s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[108.563300] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[108.565346] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[108.658113] [021/133] (910s left) sw_sync (sync_busy_fork_unixsocket)
[108.695071] Starting subtest: sync_busy_fork_unixsocket
[108.700383] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[108.765208] [022/133] (910s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[108.861730] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[108.866419] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[108.973068] [023/133] (910s left) kms_flip (plain-flip-ts-check)
[109.065165] Starting subtest: plain-flip-ts-check
[109.067060] Starting dynamic subtest: A-eDP1
[117.899738] Dynamic subtest A-eDP1: SUCCESS (8.836s)
[117.912461] Starting dynamic subtest: B-eDP1
[126.736167] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[126.750676] Starting dynamic subtest: C-eDP1
[135.560025] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[135.578177] Starting dynamic subtest: D-eDP1
[144.395925] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[144.398546] Subtest plain-flip-ts-check: SUCCESS (35.335s)
[145.584866] [024/133] (874s left) syncobj_eventfd (binary-wait-before-signal)
[145.642133] Starting subtest: binary-wait-before-signal
[145.671501] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[145.746298] [025/133] (874s left) perf (invalid-oa-metric-set-id)
[145.841487] Starting subtest: invalid-oa-metric-set-id
[145.850348] Subtest invalid-oa-metric-set-id: SUCCESS (0.007s)
[145.889812] [026/133] (873s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[146.005193] Starting subtest: psr-rgb101010-draw-mmap-gtt
[146.009461] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[146.110461] [027/133] (873s left) gem_tiled_swapping (non-threaded)
[146.169499] Subtest non-threaded: SKIP (0.000s)
[146.239676] [028/133] (873s left) gem_mmap (bad-size)
[146.292972] Subtest bad-size: SKIP (0.000s)
[146.354475] [029/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[146.459018] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[146.462907] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[146.570675] [030/133] (873s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[146.662310] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[146.664160] Starting dynamic subtest: A-eDP1
[150.210124] Dynamic subtest A-eDP1: SUCCESS (3.545s)
[150.219307] Starting dynamic subtest: B-eDP1
[153.422847] Dynamic subtest B-eDP1: SUCCESS (3.209s)
[153.432488] Starting dynamic subtest: C-eDP1
[156.520683] Dynamic subtest C-eDP1: SUCCESS (3.097s)
[156.529423] Starting dynamic subtest: D-eDP1
[159.622058] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[159.624353] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.960s)
[160.425995] [031/133] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[160.538047] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[160.542314] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[160.644918] [032/133] (859s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[160.741189] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[160.743479] Starting dynamic subtest: pipe-A-eDP-1
[160.800163] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[160.808396] Starting dynamic subtest: pipe-B-eDP-1
[160.865138] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[160.874278] Starting dynamic subtest: pipe-C-eDP-1
[160.928540] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[160.936626] Starting dynamic subtest: pipe-D-eDP-1
[160.990464] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[160.994693] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.012s)
[162.903304] [033/133] (857s left) gem_exec_schedule (submit-early-slice)
[162.978181] Starting subtest: submit-early-slice
[162.980513] Starting dynamic subtest: rcs0
[163.033731] Dynamic subtest rcs0: SUCCESS (0.054s)
[163.044928] Starting dynamic subtest: bcs0
[163.078047] Dynamic subtest bcs0: SUCCESS (0.044s)
[163.088020] Starting dynamic subtest: vcs0
[163.120230] Dynamic subtest vcs0: SUCCESS (0.042s)
[163.131491] Starting dynamic subtest: vcs1
[163.169919] Dynamic subtest vcs1: SUCCESS (0.049s)
[163.180689] Starting dynamic subtest: vecs0
[163.212408] Dynamic subtest vecs0: SUCCESS (0.042s)
[163.227058] Starting dynamic subtest: ccs0
[163.261515] Dynamic subtest ccs0: SUCCESS (0.048s)
[163.263899] Subtest submit-early-slice: SUCCESS (0.284s)
[164.404079] [034/133] (855s left) gem_wait (write-wait)
[164.459183] Starting subtest: write-wait
[164.461624] Starting dynamic subtest: all-engines
[165.580479] Dynamic subtest all-engines: SUCCESS (1.120s)
[165.594515] Starting dynamic subtest: rcs0
[166.645436] Dynamic subtest rcs0: SUCCESS (1.063s)
[166.661215] Starting dynamic subtest: bcs0
[167.704300] Dynamic subtest bcs0: SUCCESS (1.058s)
[167.723310] Starting dynamic subtest: vcs0
[168.760976] Dynamic subtest vcs0: SUCCESS (1.054s)
[168.777695] Starting dynamic subtest: vcs1
[169.814341] Dynamic subtest vcs1: SUCCESS (1.052s)
[169.830518] Starting dynamic subtest: vecs0
[170.867287] Dynamic subtest vecs0: SUCCESS (1.051s)
[170.882913] Starting dynamic subtest: ccs0
[171.923738] Dynamic subtest ccs0: SUCCESS (1.054s)
[171.926780] Subtest write-wait: SUCCESS (7.464s)
[172.121351] [035/133] (848s left) syncobj_basic (bad-flags-handle-to-fd)
[172.168511] Starting subtest: bad-flags-handle-to-fd
[172.170689] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[172.274074] [036/133] (847s left) kms_vblank (wait-busy)
[172.381775] Starting subtest: wait-busy
[172.384055] Starting dynamic subtest: pipe-A-eDP-1
[174.266216] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[174.281587] Starting dynamic subtest: pipe-D-eDP-1
[176.855656] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[176.858080] Subtest wait-busy: SUCCESS (4.475s)
[177.651194] [037/133] (842s left) gem_ctx_shared (q-independent)
[177.723827] Starting subtest: Q-independent
[177.726180] Starting dynamic subtest: rcs0
[177.790870] Dynamic subtest rcs0: SUCCESS (0.066s)
[177.800910] Starting dynamic subtest: vcs0
[177.833519] Dynamic subtest vcs0: SUCCESS (0.042s)
[177.845421] Starting dynamic subtest: vcs1
[177.880328] Dynamic subtest vcs1: SUCCESS (0.046s)
[177.889355] Starting dynamic subtest: vecs0
[177.920242] Dynamic subtest vecs0: SUCCESS (0.039s)
[177.932769] Starting dynamic subtest: ccs0
[177.976732] Dynamic subtest ccs0: SUCCESS (0.055s)
[177.979380] Subtest Q-independent: SUCCESS (0.252s)
[179.336181] [038/133] (840s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[179.426244] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[179.528768] [039/133] (840s left) kms_scaling_modes (scaling-mode-full)
[179.632150] Starting subtest: scaling-mode-full
[179.634455] Starting dynamic subtest: pipe-A-eDP-1
[179.724431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[179.737049] Starting dynamic subtest: pipe-B-eDP-1
[180.883049] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[180.892601] Starting dynamic subtest: pipe-C-eDP-1
[182.002567] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[182.011687] Starting dynamic subtest: pipe-D-eDP-1
[183.144446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[183.146666] Subtest scaling-mode-full: SUCCESS (3.516s)
[184.404800] [040/133] (835s left) i915_getparams_basic (basic-subslice-total)
[184.461677] Starting subtest: basic-subslice-total
[184.465911] Subtest basic-subslice-total: SUCCESS (0.000s)
[184.551993] [041/133] (835s left) kms_addfb_basic (tile-pitch-mismatch)
[184.607110] Starting subtest: tile-pitch-mismatch
[184.611272] Subtest tile-pitch-mismatch: SKIP (0.000s)
[184.734214] [042/133] (835s left) gen9_exec_parse (secure-batches)
[184.785341] Subtest secure-batches: SKIP (0.000s)
[184.860452] [043/133] (835s left) gem_exec_reloc (basic-cpu-read-active)
[184.920509] Subtest basic-cpu-read-active: SKIP (0.000s)
[184.993585] [044/133] (835s left) kms_color (ctm-negative)
[185.083829] Starting subtest: ctm-negative
[185.086041] Starting dynamic subtest: pipe-A-eDP-1
[185.810472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[185.820426] Starting dynamic subtest: pipe-B-eDP-1
[187.213634] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[187.224915] Starting dynamic subtest: pipe-C-eDP-1
[188.571056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[188.580772] Starting dynamic subtest: pipe-D-eDP-1
[189.908906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[189.911092] Subtest ctm-negative: SUCCESS (4.826s)
[190.708331] [045/133] (829s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[190.812192] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[190.814473] Starting dynamic subtest: pipe-A-eDP-1
[190.895629] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[190.904798] Starting dynamic subtest: pipe-B-eDP-1
[191.989115] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[191.993821] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.180s)
[193.174441] [046/133] (827s left) kms_hdr (static-toggle-dpms)
[193.263862] Starting subtest: static-toggle-dpms
[193.269862] Subtest static-toggle-dpms: SKIP (0.000s)
[193.349791] [047/133] (827s left) i915_drm_fdinfo (virtual-busy-all)
[193.389475] Starting subtest: virtual-busy-all
[193.393670] Subtest virtual-busy-all: SKIP (0.000s)
[193.460830] [048/133] (827s left) gem_barrier_race (remote-request)
[193.522884] Starting subtest: remote-request
[193.525040] Starting dynamic subtest: rcs0
[198.684666] Dynamic subtest rcs0: SUCCESS (5.161s)
[198.686872] Subtest remote-request: SUCCESS (5.162s)
[198.823485] [049/133] (821s left) kms_psr (fbc-pr-primary-render)
[198.928107] Starting subtest: fbc-pr-primary-render
[198.931801] Subtest fbc-pr-primary-render: SKIP (0.000s)
[199.005028] [050/133] (821s left) gem_ctx_engines (invalid-engines)
[199.061019] Starting subtest: invalid-engines
[199.070075] Subtest invalid-engines: SUCCESS (0.008s)
[199.291170] [051/133] (821s left) kms_pm_rpm (basic-rte)
[199.331313] Starting subtest: basic-rte
[202.883731] Subtest basic-rte: SUCCESS (3.554s)
[204.394869] [052/133] (816s left) perf (global-sseu-config-invalid)
[204.482431] Starting subtest: global-sseu-config-invalid
[204.486938] Subtest global-sseu-config-invalid: SKIP (0.000s)
[204.528225] [053/133] (816s left) kms_draw_crc (draw-method-blt)
[204.603172] Starting subtest: draw-method-blt
[204.605078] Starting dynamic subtest: xrgb8888-untiled
[204.812112] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[204.825249] Starting dynamic subtest: rgb565-untiled
[205.035664] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[205.044581] Starting dynamic subtest: xrgb2101010-untiled
[205.235515] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.197s)
[205.244755] Starting dynamic subtest: xbgr16161616f-untiled
[205.456585] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[205.465553] Starting dynamic subtest: xrgb8888-xtiled
[205.577980] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[205.587404] Starting dynamic subtest: rgb565-xtiled
[205.700851] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[205.709191] Starting dynamic subtest: xrgb2101010-xtiled
[205.811690] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[205.820177] Starting dynamic subtest: xbgr16161616f-xtiled
[205.922600] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[205.931209] Starting dynamic subtest: xrgb8888-4tiled
[206.033679] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[206.041884] Starting dynamic subtest: rgb565-4tiled
[206.145080] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[206.154523] Starting dynamic subtest: xrgb2101010-4tiled
[206.245079] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[206.253419] Starting dynamic subtest: xbgr16161616f-4tiled
[206.344916] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[206.347135] Subtest draw-method-blt: SUCCESS (1.744s)
[206.498870] [054/133] (814s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[206.880454] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[207.700883] [055/133] (813s left) kms_pm_rpm (modeset-pc8-residency-stress)
[209.439401] Starting subtest: modeset-pc8-residency-stress
[209.444646] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[209.964594] [056/133] (811s left) gem_eio (execbuf)
[210.205602] Starting subtest: execbuf
[210.545291] Subtest execbuf: SUCCESS (0.339s)
[210.709734] [057/133] (810s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[210.809563] Starting subtest: psr-farfromfence-mmap-gtt
[210.813711] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[210.906119] [058/133] (810s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[211.032337] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[211.180884] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.151s)
[211.298908] [059/133] (809s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[211.396366] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[211.398234] Starting dynamic subtest: pipe-A-eDP-1
[211.416365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.425528] Starting dynamic subtest: pipe-B-eDP-1
[211.442885] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.450914] Starting dynamic subtest: pipe-C-eDP-1
[211.467927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.476979] Starting dynamic subtest: pipe-D-eDP-1
[211.494126] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.497340] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[213.735190] [060/133] (807s left) kms_lease (lease-again)
[213.828877] Starting subtest: lease-again
[213.831132] Starting dynamic subtest: pipe-A-eDP-1
[213.836544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[213.849870] Starting dynamic subtest: pipe-B-eDP-1
[213.852898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.005s)
[213.864323] Starting dynamic subtest: pipe-C-eDP-1
[213.866611] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[213.875595] Starting dynamic subtest: pipe-D-eDP-1
[213.877769] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[213.879945] Subtest lease-again: SUCCESS (0.027s)
[213.967811] [061/133] (807s left) i915_pm_rps (thresholds-idle-park)
[214.041211] Starting subtest: thresholds-idle-park
[214.045636] Subtest thresholds-idle-park: SKIP (0.001s)
[214.150852] [062/133] (807s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[214.280313] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[215.228196] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.948s)
[216.061136] [063/133] (805s left) kms_chamelium_edid (vga-edid-read)
[216.444768] Subtest vga-edid-read: SKIP (0.000s)
[217.279783] [064/133] (804s left) syncobj_basic (bad-flags-fd-to-handle)
[217.342767] Starting subtest: bad-flags-fd-to-handle
[217.345097] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[217.441412] [065/133] (803s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[217.530240] Starting subtest: primary-y-tiled-reflect-x-90
[217.534200] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[217.601872] [066/133] (803s left) gem_exec_schedule (noreorder-priority)
[217.782727] Starting subtest: noreorder-priority
[217.785108] Starting dynamic subtest: rcs0
[218.912822] Dynamic subtest rcs0: SUCCESS (1.130s)
[218.924977] Starting dynamic subtest: vcs0
[220.278445] Dynamic subtest vcs0: SUCCESS (1.363s)
[220.292576] Starting dynamic subtest: vcs1
[222.260369] Dynamic subtest vcs1: SUCCESS (1.980s)
[222.275171] Starting dynamic subtest: vecs0
[224.307072] Dynamic subtest vecs0: SUCCESS (2.044s)
[224.319224] Starting dynamic subtest: ccs0
[225.445609] Dynamic subtest ccs0: SUCCESS (1.137s)
[225.448096] Subtest noreorder-priority: SUCCESS (7.664s)
[225.632657] [067/133] (795s left) syncobj_timeline (etime-single-wait-all-submitted)
[225.687479] Starting subtest: etime-single-wait-all-submitted
[225.793300] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[225.870361] [068/133] (795s left) gem_mmap_offset (oob-read)
[225.923035] Starting subtest: oob-read
[225.925402] Subtest oob-read: SUCCESS (0.001s)
[226.021188] [069/133] (795s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[226.139813] Starting subtest: cursorA-vs-flipB-atomic-transitions
[226.144148] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[226.283637] [070/133] (795s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[226.381044] Starting subtest: y-tiled-16bpp-rotate-90
[226.385568] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[226.464272] [071/133] (795s left) kms_psr (psr2-sprite-mmap-gtt)
[226.551160] Starting subtest: psr2-sprite-mmap-gtt
[226.553450] Starting dynamic subtest: eDP-1
[228.001393] Dynamic subtest eDP-1: SKIP (1.448s)
[228.006574] Subtest psr2-sprite-mmap-gtt: SKIP (1.450s)
[228.164305] [072/133] (793s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[228.695743] Starting subtest: syncobj-stationary-timeline-chain-engines
[228.819575] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.123s)
[230.371573] [073/133] (791s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[230.473760] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[230.478079] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[230.554131] [074/133] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[230.659385] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[230.663661] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[230.793308] [075/133] (791s left) gem_softpin (safe-alignment)
[230.859797] Starting subtest: safe-alignment
[230.887238] Subtest safe-alignment: SUCCESS (0.027s)
[232.291072] [076/133] (789s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[232.389115] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[232.393142] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[232.460537] [077/133] (789s left) gem_exec_schedule (fairslice-all)
[232.550687] Starting subtest: fairslice-all
[234.602447] Subtest fairslice-all: SUCCESS (2.063s)
[234.917987] [078/133] (787s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[235.031218] Starting subtest: fbcpsr-rgb101010-draw-blt
[241.783068] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.754s)
[241.898399] [079/133] (780s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[241.990981] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[241.995070] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[242.092325] [080/133] (779s left) api_intel_allocator (reopen)
[242.154453] Starting subtest: reopen
[242.159624] Subtest reopen: SUCCESS (0.004s)
[242.286107] [081/133] (779s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[242.381115] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[242.385130] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[242.486264] [082/133] (779s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[242.573826] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[242.575677] Starting dynamic subtest: pipe-A-eDP-1
[242.595478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[242.605296] Starting dynamic subtest: pipe-B-eDP-1
[242.624683] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[242.634351] Starting dynamic subtest: pipe-C-eDP-1
[242.653829] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s)
[242.669562] Starting dynamic subtest: pipe-D-eDP-1
[242.690717] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[242.693079] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[244.911243] [083/133] (777s left) kms_psr (pr-primary-render)
[245.024190] Starting subtest: pr-primary-render
[245.028612] Subtest pr-primary-render: SKIP (0.000s)
[245.110543] [084/133] (777s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[245.216053] Starting subtest: plane-upscale-20x20-with-pixel-format
[245.218278] Starting dynamic subtest: pipe-A
[246.262960] Dynamic subtest pipe-A: SUCCESS (1.049s)
[246.271996] Starting dynamic subtest: pipe-B
[248.431271] Dynamic subtest pipe-B: SUCCESS (2.167s)
[248.439789] Starting dynamic subtest: pipe-C
[249.614161] Dynamic subtest pipe-C: SUCCESS (1.181s)
[249.629623] Starting dynamic subtest: pipe-D
[250.757333] Dynamic subtest pipe-D: SUCCESS (1.143s)
[250.759599] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.544s)
[251.964142] [085/133] (770s left) sysfs_heartbeat_interval (nopreempt)
[252.021369] Starting subtest: nopreempt
[252.023641] Starting dynamic subtest: vecs0
[261.306068] Dynamic subtest vecs0: SUCCESS (9.280s)
[261.318273] Starting dynamic subtest: ccs0
[265.300079] Dynamic subtest ccs0: SUCCESS (3.995s)
[265.310954] Starting dynamic subtest: vcs0
[275.257742] Dynamic subtest vcs0: SUCCESS (9.952s)
[275.269800] Starting dynamic subtest: bcs0
[279.147984] Dynamic subtest bcs0: SUCCESS (3.891s)
[279.161828] Starting dynamic subtest: rcs0
[283.148972] Dynamic subtest rcs0: SUCCESS (3.999s)
[283.161586] Starting dynamic subtest: vcs1
[292.278107] Dynamic subtest vcs1: SUCCESS (9.125s)
[292.280658] Subtest nopreempt: SUCCESS (40.254s)
[292.353423] [086/133] (729s left) gem_eio (wait-wedge-1us)
[292.549925] Starting subtest: wait-wedge-1us
[294.339227] Subtest wait-wedge-1us: SUCCESS (1.788s)
[294.512422] [087/133] (727s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[294.618734] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[299.520154] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.905s)
[300.664274] [088/133] (721s left) gem_exec_balancer (bonded-false-hang)
[300.912759] Starting subtest: bonded-false-hang
[300.917025] Subtest bonded-false-hang: SKIP (0.000s)
[301.025618] [089/133] (721s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[301.126428] Starting subtest: x-tiled-8bpp-rotate-0
[302.363441] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.239s)
[302.497515] [090/133] (720s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[302.596701] Starting subtest: fbc-rgb565-draw-blt
[306.708376] Subtest fbc-rgb565-draw-blt: SUCCESS (4.115s)
[307.872754] [091/133] (714s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[307.972215] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[307.974523] Starting dynamic subtest: pipe-A-eDP-1
[307.983442] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.997173] Starting dynamic subtest: pipe-B-eDP-1
[308.005547] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.019020] Starting dynamic subtest: pipe-C-eDP-1
[308.027215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.035969] Starting dynamic subtest: pipe-D-eDP-1
[308.044287] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.048352] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[310.137677] [092/133] (712s left) prime_mmap (test_forked_cpu_write)
[310.187413] Starting subtest: test_forked_cpu_write
[310.189601] Starting dynamic subtest: test_forked_cpu_write-smem
[310.194512] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[310.196793] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[310.286056] [093/133] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[310.376431] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[310.380867] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[310.474675] [094/133] (712s left) kms_cursor_legacy (forked-move)
[310.586299] Starting subtest: forked-move
[310.588457] Starting dynamic subtest: pipe-A
[316.103034] Dynamic subtest pipe-A: SUCCESS (5.513s)
[316.121304] Starting dynamic subtest: pipe-B
[321.577793] Dynamic subtest pipe-B: SUCCESS (5.472s)
[321.589426] Starting dynamic subtest: pipe-C
[327.061514] Dynamic subtest pipe-C: SUCCESS (5.481s)
[327.075854] Starting dynamic subtest: pipe-D
[332.571920] Dynamic subtest pipe-D: SUCCESS (5.507s)
[332.584089] Starting dynamic subtest: all-pipes
[338.062830] Dynamic subtest all-pipes: SUCCESS (5.489s)
[338.065316] Subtest forked-move: SUCCESS (27.474s)
[338.204087] [095/133] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[338.307218] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[360.550710] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.246s)
[360.687836] [096/133] (662s left) gem_pread (display)
[360.752899] Subtest display: SKIP (0.000s)
[360.812720] [097/133] (662s left) gem_exec_whisper (basic-fds-forked)
[360.880792] Starting subtest: basic-fds-forked
[385.515982] Subtest basic-fds-forked: SUCCESS (24.629s)
[385.704325] [098/133] (637s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[385.803837] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[385.832701] Starting dynamic subtest: pipe-A-plane-0
[386.133986] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[386.143903] Starting dynamic subtest: pipe-A-plane-3
[386.366055] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[386.376364] Starting dynamic subtest: pipe-A-plane-5
[386.381060] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[387.434969] Starting dynamic subtest: pipe-B-plane-0
[387.722653] Dynamic subtest pipe-B-plane-0: SUCCESS (0.299s)
[387.732057] Starting dynamic subtest: pipe-B-plane-3
[387.954740] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[387.966983] Starting dynamic subtest: pipe-B-plane-5
[387.971465] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[388.275608] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.472s)
[389.112216] [099/133] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[389.205280] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[393.680376] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.479s)
[394.806872] [100/133] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[394.895468] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[401.942626] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.050s)
[402.054776] [101/133] (620s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[402.146786] Starting subtest: read-crc-frame-sequence
[402.149020] Starting dynamic subtest: pipe-A-eDP-1
[402.847403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[402.858195] Starting dynamic subtest: pipe-B-eDP-1
[404.196237] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[404.207187] Starting dynamic subtest: pipe-C-eDP-1
[405.484310] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[405.495233] Starting dynamic subtest: pipe-D-eDP-1
[406.827170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[406.829499] Subtest read-crc-frame-sequence: SUCCESS (4.680s)
[407.665328] [102/133] (615s left) kms_scaling_modes (scaling-mode-none)
[407.767272] Starting subtest: scaling-mode-none
[407.769583] Starting dynamic subtest: pipe-A-eDP-1
[407.863283] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[407.875186] Starting dynamic subtest: pipe-B-eDP-1
[407.899867] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[407.909650] Starting dynamic subtest: pipe-C-eDP-1
[407.932609] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[407.942345] Starting dynamic subtest: pipe-D-eDP-1
[407.966689] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[407.971164] Subtest scaling-mode-none: SKIP (0.198s)
[408.095309] [103/133] (614s left) prime_vgem (basic-read)
[408.174813] Starting subtest: basic-read
[408.201148] Subtest basic-read: SKIP (0.024s)
[408.335213] [104/133] (614s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[408.458486] Starting subtest: 2x-long-flip-vs-cursor-legacy
[408.462743] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[408.614000] [105/133] (614s left) kms_flip (flip-vs-panning-vs-hang)
[408.709052] Starting subtest: flip-vs-panning-vs-hang
[408.711133] Starting dynamic subtest: A-eDP1
[459.752516] Dynamic subtest A-eDP1: SUCCESS (51.041s)
[459.762411] Starting dynamic subtest: D-eDP1
[499.814721] Dynamic subtest D-eDP1: SUCCESS (40.059s)
[499.817256] Subtest flip-vs-panning-vs-hang: SUCCESS (91.106s)
[500.957357] [106/133] (522s left) i915_query (query-topology-unsupported)
[501.007107] Starting subtest: query-topology-unsupported
[501.010864] Subtest query-topology-unsupported: SKIP (0.000s)
[501.102552] [107/133] (522s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[501.150606] Starting subtest: multi-wait-for-submit-available-signaled
[501.152848] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[501.239448] [108/133] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[501.330853] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[505.948541] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.621s)
[507.081335] [109/133] (516s left) gem_ctx_persistence (engines-hostile)
[507.149554] Starting subtest: engines-hostile
[507.151833] Starting dynamic subtest: rcs0
[507.239092] Dynamic subtest rcs0: SUCCESS (0.088s)
[507.251118] Starting dynamic subtest: bcs0
[507.343370] Dynamic subtest bcs0: SUCCESS (0.103s)
[507.357504] Starting dynamic subtest: vcs0
[507.444605] Dynamic subtest vcs0: SUCCESS (0.098s)
[507.455590] Starting dynamic subtest: vcs1
[507.539573] Dynamic subtest vcs1: SUCCESS (0.093s)
[507.551034] Starting dynamic subtest: vecs0
[507.652574] Dynamic subtest vecs0: SUCCESS (0.111s)
[507.667689] Starting dynamic subtest: ccs0
[507.758903] Dynamic subtest ccs0: SUCCESS (0.103s)
[507.761608] Subtest engines-hostile: SUCCESS (0.610s)
[507.850068] [110/133] (515s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[507.957524] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[507.961653] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[508.027685] [111/133] (515s left) gem_ctx_persistence (legacy-engines-mixed)
[508.085062] Starting subtest: legacy-engines-mixed
[508.086952] Starting dynamic subtest: render
[508.179447] Dynamic subtest render: SUCCESS (0.094s)
[508.193240] Starting dynamic subtest: bsd1
[508.234882] Dynamic subtest bsd1: SUCCESS (0.052s)
[508.245807] Starting dynamic subtest: bsd2
[508.284626] Dynamic subtest bsd2: SUCCESS (0.047s)
[508.295714] Starting dynamic subtest: blt
[508.329804] Dynamic subtest blt: SUCCESS (0.043s)
[508.340505] Starting dynamic subtest: vebox
[508.377543] Dynamic subtest vebox: SUCCESS (0.046s)
[508.379913] Subtest legacy-engines-mixed: SUCCESS (0.293s)
[508.457654] [112/133] (514s left) kms_content_protection (srm)
[508.602267] Starting subtest: srm
[508.608806] Subtest srm: SKIP (0.002s)
[508.727334] [113/133] (514s left) gem_exec_fence (basic-busy)
[508.907059] Starting subtest: basic-busy
[508.909807] Starting dynamic subtest: rcs0
[508.978926] Dynamic subtest rcs0: SUCCESS (0.072s)
[508.991250] Starting dynamic subtest: bcs0
[509.032692] Dynamic subtest bcs0: SUCCESS (0.051s)
[509.044530] Starting dynamic subtest: vcs0
[509.082557] Dynamic subtest vcs0: SUCCESS (0.048s)
[509.094678] Starting dynamic subtest: vcs1
[509.140606] Dynamic subtest vcs1: SUCCESS (0.056s)
[509.151780] Starting dynamic subtest: vecs0
[509.199156] Dynamic subtest vecs0: SUCCESS (0.056s)
[509.210461] Starting dynamic subtest: ccs0
[509.255034] Dynamic subtest ccs0: SUCCESS (0.053s)
[509.257923] Subtest basic-busy: SUCCESS (0.350s)
[511.377932] [114/133] (512s left) syncobj_timeline (signal)
[511.434645] Starting subtest: signal
[511.436990] Subtest signal: SUCCESS (0.000s)
[511.544632] [115/133] (512s left) dmabuf_sync_file (import-multiple-read-only)
[511.585489] Starting subtest: import-multiple-read-only
[511.587970] Subtest import-multiple-read-only: SUCCESS (0.003s)
[511.646355] [116/133] (511s left) gem_render_copy (y-tiled-ccs-to-linear)
[511.700985] Starting subtest: y-tiled-ccs-to-linear
[511.705356] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[511.889090] [117/133] (511s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[511.982029] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[511.992852] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[512.073222] [118/133] (511s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[512.190739] Starting subtest: cursor-vs-flip-legacy
[541.945930] Subtest cursor-vs-flip-legacy: SUCCESS (29.753s)
[542.809569] [119/133] (480s left) syncobj_basic (bad-handle-to-fd)
[542.861879] Starting subtest: bad-handle-to-fd
[542.863740] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[542.964106] [120/133] (480s left) prime_vgem (busy)
[543.052756] Starting subtest: busy
[543.054900] Starting dynamic subtest: rcs0
[543.093566] Dynamic subtest rcs0: SUCCESS (0.041s)
[543.103121] Starting dynamic subtest: bcs0
[543.137770] Dynamic subtest bcs0: SUCCESS (0.043s)
[543.147308] Starting dynamic subtest: vcs0
[543.184802] Dynamic subtest vcs0: SUCCESS (0.046s)
[543.193810] Starting dynamic subtest: vcs1
[543.232792] Dynamic subtest vcs1: SUCCESS (0.047s)
[543.242204] Starting dynamic subtest: vecs0
[543.277628] Dynamic subtest vecs0: SUCCESS (0.044s)
[543.287038] Starting dynamic subtest: ccs0
[543.325784] Dynamic subtest ccs0: SUCCESS (0.047s)
[543.328061] Subtest busy: SUCCESS (0.274s)
[543.444889] [121/133] (480s left) kms_cursor_crc (cursor-dpms)
[543.580672] Starting subtest: cursor-dpms
[543.582510] Starting dynamic subtest: pipe-A-eDP-1
[546.665248] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.085s)
[546.675550] Starting dynamic subtest: pipe-D-eDP-1
[550.262214] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.592s)
[550.264237] Subtest cursor-dpms: SUCCESS (6.680s)
[551.100877] [122/133] (472s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[551.206415] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[557.735295] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.532s)
[557.857437] [123/133] (466s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[557.982713] Starting subtest: 2x-cursor-vs-flip-legacy
[557.987290] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[558.124339] [124/133] (465s left) kms_chamelium_color (ctm-negative)
[558.212057] Subtest ctm-negative: SKIP (0.000s)
[558.258373] [125/133] (465s left) gem_lmem_swapping (parallel-random)
[558.301510] Subtest parallel-random: SKIP (0.000s)
[558.344978] [126/133] (465s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[558.429929] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[558.432156] Starting dynamic subtest: pipe-A-default-mode
[559.571780] Dynamic subtest pipe-A-default-mode: SKIP (1.141s)
[559.575904] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.142s)
[559.722590] [127/133] (464s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[559.779282] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[559.783522] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[559.974145] [128/133] (464s left) kms_fbcon_fbt (fbc)
[560.022653] Starting subtest: fbc
[566.416328] Subtest fbc: SUCCESS (6.392s)
[567.495858] [129/133] (456s left) kms_psr (fbc-psr-cursor-blt)
[567.586744] Starting subtest: fbc-psr-cursor-blt
[567.589096] Starting dynamic subtest: eDP-1
[567.593162] Dynamic subtest eDP-1: SKIP (0.000s)
[567.597249] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[567.660109] [130/133] (456s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[567.751377] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[567.755429] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[567.879175] [131/133] (456s left) kms_cursor_legacy (forked-bo)
[568.013314] Starting subtest: forked-bo
[568.015222] Starting dynamic subtest: pipe-A
[573.474468] Dynamic subtest pipe-A: SUCCESS (5.458s)
[573.489718] Starting dynamic subtest: pipe-B
[578.957449] Dynamic subtest pipe-B: SUCCESS (5.479s)
[578.978898] Starting dynamic subtest: pipe-C
[584.422019] Dynamic subtest pipe-C: SUCCESS (5.462s)
[584.435561] Starting dynamic subtest: pipe-D
[589.889413] Dynamic subtest pipe-D: SUCCESS (5.464s)
[589.901721] Starting dynamic subtest: all-pipes
[595.385054] Dynamic subtest all-pipes: SUCCESS (5.494s)
[595.387334] Subtest forked-bo: SUCCESS (27.369s)
[595.547991] [132/133] (428s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[595.651662] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[596.630643] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.979s)
[596.747495] [133/133] (427s left) kms_busy (extended-pageflip-hang-oldfb)
[596.838207] Starting subtest: extended-pageflip-hang-oldfb
[596.840478] Starting dynamic subtest: pipe-A
[597.237485] Dynamic subtest pipe-A: SUCCESS (0.398s)
[597.246854] Starting dynamic subtest: pipe-D
[598.317598] Dynamic subtest pipe-D: SUCCESS (1.075s)
[598.319825] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.478s)
[599.161579] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: gem_set_tiling_vs_blt
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_atomic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: i915_pm_rpm
results: parsing output: 14/ for test: gem_flink_race
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: syncobj_eventfd
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_tiled_swapping
results: parsing output: 27/ for test: gem_mmap
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: gem_wait
results: parsing output: 34/ for test: syncobj_basic
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: gem_ctx_shared
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_scaling_modes
results: parsing output: 39/ for test: i915_getparams_basic
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_hdr
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: gem_barrier_race
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_ctx_engines
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_draw_crc
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: i915_pm_rps
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_chamelium_edid
results: parsing output: 63/ for test: syncobj_basic
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_mmap_offset
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: sysfs_heartbeat_interval
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: prime_mmap
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pread
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: kms_scaling_modes
results: parsing output: 102/ for test: prime_vgem
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: gem_lmem_swapping
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_fbcon_fbt
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_busy
Done.