[46.588665] Initializing watchdogs
[46.588904]   /dev/watchdog0
[46.621565] [001/141] (960s left) gen7_exec_parse (basic-offset)
[46.977560] Subtest basic-offset: SKIP (0.000s)
[47.065427] [002/141] (960s left) kms_plane_multiple (tiling-x)
[47.448641] Starting subtest: tiling-x
[47.469412] Starting dynamic subtest: pipe-A-DP-1
[49.400070] Dynamic subtest pipe-A-DP-1: SUCCESS (1.966s)
[49.433352] Starting dynamic subtest: pipe-B-DP-1
[51.541338] Dynamic subtest pipe-B-DP-1: SUCCESS (2.129s)
[51.573606] Starting dynamic subtest: pipe-C-DP-1
[53.742938] Dynamic subtest pipe-C-DP-1: SUCCESS (2.205s)
[53.763994] Subtest tiling-x: SUCCESS (6.306s)
[54.149626] [003/141] (953s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[54.667353] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[54.706183] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[55.261268] [004/141] (952s left) kms_addfb_basic (bo-too-small)
[55.621375] Starting subtest: bo-too-small
[55.639573] Subtest bo-too-small: SUCCESS (0.001s)
[55.765291] [005/141] (951s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[56.428858] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs
[56.465445] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[56.842532] [006/141] (950s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[57.310939] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[57.347995] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.451444] [007/141] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[57.914262] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[57.951705] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[58.069146] [008/141] (949s left) gem_exec_reloc (basic-gtt-read-active)
[58.393912] Starting subtest: basic-gtt-read-active
[58.523977] Subtest basic-gtt-read-active: SUCCESS (0.145s)
[58.748042] [009/141] (949s left) gem_exec_reloc (basic-gtt-read-noreloc)
[59.042034] Starting subtest: basic-gtt-read-noreloc
[59.060478] Subtest basic-gtt-read-noreloc: SUCCESS (0.012s)
[59.245843] [010/141] (948s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[59.808403] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[59.848675] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[60.332050] [011/141] (947s left) kms_rotation_crc (bad-tiling)
[60.714648] Starting subtest: bad-tiling
[65.189982] Subtest bad-tiling: SUCCESS (4.490s)
[65.627356] [012/141] (942s left) kms_lease (lease_get)
[66.017350] Starting subtest: lease_get
[66.037074] Starting dynamic subtest: pipe-A-DP-1
[66.055480] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s)
[66.086547] Starting dynamic subtest: pipe-B-DP-1
[66.104639] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[66.136115] Starting dynamic subtest: pipe-C-DP-1
[66.157275] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[66.178479] Subtest lease_get: SUCCESS (0.014s)
[66.281326] [013/141] (941s left) gem_ctx_isolation (preservation)
[66.579408] Starting subtest: preservation
[66.598102] Starting dynamic subtest: rcs0
[67.738664] Dynamic subtest rcs0: SUCCESS (1.170s)
[67.773467] Starting dynamic subtest: bcs0
[69.193512] Dynamic subtest bcs0: SUCCESS (1.451s)
[69.227327] Starting dynamic subtest: vcs0
[70.267475] Dynamic subtest vcs0: SUCCESS (1.076s)
[70.298462] Starting dynamic subtest: vecs0
[71.336474] Dynamic subtest vecs0: SUCCESS (1.067s)
[71.357446] Subtest preservation: SUCCESS (4.768s)
[71.609925] [014/141] (936s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[72.037761] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[72.074078] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[72.181510] [015/141] (936s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[72.539397] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[74.915646] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.375s)
[75.440167] [016/141] (933s left) gem_userptr_blits (unsync-unmap-after-close)
[75.809493] Subtest unsync-unmap-after-close: SKIP (0.000s)
[75.926087] [017/141] (932s left) gen3_render_mixed_blits
[76.331179] [018/141] (932s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[76.747262] Starting subtest: yf-tiled-32bpp-rotate-90
[81.958845] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (5.249s)
[82.546578] [019/141] (926s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[82.999209] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[83.053255] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[83.184975] [020/141] (925s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[84.152702] Starting subtest: syncobj-backward-timeline-chain-engines
[84.287809] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.131s)
[84.557095] [021/141] (924s left) gem_mmap_gtt (coherency)
[84.853166] Starting subtest: coherency
[84.890038] Subtest coherency: SKIP (0.000s)
[84.994840] [022/141] (924s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[85.425904] Starting subtest: fbc-rgb565-draw-pwrite
[87.690263] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.338s)
[87.858764] [023/141] (921s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[88.152356] Starting subtest: yf-tiled-to-vebox-yf-tiled
[88.192723] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[88.398864] [024/141] (920s left) kms_flip (bo-too-big-interruptible)
[88.780588] Starting subtest: bo-too-big-interruptible
[88.798898] Starting dynamic subtest: A-DP1
[91.860408] Dynamic subtest A-DP1: SUCCESS (2.922s)
[91.896172] Starting dynamic subtest: B-DP1
[94.736112] Dynamic subtest B-DP1: SUCCESS (2.874s)
[94.770346] Starting dynamic subtest: C-DP1
[97.591404] Dynamic subtest C-DP1: SUCCESS (2.857s)
[97.612498] Subtest bo-too-big-interruptible: SUCCESS (8.663s)
[98.070608] [025/141] (911s left) perf_pmu (semaphore-busy)
[98.369821] Starting subtest: semaphore-busy
[98.390682] Starting dynamic subtest: rcs0
[99.929837] Dynamic subtest rcs0: SUCCESS (1.563s)
[99.964850] Starting dynamic subtest: bcs0
[101.490251] Dynamic subtest bcs0: SUCCESS (1.559s)
[101.526090] Starting dynamic subtest: vcs0
[103.048924] Dynamic subtest vcs0: SUCCESS (1.557s)
[103.084117] Starting dynamic subtest: vecs0
[104.611050] Dynamic subtest vecs0: SUCCESS (1.559s)
[104.631670] Subtest semaphore-busy: SUCCESS (6.245s)
[104.732594] [026/141] (904s left) perf (blocking-parameterized)
[105.181928] Starting subtest: blocking-parameterized
[125.462035] Subtest blocking-parameterized: SUCCESS (20.112s)
[125.564821] [027/141] (884s left) gem_mmap_wc (pf-nonblock)
[125.860414] Starting subtest: pf-nonblock
[125.878928] Subtest pf-nonblock: SUCCESS (0.005s)
[125.968516] [028/141] (883s left) gem_exec_create (basic)
[126.260651] Starting subtest: basic
[126.282244] Starting dynamic subtest: smem
[128.332360] Dynamic subtest smem: SUCCESS (2.069s)
[128.350530] Subtest basic: SUCCESS (2.070s)
[128.550490] [029/141] (881s left) syncobj_timeline (invalid-query-one-illegal-handle)
[128.847601] Starting subtest: invalid-query-one-illegal-handle
[128.867956] Subtest invalid-query-one-illegal-handle: SUCCESS (0.002s)
[128.950590] [030/141] (880s left) feature_discovery (display)
[129.304828] Starting subtest: display
[129.325966] Subtest display: SUCCESS (0.000s)
[129.436793] [031/141] (880s left) gem_create (create-invalid-size)
[129.730561] Starting subtest: create-invalid-size
[129.750806] Subtest create-invalid-size: SUCCESS (0.000s)
[129.932986] [032/141] (880s left) gem_lmem_swapping (basic)
[130.232051] Subtest basic: SKIP (0.000s)
[130.323156] [033/141] (879s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[130.752079] Starting subtest: psr-rgb565-draw-pwrite
[130.793854] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[130.896796] [034/141] (879s left) syncobj_wait (single-wait-submitted)
[131.197082] Starting subtest: single-wait-submitted
[131.273108] Subtest single-wait-submitted: SUCCESS (0.108s)
[131.387734] [035/141] (878s left) kms_psr (psr2_suspend)
[131.700718] Subtest psr2_suspend: SKIP (0.000s)
[131.787542] [036/141] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[132.221348] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[132.262825] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[132.363125] [037/141] (878s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[132.747204] Starting subtest: compare-crc-sanitycheck-xr24
[132.767812] Starting dynamic subtest: pipe-A-DP-1
[133.172037] Dynamic subtest pipe-A-DP-1: SUCCESS (0.438s)
[133.211580] Starting dynamic subtest: pipe-B-DP-1
[133.919845] Dynamic subtest pipe-B-DP-1: SUCCESS (0.739s)
[133.959248] Starting dynamic subtest: pipe-C-DP-1
[134.788146] Dynamic subtest pipe-C-DP-1: SUCCESS (0.864s)
[134.810237] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.052s)
[135.162893] [038/141] (875s left) kms_cursor_edge_walk (64x64-right-edge)
[135.537713] Starting subtest: 64x64-right-edge
[135.562202] Starting dynamic subtest: pipe-A-DP-1
[139.204803] Dynamic subtest pipe-A-DP-1: SUCCESS (3.662s)
[139.248110] Starting dynamic subtest: pipe-C-DP-1
[142.703483] Dynamic subtest pipe-C-DP-1: SUCCESS (3.501s)
[142.730901] Subtest 64x64-right-edge: SUCCESS (7.170s)
[143.069959] [039/141] (867s left) prime_vgem (sync)
[143.392194] Starting subtest: sync
[143.412056] Starting dynamic subtest: rcs0
[143.431176] Dynamic subtest rcs0: SUCCESS (0.026s)
[143.465472] Starting dynamic subtest: vcs0
[143.483665] Dynamic subtest vcs0: SUCCESS (0.018s)
[143.519109] Starting dynamic subtest: vecs0
[143.539956] Dynamic subtest vecs0: SUCCESS (0.019s)
[143.560463] Subtest sync: SUCCESS (0.067s)
[143.682412] [040/141] (867s left) syncobj_timeline (transfer-timeline-point)
[143.957569] Starting subtest: transfer-timeline-point
[143.976047] Subtest transfer-timeline-point: SUCCESS (0.001s)
[144.060069] [041/141] (866s left) gem_userptr_blits (relocations)
[144.405331] Starting subtest: relocations
[144.446725] Subtest relocations: SKIP (0.003s)
[144.549103] [042/141] (866s left) gem_reg_read (timestamp-moving)
[144.839900] Starting subtest: timestamp-moving
[145.809107] Subtest timestamp-moving: SUCCESS (1.001s)
[145.925593] [043/141] (865s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[146.656497] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[146.982921] [044/141] (864s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_ccs)
[147.490883] Starting subtest: pipe-A-bad-aux-stride-y_tiled_ccs
[147.510708] Subtest pipe-A-bad-aux-stride-y_tiled_ccs: SUCCESS (0.002s)
[148.062739] [045/141] (863s left) i915_hwmon (hwmon-read)
[148.373074] Subtest hwmon-read: SKIP (0.000s)
[148.475318] [046/141] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[148.916938] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[150.976351] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.136s)
[151.145234] [047/141] (860s left) gen9_exec_parse (bb-start-far)
[151.441109] Starting subtest: bb-start-far
[151.462184] Subtest bb-start-far: SUCCESS (0.004s)
[151.688276] [048/141] (859s left) gem_ctx_persistence (engines-cleanup)
[151.968589] Starting subtest: engines-cleanup
[151.988219] Starting dynamic subtest: rcs0
[152.006736] Dynamic subtest rcs0: SUCCESS (0.046s)
[152.044447] Starting dynamic subtest: bcs0
[152.062985] Dynamic subtest bcs0: SUCCESS (0.038s)
[152.100084] Starting dynamic subtest: vcs0
[152.122089] Dynamic subtest vcs0: SUCCESS (0.032s)
[152.159555] Starting dynamic subtest: vecs0
[152.179880] Dynamic subtest vecs0: SUCCESS (0.053s)
[152.199343] Subtest engines-cleanup: SUCCESS (0.174s)
[152.282740] [049/141] (859s left) kms_plane_scaling (intel-max-src-size)
[152.668420] Starting subtest: intel-max-src-size
[152.689371] Starting dynamic subtest: pipe-A-DP-1
[152.709708] Dynamic subtest pipe-A-DP-1: SUCCESS (0.051s)
[152.729182] Subtest intel-max-src-size: SUCCESS (0.052s)
[152.860191] [050/141] (858s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[155.905821] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[156.012218] [051/141] (855s left) gem_exec_schedule (implicit-boths)
[156.455351] Starting subtest: implicit-boths
[156.473998] Starting dynamic subtest: rcs0
[156.495099] Dynamic subtest rcs0: SUCCESS (0.141s)
[156.535105] Starting dynamic subtest: bcs0
[156.594947] Dynamic subtest bcs0: SUCCESS (0.140s)
[156.630151] Starting dynamic subtest: vcs0
[156.721744] Dynamic subtest vcs0: SUCCESS (0.127s)
[156.758265] Starting dynamic subtest: vecs0
[156.855904] Dynamic subtest vecs0: SUCCESS (0.130s)
[156.876188] Subtest implicit-boths: SUCCESS (0.546s)
[157.241646] [052/141] (854s left) kms_vblank (pipe-a-query-busy)
[157.607328] Starting subtest: pipe-A-query-busy
[160.047847] Subtest pipe-A-query-busy: SUCCESS (2.460s)
[160.421803] [053/141] (851s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[160.714913] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[160.733258] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[160.836772] [054/141] (851s left) gem_eio (context-create)
[161.174114] Starting subtest: context-create
[161.195517] Subtest context-create: SUCCESS (0.056s)
[161.444808] [055/141] (850s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[161.876712] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[161.919486] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[162.025718] [056/141] (850s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[162.653392] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[162.692969] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[163.094674] [057/141] (849s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[163.461503] Starting subtest: cursorA-vs-flipA-atomic-transitions
[174.562405] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.094s)
[174.935341] [058/141] (837s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[175.716823] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[176.057589] [059/141] (836s left) kms_chamelium_hpd (vga-hpd-fast)
[176.589083] Subtest vga-hpd-fast: SKIP (0.000s)
[176.947544] [060/141] (835s left) kms_prop_blob (basic)
[177.318767] Starting subtest: basic
[177.340747] Subtest basic: SUCCESS (0.000s)
[177.466909] [061/141] (835s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[178.238872] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[178.590224] [062/141] (834s left) vc4/vc4_tiling (get-bad-handle)
[178.995382] Subtest get-bad-handle: SKIP (0.000s)
[179.129324] [063/141] (834s left) kms_chamelium_color (ctm-0-25)
[179.520913] Subtest ctm-0-25: SKIP (0.000s)
[179.636710] [064/141] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[180.092729] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[180.134297] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[180.238151] [065/141] (833s left) gem_exec_schedule (u-fairslice-all)
[180.738146] Starting subtest: u-fairslice-all
[182.737740] Subtest u-fairslice-all: SUCCESS (2.130s)
[183.117106] [066/141] (830s left) perf_pmu (all-busy-idle-check-all)
[183.410397] Starting subtest: all-busy-idle-check-all
[184.015856] Subtest all-busy-idle-check-all: SUCCESS (0.627s)
[184.151205] [067/141] (829s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[184.508294] Starting subtest: addfb25-y-tiled-small-legacy
[184.527481] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[184.665784] [068/141] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[185.091182] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[185.129584] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[185.244042] [069/141] (828s left) dmabuf_sync_file (export-multiwait)
[185.540324] Starting subtest: export-multiwait
[185.561530] Subtest export-multiwait: SUCCESS (0.002s)
[185.668963] [070/141] (828s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[186.038907] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[186.061267] Starting dynamic subtest: pipe-A-valid-mode
[186.747478] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.712s)
[186.769550] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.716s)
[187.130233] [071/141] (826s left) gem_userptr_blits (process-exit)
[187.501471] Starting subtest: process-exit
[187.523261] Subtest process-exit: SUCCESS (0.036s)
[187.644887] [072/141] (826s left) kms_vblank (pipe-c-query-forked-hang)
[188.010470] Starting subtest: pipe-C-query-forked-hang
[196.046745] Subtest pipe-C-query-forked-hang: SUCCESS (8.025s)
[196.420280] [073/141] (817s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[196.760463] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[196.870465] [074/141] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[197.290166] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[197.326997] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[197.440105] [075/141] (817s left) gem_mmap_wc (read)
[197.727450] Starting subtest: read
[197.830615] Subtest read: SUCCESS (0.134s)
[197.967816] [076/141] (816s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[198.505511] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[198.548616] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[199.063323] [077/141] (815s left) kms_atomic (crtc-invalid-params-fence)
[199.550806] Starting subtest: crtc-invalid-params-fence
[199.734312] Subtest crtc-invalid-params-fence: SUCCESS (0.179s)
[200.213621] [078/141] (814s left) gem_render_copy_redux (flink-interruptible)
[200.508969] Starting subtest: flink-interruptible
[205.294831] Subtest flink-interruptible: SUCCESS (4.789s)
[205.468233] [079/141] (809s left) gem_tiled_wb
[230.317549] [080/141] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[230.764034] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[230.800488] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[230.911298] [081/141] (784s left) i915_pm_rc6_residency (rc6-fence)
[231.206258] Starting subtest: rc6-fence
[246.607760] Subtest rc6-fence: SUCCESS (15.247s)
[246.710350] [082/141] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[247.111223] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[247.153274] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[247.265400] [083/141] (768s left) kms_draw_crc (draw-method-render)
[247.628988] Starting subtest: draw-method-render
[247.647238] Starting dynamic subtest: xrgb8888-untiled
[247.965814] Dynamic subtest xrgb8888-untiled: SUCCESS (0.333s)
[248.001785] Starting dynamic subtest: rgb565-untiled
[248.280062] Dynamic subtest rgb565-untiled: SUCCESS (0.314s)
[248.315315] Starting dynamic subtest: xrgb2101010-untiled
[248.631296] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.347s)
[248.669224] Starting dynamic subtest: xrgb8888-xtiled
[248.855184] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.214s)
[248.893992] Starting dynamic subtest: rgb565-xtiled
[249.037320] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[249.075349] Starting dynamic subtest: xrgb2101010-xtiled
[249.247403] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.214s)
[249.286713] Starting dynamic subtest: xrgb8888-ytiled
[249.469839] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.214s)
[249.511259] Starting dynamic subtest: rgb565-ytiled
[249.651424] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s)
[249.689954] Starting dynamic subtest: xrgb2101010-ytiled
[249.852544] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.197s)
[249.873848] Subtest draw-method-render: SUCCESS (2.219s)
[249.992773] [084/141] (765s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[250.718567] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[250.758781] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.004s)
[251.080227] [085/141] (764s left) v3d/v3d_submit_cl (bad-perfmon)
[251.417958] Subtest bad-perfmon: SKIP (0.000s)
[251.529632] [086/141] (764s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[251.915571] Starting subtest: cursor-rapid-movement-64x21
[251.934107] Starting dynamic subtest: pipe-A-DP-1
[252.430463] Dynamic subtest pipe-A-DP-1: SUCCESS (0.504s)
[252.512314] Starting dynamic subtest: pipe-C-DP-1
[253.319495] Dynamic subtest pipe-C-DP-1: SUCCESS (0.820s)
[253.338091] Subtest cursor-rapid-movement-64x21: SUCCESS (1.416s)
[253.717402] [087/141] (762s left) kms_cursor_crc (cursor-onscreen-512x170)
[254.101584] Starting subtest: cursor-onscreen-512x170
[254.138407] Subtest cursor-onscreen-512x170: SKIP (0.004s)
[254.253318] [088/141] (761s left) i915_query (query-regions-sanity-check)
[254.548673] Starting subtest: query-regions-sanity-check
[254.569365] Subtest query-regions-sanity-check: SUCCESS (0.039s)
[254.709142] [089/141] (761s left) i915_pm_rpm (reg-read-ioctl)
[256.572929] Starting subtest: reg-read-ioctl
[257.055803] Subtest reg-read-ioctl: SUCCESS (0.479s)
[257.577302] [090/141] (758s left) gem_mmap_gtt (flink-race)
[257.869602] Starting subtest: flink-race
[277.945211] Subtest flink-race: SUCCESS (20.109s)
[278.093492] [091/141] (738s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[278.377260] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[278.398460] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[278.491957] [092/141] (737s left) kms_vblank (pipe-b-query-busy-hang)
[278.828466] Starting subtest: pipe-B-query-busy-hang
[286.137138] Subtest pipe-B-query-busy-hang: SUCCESS (7.191s)
[286.422040] [093/141] (729s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[286.862831] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[286.967048] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.030s)
[287.109365] [094/141] (729s left) kms_psr (psr2_cursor_plane_onoff)
[287.451936] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[287.582156] [095/141] (729s left) kms_vblank (pipe-d-query-forked-hang)
[287.981908] Subtest pipe-D-query-forked-hang: SKIP (0.000s)
[288.225325] [096/141] (728s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[288.552471] Starting subtest: invalid-single-wait-all-unsubmitted
[288.580650] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[288.675975] [097/141] (728s left) gem_exec_schedule (lateslice)
[289.124081] Starting subtest: lateslice
[289.143580] Starting dynamic subtest: rcs0
[289.162061] Dynamic subtest rcs0: SUCCESS (0.029s)
[289.197903] Starting dynamic subtest: bcs0
[289.216435] Dynamic subtest bcs0: SUCCESS (0.031s)
[289.253583] Starting dynamic subtest: vcs0
[289.274639] Dynamic subtest vcs0: SUCCESS (0.027s)
[289.313089] Starting dynamic subtest: vecs0
[289.333731] Dynamic subtest vecs0: SUCCESS (0.026s)
[289.353170] Subtest lateslice: SUCCESS (0.125s)
[289.475963] [098/141] (727s left) sw_sync (sync_merge_same)
[289.752528] Starting subtest: sync_merge_same
[289.771209] Subtest sync_merge_same: SUCCESS (0.000s)
[289.860770] [099/141] (727s left) gem_exec_suspend (basic-s3-devices)
[290.155520] Starting subtest: basic-S3-devices
[290.175758] Starting dynamic subtest: smem
[300.442448] Dynamic subtest smem: SUCCESS (10.284s)
[300.460831] Subtest basic-S3-devices: SUCCESS (10.287s)
[305.863562] [100/141] (716s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[306.294152] Starting subtest: y-tiled-64bpp-rotate-270
[306.370482] Subtest y-tiled-64bpp-rotate-270: SKIP (0.087s)
[306.502478] [101/141] (715s left) kms_flip (absolute-wf_vblank)
[306.856594] Starting subtest: absolute-wf_vblank
[306.874961] Starting dynamic subtest: A-DP1
[317.559297] Dynamic subtest A-DP1: SUCCESS (10.536s)
[317.608923] Starting dynamic subtest: B-DP1
[328.011824] Dynamic subtest B-DP1: SUCCESS (10.453s)
[328.049421] Starting dynamic subtest: C-DP1
[338.478150] Dynamic subtest C-DP1: SUCCESS (10.461s)
[338.496559] Subtest absolute-wf_vblank: SUCCESS (31.463s)
[338.757966] [102/141] (683s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm)
[339.123143] Starting subtest: pipe-B-ts-continuation-modeset-rpm
[341.336522] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (2.217s)
[341.834727] [103/141] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[342.270115] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[342.310389] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[342.422746] [104/141] (680s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_mc_ccs)
[343.053586] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs
[343.094194] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[343.516690] [105/141] (679s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[344.120486] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[344.161624] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[344.601525] [106/141] (678s left) kms_plane_scaling (planes-upscale-20x20)
[344.958076] Starting subtest: planes-upscale-20x20
[344.976653] Starting dynamic subtest: pipe-A-DP-1
[345.025359] Dynamic subtest pipe-A-DP-1: SUCCESS (0.059s)
[345.077570] Starting dynamic subtest: pipe-B-DP-1
[345.383832] Dynamic subtest pipe-B-DP-1: SUCCESS (0.350s)
[345.429857] Starting dynamic subtest: pipe-C-DP-1
[345.502809] Dynamic subtest pipe-C-DP-1: SKIP (0.093s)
[345.523088] Subtest planes-upscale-20x20: SUCCESS (0.516s)
[345.909752] [107/141] (677s left) gem_softpin (full)
[346.203712] Starting subtest: full
[346.224913] Subtest full: SUCCESS (0.019s)
[346.338952] [108/141] (676s left) kms_getfb (getfb2-handle-not-fb)
[346.614777] Starting subtest: getfb2-handle-not-fb
[346.679044] Subtest getfb2-handle-not-fb: SUCCESS (0.092s)
[346.831400] [109/141] (676s left) perf_pmu (busy-start)
[347.115756] Starting subtest: busy-start
[347.137229] Starting dynamic subtest: rcs0
[349.807207] Dynamic subtest rcs0: SUCCESS (2.519s)
[349.844512] Starting dynamic subtest: bcs0
[352.324588] Dynamic subtest bcs0: SUCCESS (2.516s)
[352.363563] Starting dynamic subtest: vcs0
[354.837881] Dynamic subtest vcs0: SUCCESS (2.517s)
[354.877485] Starting dynamic subtest: vecs0
[357.362616] Dynamic subtest vecs0: SUCCESS (2.519s)
[357.381100] Subtest busy-start: SUCCESS (10.081s)
[357.486987] [110/141] (665s left) syncobj_basic (test-valid-cycle)
[357.796118] Starting subtest: test-valid-cycle
[357.820441] Subtest test-valid-cycle: SUCCESS (0.000s)
[357.936929] [111/141] (665s left) gem_workarounds (suspend-resume)
[358.260160] Starting subtest: suspend-resume
[375.071650] Subtest suspend-resume: SUCCESS (1.417s)
[380.927986] [112/141] (663s left) api_intel_bb (object-noreloc-purge-cache-simple)
[381.226929] Starting subtest: object-noreloc-purge-cache-simple
[381.245665] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s)
[381.368437] [113/141] (663s left) kms_psr (sprite_blt)
[381.655131] Subtest sprite_blt: SKIP (0.000s)
[381.751513] [114/141] (663s left) syncobj_timeline (multi-wait-signaled)
[382.038832] Starting subtest: multi-wait-signaled
[382.059434] Subtest multi-wait-signaled: SUCCESS (0.002s)
[382.151688] [115/141] (662s left) gem_exec_capture (capture-invisible)
[382.449565] Starting subtest: capture-invisible
[382.468390] Starting dynamic subtest: smem0
[382.505459] Dynamic subtest smem0: SKIP (0.000s)
[382.544970] Subtest capture-invisible: SKIP (0.003s)
[382.642266] [116/141] (662s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[382.929702] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[382.950715] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[383.043094] [117/141] (662s left) v3d/v3d_perfmon (get-values-invalid-pad)
[383.392517] Subtest get-values-invalid-pad: SKIP (0.000s)
[383.487884] [118/141] (661s left) kms_flip (2x-flip-vs-panning-vs-hang)
[383.864599] Starting subtest: 2x-flip-vs-panning-vs-hang
[383.902460] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[384.016847] [119/141] (661s left) dmabuf_sync_file (import-basic)
[384.303385] Starting subtest: import-basic
[384.322929] Subtest import-basic: SUCCESS (0.005s)
[384.419781] [120/141] (661s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[384.843433] Starting subtest: psr-1p-primscrn-spr-indfb-move
[384.884453] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[384.997726] [121/141] (660s left) gem_exec_fair (basic-none-vip)
[385.454738] Starting subtest: basic-none-vip
[385.474574] Starting dynamic subtest: rcs0
[391.089895] Dynamic subtest rcs0: SUCCESS (5.815s)
[391.109573] Subtest basic-none-vip: SUCCESS (5.819s)
[391.323219] [122/141] (654s left) sysfs_preempt_timeout (invalid)
[391.599329] Starting subtest: invalid
[391.617926] Starting dynamic subtest: vecs0
[391.637766] Dynamic subtest vecs0: SUCCESS (0.001s)
[391.679857] Starting dynamic subtest: vcs0
[391.700705] Dynamic subtest vcs0: SUCCESS (0.001s)
[391.741782] Starting dynamic subtest: bcs0
[391.761340] Dynamic subtest bcs0: SUCCESS (0.001s)
[391.800743] Starting dynamic subtest: rcs0
[391.819322] Dynamic subtest rcs0: SUCCESS (0.001s)
[391.837913] Subtest invalid: SUCCESS (0.017s)
[391.955410] [123/141] (653s left) gem_ctx_param (invalid-param-set)
[392.238625] Starting subtest: invalid-param-set
[392.259833] Subtest invalid-param-set: SUCCESS (0.000s)
[392.356280] [124/141] (653s left) kms_content_protection (uevent)
[392.763286] Starting subtest: uevent
[392.809081] Starting dynamic subtest: pipe-A-DP-1
[428.866283] Dynamic subtest pipe-A-DP-1: FAIL (34.986s)
[428.887316] Subtest uevent: FAIL (35.167s)
[429.016323] [125/141] (617s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[429.725566] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[429.765637] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[430.101606] [126/141] (616s left) gem_exec_whisper (basic-contexts-all)
[430.437668] Starting subtest: basic-contexts-all
[444.576212] Subtest basic-contexts-all: SUCCESS (14.109s)
[444.731887] [127/141] (601s left) gem_close_race (multigpu-basic-threads)
[445.030415] Starting subtest: multigpu-basic-threads
[445.069970] Subtest multigpu-basic-threads: SKIP (0.000s)
[445.268481] [128/141] (601s left) perf (short-reads)
[445.633842] Starting subtest: short-reads
[445.700663] Subtest short-reads: SUCCESS (0.047s)
[445.810050] [129/141] (600s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[446.295198] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[446.608652] [130/141] (600s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[447.066075] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[447.108802] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[447.691129] [131/141] (599s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[448.050466] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[448.069176] Starting dynamic subtest: pipe-A-valid-mode
[448.775279] Dynamic subtest pipe-A-valid-mode: SKIP (0.703s)
[448.814711] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (0.707s)
[449.206177] [132/141] (597s left) prime_vgem (fence-read-hang)
[449.572268] Subtest fence-read-hang: SKIP (0.000s)
[449.702252] [133/141] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[450.177563] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[452.203246] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.125s)
[452.430156] [134/141] (594s left) gem_exec_balancer (fairslice)
[452.768915] Starting subtest: fairslice
[452.824176] Subtest fairslice: SKIP (0.000s)
[456.880456] [135/141] (590s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[457.566620] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[457.632430] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[458.003585] [136/141] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[458.455400] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[458.505884] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[458.633728] [137/141] (588s left) gem_userptr_blits (vma-merge)
[459.037315] Starting subtest: vma-merge
[479.826258] Subtest vma-merge: FAIL (20.488s)
[479.928497] [138/141] (567s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[480.338619] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[481.762648] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.468s)
[481.937084] [139/141] (565s left) gem_mmap_gtt (fault-concurrent)
[482.247267] Starting subtest: fault-concurrent
[485.717994] Subtest fault-concurrent: SUCCESS (3.331s)
[485.971289] [140/141] (561s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[486.387750] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[487.775437] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.420s)
[487.959303] [141/141] (559s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[488.353006] Starting subtest: stress-mm-invalidate-close-overlap
[490.421096] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[490.563799] Closing watchdogs
Done.