[77.652466] Initializing watchdogs
[77.652511]   /dev/watchdog0
[77.666817] [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]
[77.671158] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[77.673857] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[77.677316] [001/131] (960s left) gem_exec_fence (basic-await)
[77.887230] Starting subtest: basic-await
[77.889643] Starting dynamic subtest: rcs0
[77.966475] Dynamic subtest rcs0: SUCCESS (0.082s)
[77.975782] Starting dynamic subtest: bcs0
[78.040438] Dynamic subtest bcs0: SUCCESS (0.073s)
[78.051179] Starting dynamic subtest: vcs0
[78.115569] Dynamic subtest vcs0: SUCCESS (0.075s)
[78.126403] Starting dynamic subtest: vcs1
[78.190939] Dynamic subtest vcs1: SUCCESS (0.074s)
[78.201886] Starting dynamic subtest: vecs0
[78.265280] Dynamic subtest vecs0: SUCCESS (0.074s)
[78.281730] Starting dynamic subtest: ccs0
[78.341956] Dynamic subtest ccs0: SUCCESS (0.076s)
[78.344428] Subtest basic-await: SUCCESS (0.458s)
[80.419801] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[80.422880] [002/131] (957s left) kms_plane (pixel-format-yf-tiled-modifier)
[80.516451] Starting subtest: pixel-format-yf-tiled-modifier
[80.520797] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[80.606456] [003/131] (957s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[80.702699] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[84.661319] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.965s)
[85.801155] [004/131] (952s left) gem_exec_balancer (hang)
[86.053058] Starting subtest: hang
[87.679591] Subtest hang: SUCCESS (1.629s)
[87.797312] [005/131] (950s left) perf_pmu (busy-accuracy-2)
[87.836679] Starting subtest: busy-accuracy-2
[87.839120] Starting dynamic subtest: rcs0
[90.888089] Dynamic subtest rcs0: SUCCESS (3.050s)
[90.899092] Starting dynamic subtest: bcs0
[93.945158] Dynamic subtest bcs0: SUCCESS (3.057s)
[93.955771] Starting dynamic subtest: vcs0
[96.988601] Dynamic subtest vcs0: SUCCESS (3.043s)
[96.999388] Starting dynamic subtest: vcs1
[100.034127] Dynamic subtest vcs1: SUCCESS (3.045s)
[100.044758] Starting dynamic subtest: vecs0
[103.081048] Dynamic subtest vecs0: SUCCESS (3.046s)
[103.091951] Starting dynamic subtest: ccs0
[106.139150] Dynamic subtest ccs0: SUCCESS (3.057s)
[106.141655] Subtest busy-accuracy-2: SUCCESS (18.304s)
[106.253767] [006/131] (932s left) gem_exec_flush (basic-uc-ro-default)
[106.323932] Starting subtest: basic-uc-ro-default
[111.787276] Subtest basic-uc-ro-default: SUCCESS (5.465s)
[112.000303] [007/131] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[112.104443] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[112.108554] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[112.214760] [008/131] (926s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[112.300973] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[112.305492] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[112.386193] [009/131] (926s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[112.491297] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[119.595665] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.108s)
[119.741519] [010/131] (918s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[119.804587] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[119.808775] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[119.997949] [011/131] (918s left) sysfs_preempt_timeout (timeout)
[120.057454] Starting subtest: timeout
[120.059337] Starting dynamic subtest: vecs0
[129.283031] Dynamic subtest vecs0: SUCCESS (9.225s)
[129.293877] Starting dynamic subtest: ccs0
[130.610430] Dynamic subtest ccs0: SUCCESS (1.327s)
[130.621306] Starting dynamic subtest: vcs0
[140.288100] Dynamic subtest vcs0: SUCCESS (9.676s)
[140.298890] Starting dynamic subtest: bcs0
[141.559260] Dynamic subtest bcs0: SUCCESS (1.272s)
[141.570299] Starting dynamic subtest: rcs0
[142.815191] Dynamic subtest rcs0: SUCCESS (1.255s)
[142.827391] Starting dynamic subtest: vcs1
[152.256102] Dynamic subtest vcs1: SUCCESS (9.438s)
[152.258699] Subtest timeout: SUCCESS (32.199s)
[152.351177] [012/131] (886s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[152.482416] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[152.623062] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.143s)
[152.756729] [013/131] (885s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[152.857747] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[152.861899] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[152.934478] [014/131] (885s left) gem_create (create-clear)
[152.978021] Starting subtest: create-clear
[152.980641] Starting dynamic subtest: smem0
[185.871114] Dynamic subtest smem0: SUCCESS (32.888s)
[185.873232] Subtest create-clear: SUCCESS (32.888s)
[186.065106] [015/131] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[186.181590] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[190.742903] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.565s)
[191.919557] [016/131] (846s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[192.028900] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[192.033105] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[192.124993] [017/131] (846s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[192.181638] Starting subtest: yf-tiled-ccs-to-yf-tiled
[192.186151] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[192.370533] [018/131] (846s left) sw_sync (alloc_fence)
[192.417475] Starting subtest: alloc_fence
[192.419568] Subtest alloc_fence: SUCCESS (0.000s)
[192.476492] [019/131] (846s left) gem_exec_schedule (independent)
[192.550812] Starting subtest: independent
[192.553151] Starting dynamic subtest: rcs0
[194.309968] Dynamic subtest rcs0: SUCCESS (1.768s)
[194.322067] Starting dynamic subtest: vcs0
[196.301739] Dynamic subtest vcs0: SUCCESS (1.991s)
[196.313427] Starting dynamic subtest: vcs1
[198.288870] Dynamic subtest vcs1: SUCCESS (1.986s)
[198.300893] Starting dynamic subtest: vecs0
[200.262879] Dynamic subtest vecs0: SUCCESS (1.973s)
[200.274177] Starting dynamic subtest: ccs0
[202.310080] Dynamic subtest ccs0: SUCCESS (2.046s)
[202.312935] Subtest independent: SUCCESS (9.768s)
[202.614944] [020/131] (836s left) gem_wait (invalid-buf)
[202.675427] Starting subtest: invalid-buf
[202.677783] Subtest invalid-buf: SUCCESS (0.000s)
[202.895166] [021/131] (836s left) api_intel_bb (simple-bb-ctx)
[202.958924] Starting subtest: simple-bb-ctx
[202.968438] Subtest simple-bb-ctx: SUCCESS (0.012s)
[203.083382] [022/131] (835s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[203.178049] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[203.180339] Starting dynamic subtest: pipe-A-eDP-1
[203.237725] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[203.245754] Starting dynamic subtest: pipe-B-eDP-1
[203.303103] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[203.313085] Starting dynamic subtest: pipe-C-eDP-1
[203.369977] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[203.380181] Starting dynamic subtest: pipe-D-eDP-1
[203.437578] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[203.442034] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[205.455103] [023/131] (833s left) perf (polling-small-buf)
[205.571657] Starting subtest: polling-small-buf
[205.662945] Subtest polling-small-buf: SUCCESS (0.091s)
[205.709217] [024/131] (833s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[205.810036] Starting subtest: psr-rgb565-draw-pwrite
[212.863815] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.059s)
[212.978186] [025/131] (826s left) gem_ctx_persistence (smoketest)
[213.040875] Starting subtest: smoketest
[253.221240] Subtest smoketest: SUCCESS (40.179s)
[253.305062] [026/131] (785s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[253.409166] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[253.413397] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[253.542256] [027/131] (785s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[254.111606] Starting subtest: syncobj-stationary-timeline-chain-engines
[254.207799] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.098s)
[255.412408] [028/131] (783s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[255.463182] Starting subtest: single-wait-all-for-submit-unsubmitted
[255.569993] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[255.657636] [029/131] (783s left) kms_async_flips (invalid-async-flip)
[255.746837] Starting subtest: invalid-async-flip
[256.122521] Starting dynamic subtest: pipe-A-eDP-1
[256.908074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[257.265383] Starting dynamic subtest: pipe-B-eDP-1
[258.041540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[258.410091] Starting dynamic subtest: pipe-C-eDP-1
[259.165216] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[259.524690] Starting dynamic subtest: pipe-D-eDP-1
[260.289605] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[260.291938] Subtest invalid-async-flip: SUCCESS (4.544s)
[261.439987] [030/131] (777s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[261.531991] Starting subtest: plane-upscale-20x20-with-pixel-format
[261.534397] Starting dynamic subtest: pipe-A
[262.601042] Dynamic subtest pipe-A: SUCCESS (1.072s)
[262.610521] Starting dynamic subtest: pipe-B
[264.748032] Dynamic subtest pipe-B: SUCCESS (2.146s)
[264.756308] Starting dynamic subtest: pipe-C
[265.941485] Dynamic subtest pipe-C: SUCCESS (1.192s)
[265.951580] Starting dynamic subtest: pipe-D
[267.086374] Dynamic subtest pipe-D: SUCCESS (1.144s)
[267.088586] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.557s)
[268.268080] [031/131] (771s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[268.379067] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[268.383406] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[268.448153] [032/131] (771s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[268.504877] Starting subtest: multi-wait-all-for-submit-available-submitted
[268.507207] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[268.591673] [033/131] (770s left) kms_chamelium_edid (dp-mode-timings)
[268.982241] Subtest dp-mode-timings: SKIP (0.000s)
[269.785560] [034/131] (769s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[269.879652] Starting subtest: psr-rgb565-draw-mmap-gtt
[269.883987] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[269.964209] [035/131] (769s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[270.052275] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[270.054442] Starting dynamic subtest: pipe-A-eDP-1
[270.076502] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[270.086925] Starting dynamic subtest: pipe-B-eDP-1
[270.107156] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[270.115248] Starting dynamic subtest: pipe-C-eDP-1
[270.135947] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[270.144032] Starting dynamic subtest: pipe-D-eDP-1
[270.164904] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[270.168734] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[272.364482] [036/131] (767s left) kms_pm_backlight (fade)
[272.453072] Starting subtest: fade
[272.524716] Starting dynamic subtest: eDP-1
[275.514223] Dynamic subtest eDP-1: SUCCESS (2.989s)
[275.516724] Subtest fade: SUCCESS (3.063s)
[276.322695] [037/131] (763s left) kms_legacy_colorkey (invalid-plane)
[276.409702] Starting subtest: invalid-plane
[276.411854] Starting dynamic subtest: zero-id
[276.414053] Dynamic subtest zero-id: SUCCESS (0.000s)
[276.423710] Starting dynamic subtest: outrange-id
[276.425640] Dynamic subtest outrange-id: SUCCESS (0.000s)
[276.427752] Subtest invalid-plane: SUCCESS (0.001s)
[276.482649] [038/131] (763s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[276.577226] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[276.579551] Starting dynamic subtest: pipe-A-eDP-1
[293.363908] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.488s)
[293.378583] Starting dynamic subtest: pipe-B-eDP-1
[310.356079] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s)
[310.366078] Starting dynamic subtest: pipe-C-eDP-1
[327.301314] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.348s)
[327.311551] Starting dynamic subtest: pipe-D-eDP-1
[344.331194] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.374s)
[344.333660] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.656s)
[345.514982] [039/131] (694s left) gem_wait (wait)
[345.597405] Starting subtest: wait
[345.599777] Starting dynamic subtest: all-engines
[347.535894] Dynamic subtest all-engines: SUCCESS (1.965s)
[347.548911] Starting dynamic subtest: rcs0
[348.584128] Dynamic subtest rcs0: SUCCESS (1.059s)
[348.598801] Starting dynamic subtest: bcs0
[349.630893] Dynamic subtest bcs0: SUCCESS (1.056s)
[349.643102] Starting dynamic subtest: vcs0
[350.676492] Dynamic subtest vcs0: SUCCESS (1.053s)
[350.689554] Starting dynamic subtest: vcs1
[351.721779] Dynamic subtest vcs1: SUCCESS (1.052s)
[351.732156] Starting dynamic subtest: vecs0
[352.767155] Dynamic subtest vecs0: SUCCESS (1.051s)
[352.779738] Starting dynamic subtest: ccs0
[353.815186] Dynamic subtest ccs0: SUCCESS (1.052s)
[353.817953] Subtest wait: SUCCESS (8.303s)
[354.020261] [040/131] (685s left) gem_partial_pwrite_pread (reads-uncached)
[354.076317] Subtest reads-uncached: SKIP (0.000s)
[354.159110] [041/131] (685s left) gen9_exec_parse (bb-start-cmd)
[354.214112] Subtest bb-start-cmd: SKIP (0.000s)
[354.280524] [042/131] (685s left) kms_sequence (get-forked)
[354.376466] Starting subtest: get-forked
[354.378369] Starting dynamic subtest: pipe-A-eDP-1
[356.236704] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.867s)
[356.247003] Starting dynamic subtest: pipe-B-eDP-1
[358.774949] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.548s)
[358.786677] Starting dynamic subtest: pipe-C-eDP-1
[361.261196] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.491s)
[361.278401] Starting dynamic subtest: pipe-D-eDP-1
[363.794480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s)
[363.796507] Subtest get-forked: SUCCESS (9.450s)
[364.623901] [043/131] (675s left) perf (invalid-oa-format-id)
[364.726505] Starting subtest: invalid-oa-format-id
[364.737512] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[364.778294] [044/131] (675s left) kms_psr (fbc-psr2-primary-render)
[364.876749] Starting subtest: fbc-psr2-primary-render
[364.879007] Starting dynamic subtest: eDP-1
[364.883346] Dynamic subtest eDP-1: SKIP (0.000s)
[364.887719] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[364.968010] [045/131] (675s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[365.068462] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[365.073403] Starting dynamic subtest: pipe-A-default-mode
[366.183884] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[366.188168] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.117s)
[366.331688] [046/131] (673s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[366.422422] Starting subtest: compare-crc-sanitycheck-xr24
[366.424709] Starting dynamic subtest: pipe-A-eDP-1
[367.050471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[367.060184] Starting dynamic subtest: pipe-B-eDP-1
[368.342208] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s)
[368.352172] Starting dynamic subtest: pipe-C-eDP-1
[369.616135] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.273s)
[369.626208] Starting dynamic subtest: pipe-D-eDP-1
[370.830520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[370.833209] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.416s)
[371.688598] [047/131] (668s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[371.787118] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[371.791675] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[371.875991] [048/131] (668s left) gem_mmap_offset (clear-via-pagefault)
[371.940575] Starting subtest: clear-via-pagefault
[371.942598] Starting dynamic subtest: smem0
[404.746874] Dynamic subtest smem0: SUCCESS (32.795s)
[404.749403] Subtest clear-via-pagefault: SUCCESS (32.798s)
[404.852424] [049/131] (635s left) gem_exec_params (invalid-ring2)
[404.915584] Starting subtest: invalid-ring2
[404.918044] Subtest invalid-ring2: SUCCESS (0.000s)
[405.021553] [050/131] (635s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[405.123370] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[405.125576] Starting dynamic subtest: pipe-A-eDP-1
[415.799875] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.681s)
[415.809821] Starting dynamic subtest: pipe-B-eDP-1
[427.194561] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.398s)
[427.197009] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.081s)
[428.049183] [051/131] (612s left) kms_addfb_basic (size-max)
[428.148657] Starting subtest: size-max
[428.150908] Subtest size-max: SUCCESS (0.000s)
[428.244238] [052/131] (612s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[428.309030] Starting subtest: wait-all-for-submit-delayed-submit
[428.413183] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[428.504762] [053/131] (611s left) prime_mmap (test_errors)
[428.563819] Starting subtest: test_errors
[428.565886] Starting dynamic subtest: test_errors-smem
[428.656512] Dynamic subtest test_errors-smem: SUCCESS (0.095s)
[428.659308] Subtest test_errors: SUCCESS (0.096s)
[428.772257] [054/131] (611s left) vgem_basic (mmap)
[428.813256] Starting subtest: mmap
[428.821938] Subtest mmap: SUCCESS (0.010s)
[428.884841] [055/131] (611s left) syncobj_basic (bad-create-flags)
[428.938784] Starting subtest: bad-create-flags
[428.940969] Subtest bad-create-flags: SUCCESS (0.000s)
[429.043278] [056/131] (611s left) kms_vblank (ts-continuation-modeset)
[429.137901] Starting subtest: ts-continuation-modeset
[429.139787] Starting dynamic subtest: pipe-A-eDP-1
[430.598382] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.462s)
[430.615699] Starting dynamic subtest: pipe-D-eDP-1
[432.766832] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[432.769208] Subtest ts-continuation-modeset: SUCCESS (3.633s)
[433.567962] [057/131] (606s left) gem_exec_schedule (u-semaphore-noskip)
[433.646845] Starting subtest: u-semaphore-noskip
[434.040432] Subtest u-semaphore-noskip: SUCCESS (0.396s)
[434.381245] [058/131] (606s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[434.495376] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[435.253377] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.759s)
[435.424949] [059/131] (605s left) kms_draw_crc (draw-method-pwrite)
[435.514421] Starting subtest: draw-method-pwrite
[435.516689] Starting dynamic subtest: xrgb8888-untiled
[436.080209] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s)
[436.089847] Starting dynamic subtest: rgb565-untiled
[436.526078] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[436.536466] Starting dynamic subtest: xrgb2101010-untiled
[437.058039] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[437.067787] Starting dynamic subtest: xbgr16161616f-untiled
[437.779685] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.721s)
[437.789477] Starting dynamic subtest: xrgb8888-xtiled
[439.512746] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.733s)
[439.523789] Starting dynamic subtest: rgb565-xtiled
[440.579555] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[440.589819] Starting dynamic subtest: xrgb2101010-xtiled
[442.302860] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.721s)
[442.313096] Starting dynamic subtest: xbgr16161616f-xtiled
[445.528329] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.220s)
[445.538372] Starting dynamic subtest: xrgb8888-4tiled
[446.605114] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.075s)
[446.617140] Starting dynamic subtest: rgb565-4tiled
[447.160535] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[447.172440] Starting dynamic subtest: xrgb2101010-4tiled
[448.227254] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[448.237444] Starting dynamic subtest: xbgr16161616f-4tiled
[451.128404] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.899s)
[451.130747] Subtest draw-method-pwrite: SUCCESS (15.613s)
[451.240009] [060/131] (589s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[451.360630] Starting subtest: extended-pageflip-modeset-hang-oldfb
[451.362674] Starting dynamic subtest: pipe-A
[459.265458] Dynamic subtest pipe-A: SUCCESS (7.901s)
[459.276016] Starting dynamic subtest: pipe-D
[467.880233] Dynamic subtest pipe-D: SUCCESS (8.614s)
[467.882397] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.520s)
[468.742430] [061/131] (571s left) kms_psr (psr-sprite-plane-move)
[468.841497] Starting subtest: psr-sprite-plane-move
[468.843788] Starting dynamic subtest: eDP-1
[470.575990] Dynamic subtest eDP-1: SUCCESS (1.734s)
[470.578319] Subtest psr-sprite-plane-move: SUCCESS (1.735s)
[471.400092] [062/131] (569s left) i915_pm_rpm (sysfs-read)
[473.619650] Starting subtest: sysfs-read
[474.776948] Subtest sysfs-read: SUCCESS (1.155s)
[475.160152] [063/131] (565s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[475.222197] Subtest untiled-to-tiled: SKIP (0.000s)
[475.301699] [064/131] (565s left) kms_flip (2x-flip-vs-rmfb)
[475.389797] Starting subtest: 2x-flip-vs-rmfb
[475.398867] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[475.475669] [065/131] (565s left) kms_psr (pr-no-drrs)
[475.565464] Starting subtest: pr-no-drrs
[475.569751] Subtest pr-no-drrs: SKIP (0.000s)
[475.639340] [066/131] (565s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[475.743729] Starting subtest: fbc-rgb565-draw-mmap-cpu
[479.733144] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.992s)
[480.859985] [067/131] (560s left) perf_pmu (frequency)
[480.902962] Starting subtest: frequency
[480.908000] Starting dynamic subtest: gt0
[483.024399] Dynamic subtest gt0: SUCCESS (2.112s)
[483.036388] Starting dynamic subtest: idle-gt0
[483.530282] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[483.543031] Starting dynamic subtest: gt1
[488.527777] Dynamic subtest gt1: SUCCESS (4.993s)
[488.539058] Starting dynamic subtest: idle-gt1
[489.033346] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[489.036174] Subtest frequency: SUCCESS (8.133s)
[489.134092] [068/131] (551s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[489.245821] Starting subtest: sprite-rotation-90-pos-100-0
[489.250418] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[489.319057] [069/131] (551s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[489.432119] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[489.434457] Starting dynamic subtest: pipe-A-eDP-1
[489.455281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[489.467103] Starting dynamic subtest: pipe-B-eDP-1
[489.486942] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[489.496672] Starting dynamic subtest: pipe-C-eDP-1
[489.516802] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[489.533903] Starting dynamic subtest: pipe-D-eDP-1
[489.554244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[489.556507] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[491.638205] [070/131] (549s left) kms_cursor_crc (cursor-random-256x85)
[491.888757] Starting subtest: cursor-random-256x85
[491.931928] Subtest cursor-random-256x85: SKIP (0.040s)
[492.126042] [071/131] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[492.215930] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[499.151046] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.937s)
[499.291902] [072/131] (541s left) gem_eio (wait-immediate)
[499.506444] Starting subtest: wait-immediate
[499.852740] Subtest wait-immediate: SUCCESS (0.346s)
[499.999187] [073/131] (541s left) syncobj_timeline (device-signal-unordered)
[500.043336] Starting subtest: device-signal-unordered
[500.045649] Subtest device-signal-unordered: SUCCESS (0.001s)
[500.150432] [074/131] (541s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[500.243369] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[500.252624] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[500.354046] [075/131] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[500.447449] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[500.450943] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[500.538070] [076/131] (540s left) kms_cursor_crc (cursor-sliding-max-size)
[500.859767] Starting subtest: cursor-sliding-max-size
[500.865048] Subtest cursor-sliding-max-size: SKIP (0.000s)
[500.981711] [077/131] (540s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[501.071726] Starting subtest: plane-downscale-factor-0-75-with-rotation
[501.073602] Starting dynamic subtest: pipe-A
[501.311493] Dynamic subtest pipe-A: SUCCESS (0.241s)
[501.321502] Starting dynamic subtest: pipe-B
[502.602539] Dynamic subtest pipe-B: SUCCESS (1.289s)
[502.613729] Starting dynamic subtest: pipe-C
[503.924106] Dynamic subtest pipe-C: SUCCESS (1.321s)
[503.935242] Starting dynamic subtest: pipe-D
[505.270142] Dynamic subtest pipe-D: SUCCESS (1.345s)
[505.272526] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.201s)
[506.431251] [078/131] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[506.533908] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[506.538253] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[506.630878] [079/131] (534s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[506.731114] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[511.384589] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.657s)
[512.533457] [080/131] (528s left) gem_mmap (bad-offset)
[512.590334] Subtest bad-offset: SKIP (0.000s)
[512.647878] [081/131] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[512.745948] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[519.256665] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.514s)
[519.384592] [082/131] (522s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[519.506655] Starting subtest: short-flip-after-cursor-toggle
[520.436045] Subtest short-flip-after-cursor-toggle: SUCCESS (0.927s)
[521.272979] [083/131] (520s left) perf_pmu (busy-start)
[521.319892] Starting subtest: busy-start
[521.321737] Starting dynamic subtest: rcs0
[523.867212] Dynamic subtest rcs0: SUCCESS (2.549s)
[523.879874] Starting dynamic subtest: bcs0
[526.418134] Dynamic subtest bcs0: SUCCESS (2.549s)
[526.429391] Starting dynamic subtest: vcs0
[529.487969] Dynamic subtest vcs0: SUCCESS (3.067s)
[529.500590] Starting dynamic subtest: vcs1
[533.519456] Dynamic subtest vcs1: SUCCESS (4.030s)
[533.531603] Starting dynamic subtest: vecs0
[537.488142] Dynamic subtest vecs0: SUCCESS (3.967s)
[537.501377] Starting dynamic subtest: ccs0
[540.035939] Dynamic subtest ccs0: SUCCESS (2.547s)
[540.038517] Subtest busy-start: SUCCESS (18.723s)
[540.164571] [084/131] (501s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[540.276939] Starting subtest: fbc-psr-sprite-mmap-gtt
[540.279245] Starting dynamic subtest: eDP-1
[540.283689] Dynamic subtest eDP-1: SKIP (0.000s)
[540.287865] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.003s)
[540.359637] [085/131] (501s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[540.466164] Starting subtest: 4-tiled-64bpp-rotate-180
[541.910671] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.444s)
[542.215922] [086/131] (499s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[542.335010] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[553.505661] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.171s)
[554.308220] [087/131] (487s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[554.413552] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[562.856006] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.447s)
[562.974089] [088/131] (478s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[563.080830] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[563.085100] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[563.181563] [089/131] (478s left) kms_color (degamma)
[563.261638] Starting subtest: degamma
[563.263774] Starting dynamic subtest: pipe-A-eDP-1
[563.967512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[563.978630] Starting dynamic subtest: pipe-B-eDP-1
[565.354204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[565.365075] Starting dynamic subtest: pipe-C-eDP-1
[566.713231] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[566.723677] Starting dynamic subtest: pipe-D-eDP-1
[568.061548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[568.063936] Subtest degamma: SUCCESS (4.804s)
[568.866040] [090/131] (473s left) kms_chamelium_color (ctm-0-50)
[568.960585] Subtest ctm-0-50: SKIP (0.000s)
[569.008104] [091/131] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[569.116694] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[569.120918] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[569.213034] [092/131] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[569.312234] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[573.018162] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.708s)
[574.187561] [093/131] (467s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[574.295095] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[574.297342] Starting dynamic subtest: pipe-A-eDP-1
[580.129450] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.838s)
[580.139795] Starting dynamic subtest: pipe-B-eDP-1
[586.777975] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[586.780152] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.484s)
[587.685828] [094/131] (454s left) gem_ctx_shared (exec-single-timeline)
[587.744739] Starting subtest: exec-single-timeline
[587.747204] Starting dynamic subtest: rcs0
[588.780904] Dynamic subtest rcs0: SUCCESS (1.034s)
[588.793894] Starting dynamic subtest: bcs0
[589.868924] Dynamic subtest bcs0: SUCCESS (1.085s)
[589.883257] Starting dynamic subtest: vcs0
[590.958294] Dynamic subtest vcs0: SUCCESS (1.086s)
[590.972814] Starting dynamic subtest: vcs1
[592.045869] Dynamic subtest vcs1: SUCCESS (1.084s)
[592.059827] Starting dynamic subtest: vecs0
[593.133819] Dynamic subtest vecs0: SUCCESS (1.085s)
[593.145960] Starting dynamic subtest: ccs0
[594.221720] Dynamic subtest ccs0: SUCCESS (1.084s)
[594.224337] Subtest exec-single-timeline: SUCCESS (6.476s)
[594.416961] [095/131] (447s left) prime_mmap (test_forked)
[594.489354] Starting subtest: test_forked
[594.491665] Starting dynamic subtest: test_forked-smem
[594.528383] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[594.530728] Subtest test_forked: SUCCESS (0.041s)
[594.653614] [096/131] (447s left) drm_read (short-buffer-block)
[594.789199] Starting subtest: short-buffer-block
[594.791119] Subtest short-buffer-block: SUCCESS (0.000s)
[594.916907] [097/131] (447s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[594.980052] Starting subtest: etime-single-wait-all-for-submit-submitted
[595.084576] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[595.162208] [098/131] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[595.261285] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[602.041596] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.783s)
[602.190064] [099/131] (440s left) api_intel_allocator (gem-pool)
[602.250266] Starting subtest: gem-pool
[602.257647] Subtest gem-pool: SUCCESS (0.008s)
[602.374369] [100/131] (439s left) syncobj_wait (multi-wait-all-signaled)
[602.429643] Starting subtest: multi-wait-all-signaled
[602.431836] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[602.538777] [101/131] (439s left) kms_psr (psr2-primary-mmap-gtt)
[602.643664] Starting subtest: psr2-primary-mmap-gtt
[602.645916] Starting dynamic subtest: eDP-1
[604.097835] Dynamic subtest eDP-1: SKIP (1.450s)
[604.102401] Subtest psr2-primary-mmap-gtt: SKIP (1.452s)
[604.254851] [102/131] (438s left) kms_big_fb (x-tiled-addfb)
[604.363141] Starting subtest: x-tiled-addfb
[604.365239] Subtest x-tiled-addfb: SUCCESS (0.000s)
[604.477754] [103/131] (437s left) gem_lmem_swapping (massive-random)
[604.521179] Subtest massive-random: SKIP (0.000s)
[604.590347] [104/131] (437s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[604.697092] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[606.093665] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.397s)
[606.883815] [105/131] (435s left) i915_drm_fdinfo (memory-info-purgeable)
[606.928638] Starting subtest: memory-info-purgeable
[606.931044] Starting dynamic subtest: smem0
[609.445912] Dynamic subtest smem0: SUCCESS (2.518s)
[609.448231] Subtest memory-info-purgeable: SUCCESS (2.520s)
[609.526576] [106/131] (433s left) kms_content_protection (suspend-resume)
[609.677023] Starting subtest: suspend-resume
[609.680905] Subtest suspend-resume: SKIP (0.000s)
[609.813931] [107/131] (432s left) kms_dp_linktrain_fallback (dsc-fallback)
[609.900654] Starting subtest: dsc-fallback
[609.906112] Subtest dsc-fallback: SKIP (0.000s)
[609.973623] [108/131] (432s left) gem_softpin (evict-prime-sanity-check)
[610.024912] Starting subtest: evict-prime-sanity-check
[610.026800] Starting dynamic subtest: rcs0
[611.174551] Dynamic subtest rcs0: SUCCESS (1.148s)
[611.187361] Starting dynamic subtest: bcs0
[612.296278] Dynamic subtest bcs0: SUCCESS (1.119s)
[612.309363] Starting dynamic subtest: vcs0
[613.424525] Dynamic subtest vcs0: SUCCESS (1.127s)
[613.437260] Starting dynamic subtest: vcs1
[615.501970] Dynamic subtest vcs1: SUCCESS (2.074s)
[615.515644] Starting dynamic subtest: vecs0
[617.463818] Dynamic subtest vecs0: SUCCESS (1.959s)
[617.477149] Starting dynamic subtest: ccs0
[618.612596] Dynamic subtest ccs0: SUCCESS (1.148s)
[618.625496] Starting dynamic subtest: all
[619.739540] Dynamic subtest all: SUCCESS (1.124s)
[619.742067] Subtest evict-prime-sanity-check: SUCCESS (9.714s)
[619.829875] [109/131] (422s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[619.924200] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[619.928373] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[620.020420] [110/131] (422s left) i915_pm_freq_api (freq-reset)
[620.086014] Starting subtest: freq-reset
[620.088429] Starting dynamic subtest: gt0
[620.276341] Dynamic subtest gt0: SUCCESS (0.189s)
[620.287038] Starting dynamic subtest: gt1
[620.450599] Dynamic subtest gt1: SUCCESS (0.173s)
[620.453369] Subtest freq-reset: SUCCESS (0.364s)
[620.527977] [111/131] (422s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[620.629457] Starting subtest: fbc-rgb101010-draw-mmap-wc
[625.151907] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.525s)
[626.273522] [112/131] (416s left) gem_exec_whisper (basic-normal)
[626.344497] Starting subtest: basic-normal
[631.463746] Subtest basic-normal: SUCCESS (5.117s)
[631.647260] [113/131] (411s left) dumb_buffer (map-uaf)
[631.711335] Starting subtest: map-uaf
[631.713692] Subtest map-uaf: SUCCESS (0.004s)
[631.799395] [114/131] (411s left) i915_suspend (forcewake)
[631.851216] Starting subtest: forcewake
[664.175610] Subtest forcewake: SUCCESS (2.230s)
[665.268294] [115/131] (378s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[665.352037] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[665.354818] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[665.457489] [116/131] (378s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[665.575028] Starting subtest: cursorA-vs-flipB-toggle
[665.579705] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[665.718608] [117/131] (378s left) syncobj_wait (single-wait-signaled)
[665.770772] Starting subtest: single-wait-signaled
[665.772898] Subtest single-wait-signaled: SUCCESS (0.000s)
[665.857940] [118/131] (378s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[665.944389] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[665.954359] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s)
[666.039028] [119/131] (378s left) dmabuf (all-tests)
[666.082951] Starting subtest: all-tests
[666.085278] Starting dynamic subtest: sanitycheck
[666.208792] Dynamic subtest sanitycheck: SUCCESS (0.132s)
[666.220740] Starting dynamic subtest: dma_fence
[666.411013] Dynamic subtest dma_fence: SUCCESS (0.203s)
[666.425886] Starting dynamic subtest: dma_fence_chain
[675.798564] Dynamic subtest dma_fence_chain: SUCCESS (9.466s)
[675.810138] Starting dynamic subtest: dma_fence_unwrap
[675.875736] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s)
[675.890805] Starting dynamic subtest: dma_resv
[675.952795] Dynamic subtest dma_resv: SUCCESS (0.075s)
[675.955618] Subtest all-tests: SUCCESS (9.964s)
[676.025318] [120/131] (368s left) gem_exec_fence (syncobj-timeline-wait)
[676.569674] Starting subtest: syncobj-timeline-wait
[677.599670] Subtest syncobj-timeline-wait: SUCCESS (1.034s)
[679.626998] [121/131] (364s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[679.724886] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[680.524633] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[680.675998] [122/131] (363s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[680.769702] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[685.240184] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.484s)
[686.410151] [123/131] (357s left) gem_exec_flush (basic-wb-rw-default)
[686.473898] Starting subtest: basic-wb-rw-default
[691.954170] Subtest basic-wb-rw-default: SUCCESS (5.488s)
[692.158477] [124/131] (352s left) prime_vgem (basic-write)
[692.227820] Starting subtest: basic-write
[692.244778] Subtest basic-write: SKIP (0.014s)
[692.357398] [125/131] (352s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[692.466589] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[699.524323] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.063s)
[699.650821] [126/131] (344s left) kms_cursor_crc (cursor-onscreen-64x21)
[699.857151] Starting subtest: cursor-onscreen-64x21
[699.900609] Subtest cursor-onscreen-64x21: SKIP (0.039s)
[700.161537] [127/131] (344s left) gem_ctx_param (invalid-set-no-zeromap)
[700.215061] Starting subtest: invalid-set-no-zeromap
[700.218060] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[700.289526] [128/131] (344s left) syncobj_timeline (single-wait-all-available-signaled)
[700.344138] Starting subtest: single-wait-all-available-signaled
[700.347062] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[700.432750] [129/131] (344s left) kms_invalid_mode (clock-too-high)
[700.525037] Starting subtest: clock-too-high
[700.527833] Starting dynamic subtest: pipe-A-eDP-1
[700.531917] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[700.541825] Starting dynamic subtest: pipe-B-eDP-1
[700.546015] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[700.556921] Starting dynamic subtest: pipe-C-eDP-1
[700.560982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[700.570930] Starting dynamic subtest: pipe-D-eDP-1
[700.575700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[700.579873] Subtest clock-too-high: SKIP (0.004s)
[700.639418] [130/131] (344s left) kms_chamelium_hpd (dp-hpd-storm)
[701.026986] Subtest dp-hpd-storm: SKIP (0.000s)
[701.835994] [131/131] (342s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[701.932782] Starting subtest: addfb25-y-tiled-legacy
[701.935155] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[702.045659] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: gem_exec_flush
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_render_copy
results: parsing output: 10/ for test: sysfs_preempt_timeout
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_create
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: sw_sync
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: api_intel_bb
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_chamelium_edid
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_legacy_colorkey
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_wait
results: parsing output: 39/ for test: gem_partial_pwrite_pread
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_sequence
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_pipe_crc_basic
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: prime_mmap
results: parsing output: 53/ for test: vgem_basic
results: parsing output: 54/ for test: syncobj_basic
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_draw_crc
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: gem_set_tiling_vs_blt
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: drm_read
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: kms_dp_linktrain_fallback
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: i915_pm_freq_api
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: dumb_buffer
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: dmabuf
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_invalid_mode
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: kms_addfb_basic
Done.