[60.206864] Initializing watchdogs
[60.206930]   /dev/watchdog0
[60.226166] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.236473] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.240592] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.242973] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[60.432994] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[60.434678] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[60.611587] [002/131] (960s left) gem_exec_fence (submit3)
[60.810894] Starting subtest: submit3
[60.812584] Subtest submit3: SKIP (0.000s)
[61.609156] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[61.610747] [003/131] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[61.795427] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[61.797113] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.978946] [004/131] (959s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[62.168378] Starting subtest: fbc-rgb101010-draw-mmap-wc
[62.170050] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[62.373912] [005/131] (958s left) gem_exec_balancer (noheartbeat)
[62.721266] Starting subtest: noheartbeat
[62.722988] Subtest noheartbeat: SKIP (0.000s)
[62.888866] [006/131] (958s left) kms_chamelium_color (ctm-blue-to-red)
[63.091115] Subtest ctm-blue-to-red: SKIP (0.000s)
[63.151580] [007/131] (958s left) gem_workarounds (suspend-resume)
[63.248545] Starting subtest: suspend-resume
[82.431128] Subtest suspend-resume: SUCCESS (3.812s)
[82.585845] [008/131] (938s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[82.771736] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[82.772560] Starting dynamic subtest: pipe-A
[82.872604] Dynamic subtest pipe-A: SUCCESS (0.101s)
[82.882332] Starting dynamic subtest: pipe-B
[83.070258] Dynamic subtest pipe-B: SUCCESS (0.197s)
[83.086685] Starting dynamic subtest: pipe-C
[83.312837] Dynamic subtest pipe-C: SUCCESS (0.242s)
[83.325442] Starting dynamic subtest: pipe-D
[83.508268] Dynamic subtest pipe-D: SUCCESS (0.195s)
[83.509245] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.737s)
[83.849566] [009/131] (937s left) gem_pxp (create-regular-buffer)
[86.457836] Starting subtest: create-regular-buffer
[86.459821] Subtest create-regular-buffer: SKIP (0.000s)
[86.598957] [010/131] (934s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[86.683807] Starting subtest: rel-constants-invalid-rel-gen5
[86.684752] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[86.886721] [011/131] (934s left) gem_exec_nop (basic-series)
[86.975774] Starting subtest: basic-series
[91.318394] Subtest basic-series: SUCCESS (4.342s)
[91.599179] [012/131] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[91.786654] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[91.788366] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[91.989483] [013/131] (929s left) kms_psr (fbc-psr-primary-page-flip)
[92.174499] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[92.229188] [014/131] (929s left) i915_pm_rps (engine-order)
[92.315778] Starting subtest: engine-order
[103.036023] Subtest engine-order: SUCCESS (10.719s)
[103.304218] [015/131] (918s left) gem_softpin (evict-active)
[103.387523] Starting subtest: evict-active
[103.403977] Subtest evict-active: SUCCESS (0.016s)
[103.587772] [016/131] (918s left) syncobj_timeline (wait-delayed-signal)
[103.666437] Starting subtest: wait-delayed-signal
[103.769993] Subtest wait-delayed-signal: SUCCESS (0.103s)
[103.955044] [017/131] (917s left) kms_panel_fitting (atomic-fastset)
[104.136783] Starting subtest: atomic-fastset
[104.138562] Subtest atomic-fastset: SKIP (0.000s)
[104.315149] [018/131] (917s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[104.511577] Starting subtest: x-tiled-16bpp-rotate-270
[104.572452] Subtest x-tiled-16bpp-rotate-270: SKIP (0.060s)
[104.757783] [019/131] (917s left) api_intel_bb (render-ccs)
[104.835249] Starting subtest: render-ccs
[104.931781] Subtest render-ccs: SUCCESS (0.097s)
[105.119437] [020/131] (916s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[105.305635] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[105.306547] Starting dynamic subtest: pipe-A-DP-3
[105.314772] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[105.325637] Starting dynamic subtest: pipe-B-DP-3
[105.341323] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[105.351869] Starting dynamic subtest: pipe-C-DP-3
[105.360127] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[105.370788] Starting dynamic subtest: pipe-D-DP-3
[105.380261] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[105.382324] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[105.801818] [021/131] (916s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[105.891753] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[106.001398] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[106.184894] [022/131] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[106.373003] Starting subtest: psr-2p-primscrn-cur-indfb-move
[106.374577] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[106.569802] [023/131] (915s left) gem_lmem_swapping (heavy-multi)
[109.219539] Starting subtest: heavy-multi
[109.220460] Starting dynamic subtest: lmem0
[114.320776] Dynamic subtest lmem0: SUCCESS (5.101s)
[114.321689] Subtest heavy-multi: SUCCESS (5.101s)
[115.496261] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[115.497198] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[115.498723] [024/131] (906s left) kms_async_flips (test-cursor)
[117.160018] Starting subtest: test-cursor
[117.397670] Starting dynamic subtest: pipe-A-DP-3
[117.704149] Dynamic subtest pipe-A-DP-3: SUCCESS (0.306s)
[117.943873] Starting dynamic subtest: pipe-B-DP-3
[118.045532] Dynamic subtest pipe-B-DP-3: SUCCESS (0.112s)
[118.258960] Starting dynamic subtest: pipe-C-DP-3
[118.352393] Dynamic subtest pipe-C-DP-3: SUCCESS (0.104s)
[118.564578] Starting dynamic subtest: pipe-D-DP-3
[118.662804] Dynamic subtest pipe-D-DP-3: SUCCESS (0.111s)
[118.663689] Subtest test-cursor: SUCCESS (1.504s)
[119.146719] [FACT kms_async_flips (test-cursor)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[119.148966] [FACT kms_async_flips (test-cursor)] new: kernel.kmod_is_loaded.i915: true
[119.151503] [025/131] (903s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[119.352174] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[119.404667] [026/131] (903s left) kms_plane_multiple (2x-tiling-4)
[119.595312] Starting subtest: 2x-tiling-4
[119.597125] Subtest 2x-tiling-4: SKIP (0.000s)
[119.768385] [027/131] (902s left) gem_ctx_param (invalid-param-set)
[119.848666] Starting subtest: invalid-param-set
[119.849640] Subtest invalid-param-set: SUCCESS (0.000s)
[120.011661] [028/131] (902s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[120.198196] Starting subtest: bad-pixel-format-y-tiled-ccs
[120.199033] Starting dynamic subtest: pipe-A-DP-3
[120.207519] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[120.218403] Starting dynamic subtest: pipe-B-DP-3
[120.226888] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[120.237787] Starting dynamic subtest: pipe-C-DP-3
[120.246026] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[120.256799] Starting dynamic subtest: pipe-D-DP-3
[120.266752] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[120.268914] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[120.694291] [029/131] (901s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[120.877095] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[120.877916] Starting dynamic subtest: pipe-A
[121.438996] Dynamic subtest pipe-A: SUCCESS (0.562s)
[121.462749] Starting dynamic subtest: pipe-B
[122.084536] Dynamic subtest pipe-B: SUCCESS (0.645s)
[122.105522] Starting dynamic subtest: pipe-C
[122.751346] Dynamic subtest pipe-C: SUCCESS (0.666s)
[122.773370] Starting dynamic subtest: pipe-D
[123.396530] Dynamic subtest pipe-D: SUCCESS (0.644s)
[123.397510] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.520s)
[123.741135] [030/131] (899s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[123.821491] Starting subtest: multi-wait-all-available-submitted-signaled
[123.822432] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[123.989695] [031/131] (898s left) perf (missing-sample-flags)
[124.382720] Starting subtest: missing-sample-flags
[124.383533] Subtest missing-sample-flags: SUCCESS (0.000s)
[124.439861] [032/131] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[124.632050] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[127.759812] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.128s)
[127.956397] [033/131] (894s left) kms_pm_rpm (system-suspend-idle)
[130.374838] Starting subtest: system-suspend-idle
[149.814813] Subtest system-suspend-idle: SUCCESS (5.236s)
[150.247363] [034/131] (872s left) kms_vblank (wait-forked)
[150.429296] Starting subtest: wait-forked
[150.431164] Starting dynamic subtest: pipe-A-DP-3
[152.790922] Dynamic subtest pipe-A-DP-3: SUCCESS (2.406s)
[152.818891] Starting dynamic subtest: pipe-D-DP-3
[155.080192] Dynamic subtest pipe-D-DP-3: SUCCESS (2.314s)
[155.081195] Subtest wait-forked: SUCCESS (4.733s)
[155.378966] [035/131] (867s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[155.575167] Starting subtest: y-tiled-32bpp-rotate-0
[155.576959] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[155.771410] [036/131] (867s left) kms_pipe_crc_basic (read-crc)
[155.954709] Starting subtest: read-crc
[155.956829] Starting dynamic subtest: pipe-A-DP-3
[156.585827] Dynamic subtest pipe-A-DP-3: SUCCESS (0.637s)
[156.604025] Starting dynamic subtest: pipe-B-DP-3
[157.185002] Dynamic subtest pipe-B-DP-3: SUCCESS (0.603s)
[157.198757] Starting dynamic subtest: pipe-C-DP-3
[157.765169] Dynamic subtest pipe-C-DP-3: SUCCESS (0.584s)
[157.778667] Starting dynamic subtest: pipe-D-DP-3
[158.316972] Dynamic subtest pipe-D-DP-3: SUCCESS (0.556s)
[158.317900] Subtest read-crc: SUCCESS (2.386s)
[158.644367] [037/131] (864s left) kms_cursor_legacy (single-move)
[158.827854] Starting subtest: single-move
[158.828748] Starting dynamic subtest: pipe-A
[164.177522] Dynamic subtest pipe-A: SUCCESS (5.379s)
[164.190290] Starting dynamic subtest: pipe-B
[169.548126] Dynamic subtest pipe-B: SUCCESS (5.387s)
[169.559947] Starting dynamic subtest: pipe-C
[174.917953] Dynamic subtest pipe-C: SUCCESS (5.379s)
[174.930741] Starting dynamic subtest: pipe-D
[180.299228] Dynamic subtest pipe-D: SUCCESS (5.387s)
[180.311341] Starting dynamic subtest: all-pipes
[185.680254] Dynamic subtest all-pipes: SUCCESS (5.379s)
[185.681141] Subtest single-move: SUCCESS (26.914s)
[185.813895] [038/131] (837s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[186.006320] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[186.057956] [039/131] (837s left) gem_unref_active_buffers
[186.476950] [040/131] (836s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[186.663388] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[186.724428] [041/131] (836s left) syncobj_wait (invalid-signal-zero-handles)
[186.797908] Starting subtest: invalid-signal-zero-handles
[186.798826] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[186.992910] [042/131] (836s left) gen9_exec_parse (bb-oversize)
[187.078783] Subtest bb-oversize: SKIP (0.000s)
[187.157767] [043/131] (836s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[187.233130] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[187.335743] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[187.518216] [044/131] (836s left) gem_exec_reloc (basic-write-cpu-noreloc)
[187.600318] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[187.676939] [045/131] (836s left) gem_mmap_offset (bad-flags)
[187.753007] Starting subtest: bad-flags
[187.753911] Subtest bad-flags: SUCCESS (0.000s)
[187.964907] [046/131] (835s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[188.150016] Starting subtest: cursor-vs-flip-legacy
[218.402100] Subtest cursor-vs-flip-legacy: SUCCESS (30.255s)
[218.682195] [047/131] (805s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[218.877159] Starting subtest: sprite-rotation-90-pos-100-0
[218.878930] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[219.043019] [048/131] (804s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[219.235761] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[220.508020] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.272s)
[220.706004] [049/131] (803s left) gem_create (busy-create)
[220.789291] Starting subtest: busy-create
[220.790210] Starting dynamic subtest: lmem0
[253.093159] Dynamic subtest lmem0: SUCCESS (32.309s)
[253.106172] Starting dynamic subtest: smem0
[285.363226] Dynamic subtest smem0: SUCCESS (32.264s)
[285.364405] Subtest busy-create: SUCCESS (64.574s)
[285.645224] [050/131] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[285.833402] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[288.261571] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.429s)
[288.478206] [051/131] (735s left) perf (invalid-open-flags)
[288.745142] Starting subtest: invalid-open-flags
[288.746115] Subtest invalid-open-flags: SUCCESS (0.000s)
[288.806105] [052/131] (735s left) perf (oa-formats)
[289.025433] Starting subtest: oa-formats
[289.026318] Starting dynamic subtest: 0-rcs0
[289.052018] Dynamic subtest 0-rcs0: SUCCESS (0.026s)
[289.052950] Subtest oa-formats: SUCCESS (0.027s)
[289.106605] [053/131] (735s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[289.298253] Starting subtest: 4-tiled-8bpp-rotate-270
[289.361020] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.062s)
[289.593691] [054/131] (734s left) kms_cursor_crc (cursor-onscreen-64x21)
[289.933849] Starting subtest: cursor-onscreen-64x21
[289.938113] Starting dynamic subtest: pipe-A-DP-3
[292.810091] Dynamic subtest pipe-A-DP-3: SUCCESS (2.870s)
[292.863882] Starting dynamic subtest: pipe-D-DP-3
[295.418578] Dynamic subtest pipe-D-DP-3: SUCCESS (2.567s)
[295.419444] Subtest cursor-onscreen-64x21: SUCCESS (5.485s)
[295.927169] [055/131] (728s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[296.114940] Starting subtest: primary-4-tiled-reflect-x-180
[306.512134] Subtest primary-4-tiled-reflect-x-180: SUCCESS (10.399s)
[306.923994] [056/131] (717s left) kms_cursor_crc (cursor-onscreen-256x256)
[307.329962] Starting subtest: cursor-onscreen-256x256
[307.333225] Starting dynamic subtest: pipe-A-DP-3
[310.154454] Dynamic subtest pipe-A-DP-3: SUCCESS (2.821s)
[310.192648] Starting dynamic subtest: pipe-D-DP-3
[312.932160] Dynamic subtest pipe-D-DP-3: SUCCESS (2.752s)
[312.933131] Subtest cursor-onscreen-256x256: SUCCESS (5.604s)
[313.373804] [057/131] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[313.566781] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[313.568519] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[313.769573] [058/131] (710s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[313.954735] Starting subtest: async-flip-with-page-flip-events-tiled
[314.182892] Starting dynamic subtest: pipe-A-DP-3-4
[316.447681] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.265s)
[316.460204] Starting dynamic subtest: pipe-A-DP-3-x
[318.629024] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.181s)
[318.850277] Starting dynamic subtest: pipe-B-DP-3-4
[321.078513] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.242s)
[321.099408] Starting dynamic subtest: pipe-B-DP-3-x
[323.242944] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.164s)
[323.457561] Starting dynamic subtest: pipe-C-DP-3-4
[325.673497] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.228s)
[325.686297] Starting dynamic subtest: pipe-C-DP-3-x
[327.837996] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.164s)
[328.048666] Starting dynamic subtest: pipe-D-DP-3-4
[330.273459] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.237s)
[330.286388] Starting dynamic subtest: pipe-D-DP-3-x
[332.437848] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.164s)
[332.438806] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.487s)
[332.943749] [059/131] (691s left) perf (polling)
[333.182044] Starting subtest: polling
[333.183022] Starting dynamic subtest: 0-rcs0
[343.199560] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[343.200369] Subtest polling: SUCCESS (10.020s)
[343.251907] [060/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[343.440741] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[343.442479] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[343.628376] [061/131] (681s left) syncobj_timeline (reset-signaled)
[343.707995] Starting subtest: reset-signaled
[343.708971] Subtest reset-signaled: SUCCESS (0.000s)
[343.859201] [062/131] (681s left) kms_rmfb (rmfb-ioctl)
[344.052988] Starting subtest: rmfb-ioctl
[344.053854] Starting dynamic subtest: pipe-A-DP-3
[344.204212] Dynamic subtest pipe-A-DP-3: SUCCESS (0.151s)
[344.232423] Starting dynamic subtest: pipe-B-DP-3
[344.482271] Dynamic subtest pipe-B-DP-3: SUCCESS (0.276s)
[344.495708] Starting dynamic subtest: pipe-C-DP-3
[344.748717] Dynamic subtest pipe-C-DP-3: SUCCESS (0.265s)
[344.762208] Starting dynamic subtest: pipe-D-DP-3
[344.997282] Dynamic subtest pipe-D-DP-3: SUCCESS (0.247s)
[344.998175] Subtest rmfb-ioctl: SUCCESS (0.946s)
[345.328350] [063/131] (679s left) gem_userptr_blits (create-destroy-sync)
[345.418025] Starting subtest: create-destroy-sync
[350.433330] Subtest create-destroy-sync: SUCCESS (5.016s)
[350.652559] [064/131] (674s left) gem_exec_reloc (basic-gtt-cpu-active)
[350.735438] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[350.820199] [065/131] (674s left) api_intel_allocator (execbuf-with-allocator)
[350.897069] Starting subtest: execbuf-with-allocator
[350.929180] Subtest execbuf-with-allocator: SUCCESS (0.032s)
[351.153769] [066/131] (674s left) kms_lease (cursor-implicit-plane)
[351.340995] Starting subtest: cursor-implicit-plane
[351.341910] Starting dynamic subtest: pipe-A-DP-3
[351.687881] Dynamic subtest pipe-A-DP-3: SUCCESS (0.345s)
[351.703845] Starting dynamic subtest: pipe-B-DP-3
[351.987235] Dynamic subtest pipe-B-DP-3: SUCCESS (0.297s)
[352.003223] Starting dynamic subtest: pipe-C-DP-3
[352.277121] Dynamic subtest pipe-C-DP-3: SUCCESS (0.289s)
[352.295984] Starting dynamic subtest: pipe-D-DP-3
[352.556839] Dynamic subtest pipe-D-DP-3: SUCCESS (0.277s)
[352.557854] Subtest cursor-implicit-plane: SUCCESS (1.218s)
[352.880639] [067/131] (672s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[353.070176] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[353.071936] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[353.232295] [068/131] (672s left) syncobj_wait (invalid-signal-illegal-handle)
[353.311231] Starting subtest: invalid-signal-illegal-handle
[353.312149] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[353.515996] [069/131] (672s left) kms_psr (psr-primary-blt)
[353.701039] Subtest psr-primary-blt: SKIP (0.000s)
[353.758311] [070/131] (671s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[353.952044] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[353.952946] Starting dynamic subtest: pipe-A-DP-3
[353.974112] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[353.986651] Starting dynamic subtest: pipe-B-DP-3
[354.007961] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[354.020529] Starting dynamic subtest: pipe-C-DP-3
[354.047713] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[354.060865] Starting dynamic subtest: pipe-D-DP-3
[354.086881] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[354.088900] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.014s)
[354.424989] [071/131] (671s left) kms_psr (pr-primary-blt)
[354.611982] Subtest pr-primary-blt: SKIP (0.000s)
[354.667800] [072/131] (671s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[354.858900] Starting subtest: psr-2p-primscrn-spr-indfb-move
[354.860610] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[355.056725] [073/131] (670s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[355.249076] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[355.249959] Starting dynamic subtest: pipe-A-valid-mode
[357.708914] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.459s)
[357.714031] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.463s)
[358.041337] [074/131] (667s left) gem_exec_schedule (u-semaphore-noskip)
[358.133354] Starting subtest: u-semaphore-noskip
[358.894757] Subtest u-semaphore-noskip: SUCCESS (0.761s)
[359.291720] [075/131] (666s left) i915_drm_fdinfo (memory-info-idle)
[359.360207] Starting subtest: memory-info-idle
[359.361131] Starting dynamic subtest: lmem0
[359.440131] Dynamic subtest lmem0: SUCCESS (0.079s)
[359.455898] Starting dynamic subtest: smem0
[359.506070] Dynamic subtest smem0: SUCCESS (0.065s)
[359.507189] Subtest memory-info-idle: SUCCESS (0.147s)
[359.656384] [076/131] (666s left) i915_selftest (live)
[360.783244] Starting subtest: live
[360.784276] Starting dynamic subtest: sanitycheck
[362.323838] Dynamic subtest sanitycheck: SUCCESS (1.540s)
[362.334304] Starting dynamic subtest: uncore
[363.838957] Dynamic subtest uncore: SUCCESS (1.514s)
[363.852287] Starting dynamic subtest: workarounds
[380.512623] Dynamic subtest workarounds: FAIL (16.471s)
[380.521713] Starting dynamic subtest: gt_engines
[382.645129] Dynamic subtest gt_engines: SUCCESS (2.331s)
[382.659774] Starting dynamic subtest: gt_timelines
[402.666690] Dynamic subtest gt_timelines: SUCCESS (20.015s)
[402.676865] Starting dynamic subtest: gt_contexts
[404.244879] Dynamic subtest gt_contexts: SUCCESS (1.577s)
[404.258606] Starting dynamic subtest: gt_lrc
[410.477715] Dynamic subtest gt_lrc: SUCCESS (6.230s)
[410.488659] Starting dynamic subtest: gt_mocs
[413.419782] Dynamic subtest gt_mocs: SUCCESS (2.940s)
[413.433262] Starting dynamic subtest: gt_pm
[417.593836] Dynamic subtest gt_pm: SUCCESS (4.172s)
[417.604709] Starting dynamic subtest: gt_heartbeat
[419.133802] Dynamic subtest gt_heartbeat: SUCCESS (1.538s)
[419.144544] Starting dynamic subtest: gt_tlb
[431.741848] Dynamic subtest gt_tlb: SUCCESS (12.606s)
[431.752485] Starting dynamic subtest: requests
[445.054971] Dynamic subtest requests: SUCCESS (13.312s)
[445.065919] Starting dynamic subtest: migrate
[450.225934] Dynamic subtest migrate: SUCCESS (5.170s)
[450.236885] Starting dynamic subtest: active
[451.756883] Dynamic subtest active: SUCCESS (1.530s)
[451.771537] Starting dynamic subtest: objects
[454.018693] Dynamic subtest objects: SUCCESS (2.261s)
[454.029249] Starting dynamic subtest: mman
[460.823003] Dynamic subtest mman: SUCCESS (6.803s)
[460.834367] Starting dynamic subtest: dmabuf
[462.395732] Dynamic subtest dmabuf: SUCCESS (1.571s)
[462.406199] Starting dynamic subtest: vma
[463.901796] Dynamic subtest vma: SUCCESS (1.505s)
[463.912612] Starting dynamic subtest: coherency
[468.115824] Dynamic subtest coherency: SUCCESS (4.213s)
[468.126033] Starting dynamic subtest: gtt
[478.183811] Dynamic subtest gtt: SUCCESS (10.068s)
[478.196159] Starting dynamic subtest: gem
[479.885984] Dynamic subtest gem: SUCCESS (1.701s)
[479.897749] Starting dynamic subtest: evict
[482.840261] Dynamic subtest evict: SUCCESS (2.953s)
[482.852951] Starting dynamic subtest: hugepages
[500.861083] Dynamic subtest hugepages: SUCCESS (18.020s)
[500.881989] Starting dynamic subtest: gem_contexts
[532.784669] Dynamic subtest gem_contexts: SUCCESS (31.926s)
[532.795241] Starting dynamic subtest: client
[534.335777] Dynamic subtest client: SUCCESS (1.550s)
[534.346948] Starting dynamic subtest: gem_migrate
[537.753751] Dynamic subtest gem_migrate: SUCCESS (3.417s)
[537.764440] Starting dynamic subtest: reset
[539.350769] Dynamic subtest reset: SUCCESS (1.596s)
[539.361453] Starting dynamic subtest: memory_region
[542.479842] Dynamic subtest memory_region: SUCCESS (3.128s)
[542.490874] Starting dynamic subtest: hangcheck
[572.307983] Dynamic subtest hangcheck: SUCCESS (29.832s)
[572.320317] Starting dynamic subtest: execlists
[573.810019] Dynamic subtest execlists: SUCCESS (1.501s)
[573.823594] Starting dynamic subtest: ring_submission
[575.365977] Dynamic subtest ring_submission: SUCCESS (1.555s)
[575.376679] Starting dynamic subtest: perf
[576.988897] Dynamic subtest perf: SUCCESS (1.622s)
[577.002705] Starting dynamic subtest: slpc
[584.194699] Dynamic subtest slpc: SUCCESS (7.206s)
[584.205100] Starting dynamic subtest: guc
[587.084827] Dynamic subtest guc: SUCCESS (2.890s)
[587.095992] Starting dynamic subtest: guc_multi_lrc
[588.647070] Dynamic subtest guc_multi_lrc: SUCCESS (1.561s)
[588.659153] Starting dynamic subtest: guc_hang
[590.979608] Dynamic subtest guc_hang: SUCCESS (2.332s)
[590.990152] Starting dynamic subtest: late_gt_pm
[592.557036] Dynamic subtest late_gt_pm: SUCCESS (1.576s)
[592.558032] Subtest live: FAIL (231.786s)
[592.590025] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[592.590957] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[592.592704] [077/131] (433s left) gem_userptr_blits (nohangcheck)
[594.149277] Starting subtest: nohangcheck
[594.482810] Subtest nohangcheck: SUCCESS (0.333s)
[594.637250] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[594.639486] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true
[594.642373] [078/131] (431s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[594.827194] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[594.828071] Starting dynamic subtest: pipe-A-DP-3
[594.836360] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[594.848113] Starting dynamic subtest: pipe-B-DP-3
[594.856578] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[594.869128] Starting dynamic subtest: pipe-C-DP-3
[594.877399] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[594.889225] Starting dynamic subtest: pipe-D-DP-3
[594.899854] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[594.902127] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[595.337083] [079/131] (430s left) gem_softpin (allocator-nopin)
[595.419579] Starting subtest: allocator-nopin
[595.673309] Subtest allocator-nopin: SUCCESS (0.245s)
[595.897121] [080/131] (430s left) kms_draw_crc (draw-method-pwrite)
[596.089996] Starting subtest: draw-method-pwrite
[596.090781] Starting dynamic subtest: xrgb8888-untiled
[596.510771] Dynamic subtest xrgb8888-untiled: SUCCESS (0.420s)
[596.555272] Starting dynamic subtest: rgb565-untiled
[596.959586] Dynamic subtest rgb565-untiled: SUCCESS (0.445s)
[596.975586] Starting dynamic subtest: xrgb2101010-untiled
[597.359125] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.398s)
[597.373195] Starting dynamic subtest: xbgr16161616f-untiled
[597.777095] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.416s)
[597.793067] Starting dynamic subtest: xrgb8888-xtiled
[598.326651] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.546s)
[598.343825] Starting dynamic subtest: rgb565-xtiled
[598.876035] Dynamic subtest rgb565-xtiled: SUCCESS (0.548s)
[598.891201] Starting dynamic subtest: xrgb2101010-xtiled
[599.392164] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.515s)
[599.405171] Starting dynamic subtest: xbgr16161616f-xtiled
[599.992162] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.599s)
[600.006560] Starting dynamic subtest: xrgb8888-4tiled
[600.393655] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.400s)
[600.409845] Starting dynamic subtest: rgb565-4tiled
[600.709099] Dynamic subtest rgb565-4tiled: SUCCESS (0.312s)
[600.724402] Starting dynamic subtest: xrgb2101010-4tiled
[601.093320] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.382s)
[601.113285] Starting dynamic subtest: xbgr16161616f-4tiled
[601.708586] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.612s)
[601.709552] Subtest draw-method-pwrite: SUCCESS (5.621s)
[601.870713] [081/131] (424s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[602.063555] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[602.065219] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[602.261112] [082/131] (424s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[602.449843] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[602.451653] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[602.660010] [083/131] (423s left) syncobj_timeline (host-signal-points)
[602.735138] Starting subtest: host-signal-points
[602.741726] Subtest host-signal-points: SUCCESS (0.007s)
[602.926503] [084/131] (423s left) gem_mmap_gtt (basic-small-bo)
[603.005951] Subtest basic-small-bo: SKIP (0.000s)
[603.087870] [085/131] (423s left) perf_pmu (semaphore-wait-idle)
[603.155892] Starting subtest: semaphore-wait-idle
[603.156817] Starting dynamic subtest: rcs0
[603.700202] Dynamic subtest rcs0: SUCCESS (0.543s)
[603.715665] Starting dynamic subtest: bcs0
[604.212644] Dynamic subtest bcs0: SUCCESS (0.509s)
[604.228920] Starting dynamic subtest: vcs0
[604.726107] Dynamic subtest vcs0: SUCCESS (0.509s)
[604.742398] Starting dynamic subtest: vcs1
[605.239738] Dynamic subtest vcs1: SUCCESS (0.508s)
[605.256348] Starting dynamic subtest: vecs0
[605.752902] Dynamic subtest vecs0: SUCCESS (0.509s)
[605.770120] Starting dynamic subtest: vecs1
[606.266905] Dynamic subtest vecs1: SUCCESS (0.509s)
[606.283351] Starting dynamic subtest: ccs0
[606.780703] Dynamic subtest ccs0: SUCCESS (0.509s)
[606.785519] Subtest semaphore-wait-idle: SUCCESS (3.627s)
[607.024373] [086/131] (419s left) kms_addfb_basic (no-handle)
[607.106310] Starting subtest: no-handle
[607.107208] Subtest no-handle: SUCCESS (0.000s)
[607.443431] [087/131] (419s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[607.635774] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[607.637555] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[607.841673] [088/131] (419s left) gem_render_copy (yf-tiled-ccs-to-linear)
[607.922278] Starting subtest: yf-tiled-ccs-to-linear
[607.924186] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[608.163178] [089/131] (418s left) kms_flip (wf_vblank-ts-check)
[608.348955] Starting subtest: wf_vblank-ts-check
[608.352307] Starting dynamic subtest: A-DP3
[616.624858] Dynamic subtest A-DP3: SUCCESS (8.274s)
[616.640917] Starting dynamic subtest: B-DP3
[624.842736] Dynamic subtest B-DP3: SUCCESS (8.218s)
[624.857239] Starting dynamic subtest: C-DP3
[632.893901] Dynamic subtest C-DP3: SUCCESS (8.049s)
[632.908284] Starting dynamic subtest: D-DP3
[640.951315] Dynamic subtest D-DP3: SUCCESS (8.050s)
[640.953694] Subtest wf_vblank-ts-check: SUCCESS (32.602s)
[641.299273] [090/131] (385s left) gem_exec_schedule (deep)
[641.544073] Starting subtest: deep
[641.545332] Starting dynamic subtest: rcs0
[656.508091] Dynamic subtest rcs0: SUCCESS (14.956s)
[656.521146] Starting dynamic subtest: bcs0
[671.607151] Dynamic subtest bcs0: SUCCESS (15.091s)
[671.620400] Starting dynamic subtest: vcs0
[686.917646] Dynamic subtest vcs0: SUCCESS (15.304s)
[686.930597] Starting dynamic subtest: vcs1
[702.208270] Dynamic subtest vcs1: SUCCESS (15.286s)
[702.221582] Starting dynamic subtest: vecs0
[717.268371] Dynamic subtest vecs0: SUCCESS (15.056s)
[717.281578] Starting dynamic subtest: vecs1
[733.175163] Dynamic subtest vecs1: SUCCESS (15.904s)
[733.188196] Starting dynamic subtest: ccs0
[748.434418] Dynamic subtest ccs0: SUCCESS (15.257s)
[748.435316] Subtest deep: SUCCESS (106.863s)
[749.468107] [091/131] (277s left) kms_sequence (queue-idle)
[749.655020] Starting subtest: queue-idle
[749.655947] Starting dynamic subtest: pipe-A-DP-3
[752.022196] Dynamic subtest pipe-A-DP-3: SUCCESS (2.366s)
[752.037683] Starting dynamic subtest: pipe-B-DP-3
[754.323189] Dynamic subtest pipe-B-DP-3: SUCCESS (2.299s)
[754.339318] Starting dynamic subtest: pipe-C-DP-3
[756.608388] Dynamic subtest pipe-C-DP-3: SUCCESS (2.283s)
[756.623036] Starting dynamic subtest: pipe-D-DP-3
[758.881651] Dynamic subtest pipe-D-DP-3: SUCCESS (2.271s)
[758.882781] Subtest queue-idle: SUCCESS (9.227s)
[759.162306] [092/131] (268s left) gem_gtt_cpu_tlb
[759.309180] [093/131] (268s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[759.500016] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[759.501792] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[759.702800] [094/131] (267s left) gem_eio (create-ext)
[760.005214] Starting subtest: create-ext
[760.506085] Subtest create-ext: SUCCESS (0.501s)
[760.787660] [095/131] (266s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[760.872222] Subtest writes-after-reads-uncached: SKIP (0.000s)
[760.961989] [096/131] (266s left) sysfs_preempt_timeout (idempotent)
[761.042287] Starting subtest: idempotent
[761.044463] Starting dynamic subtest: vecs0
[761.045283] Dynamic subtest vecs0: SUCCESS (0.001s)
[761.058555] Starting dynamic subtest: ccs0
[761.059671] Dynamic subtest ccs0: SUCCESS (0.001s)
[761.072305] Starting dynamic subtest: vcs0
[761.073196] Dynamic subtest vcs0: SUCCESS (0.001s)
[761.086292] Starting dynamic subtest: bcs0
[761.087356] Dynamic subtest bcs0: SUCCESS (0.001s)
[761.100222] Starting dynamic subtest: vecs1
[761.101267] Dynamic subtest vecs1: SUCCESS (0.001s)
[761.114416] Starting dynamic subtest: rcs0
[761.115555] Dynamic subtest rcs0: SUCCESS (0.001s)
[761.130089] Starting dynamic subtest: vcs1
[761.131761] Dynamic subtest vcs1: SUCCESS (0.001s)
[761.132682] Subtest idempotent: SUCCESS (0.012s)
[761.180584] [097/131] (266s left) gem_busy (semaphore)
[761.419152] Subtest semaphore: SKIP (0.000s)
[761.735359] [098/131] (265s left) sriov_basic (enable-vfs-bind-unbind-each)
[761.817228] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[761.902652] [099/131] (265s left) kms_pm_lpsp (screens-disabled)
[763.089981] Starting subtest: screens-disabled
[763.091691] Subtest screens-disabled: SKIP (0.000s)
[763.244827] [100/131] (264s left) gem_exec_capture (capture-invisible)
[763.329611] Starting subtest: capture-invisible
[763.330553] Starting dynamic subtest: lmem0
[763.332210] Dynamic subtest lmem0: SKIP (0.000s)
[763.345950] Starting dynamic subtest: smem0
[763.347975] Dynamic subtest smem0: SKIP (0.000s)
[763.350230] Subtest capture-invisible: SKIP (0.002s)
[763.532668] [101/131] (264s left) gem_lmem_swapping (verify-ccs)
[766.171042] Starting subtest: verify-ccs
[766.171945] Starting dynamic subtest: lmem0
[810.662993] Dynamic subtest lmem0: SUCCESS (44.492s)
[810.663950] Subtest verify-ccs: SUCCESS (44.493s)
[812.940543] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[812.941476] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[812.943455] [102/131] (215s left) kms_joiner (basic-force-ultra-joiner)
[814.584026] Starting subtest: basic-force-ultra-joiner
[814.585744] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[814.787424] [FACT kms_joiner (basic-force-ultra-joiner)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[814.789651] [FACT kms_joiner (basic-force-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true
[814.792577] [103/131] (213s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[814.986008] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[814.987746] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[815.180719] [104/131] (212s left) kms_color (legacy-gamma)
[815.360705] Starting subtest: legacy-gamma
[815.361640] Starting dynamic subtest: pipe-A-DP-3
[816.046059] Dynamic subtest pipe-A-DP-3: SUCCESS (0.684s)
[816.064156] Starting dynamic subtest: pipe-B-DP-3
[816.647406] Dynamic subtest pipe-B-DP-3: SUCCESS (0.600s)
[816.668008] Starting dynamic subtest: pipe-C-DP-3
[817.241052] Dynamic subtest pipe-C-DP-3: SUCCESS (0.591s)
[817.255753] Starting dynamic subtest: pipe-D-DP-3
[817.848277] Dynamic subtest pipe-D-DP-3: SUCCESS (0.606s)
[817.849297] Subtest legacy-gamma: SUCCESS (2.488s)
[818.154133] [105/131] (210s left) gem_exec_schedule (wide)
[818.367218] Starting subtest: wide
[818.368183] Starting dynamic subtest: rcs0
[830.745554] Dynamic subtest rcs0: SUCCESS (12.379s)
[830.760200] Starting dynamic subtest: bcs0
[843.970509] Dynamic subtest bcs0: SUCCESS (13.222s)
[844.013637] Starting dynamic subtest: vcs0
[857.448509] Dynamic subtest vcs0: SUCCESS (13.479s)
[857.461941] Starting dynamic subtest: vcs1
[870.806713] Dynamic subtest vcs1: SUCCESS (13.358s)
[870.821301] Starting dynamic subtest: vecs0
[884.276689] Dynamic subtest vecs0: SUCCESS (13.464s)
[884.291554] Starting dynamic subtest: vecs1
[897.273365] Dynamic subtest vecs1: SUCCESS (12.999s)
[897.286526] Starting dynamic subtest: ccs0
[910.649395] Dynamic subtest ccs0: SUCCESS (13.373s)
[910.650297] Subtest wide: SUCCESS (92.285s)
[912.609643] [106/131] (115s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[912.800215] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[912.801078] Starting dynamic subtest: pipe-A-valid-mode
[912.883901] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[912.885737] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.083s)
[913.135798] [107/131] (115s left) kms_big_fb (linear-64bpp-rotate-180)
[913.329945] Starting subtest: linear-64bpp-rotate-180
[915.770729] Subtest linear-64bpp-rotate-180: SUCCESS (2.440s)
[916.021919] [108/131] (112s left) gem_ppgtt (blt-vs-render-ctxn)
[916.111164] Starting subtest: blt-vs-render-ctxN
[949.151321] Subtest blt-vs-render-ctxN: SUCCESS (33.036s)
[949.384221] [109/131] ( 79s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[949.602074] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[949.603808] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[949.808260] [110/131] ( 78s left) kms_chamelium_frames (dp-frame-dump)
[950.067079] Subtest dp-frame-dump: SKIP (0.000s)
[950.214613] [111/131] ( 78s left) kms_psr2_su (page_flip-nv12)
[950.289000] Subtest page_flip-NV12: SKIP (0.000s)
[950.405455] [112/131] ( 78s left) gem_tiling_max_stride
[950.552112] [113/131] ( 78s left) perf_pmu (busy-idle)
[950.622941] Starting subtest: busy-idle
[950.623916] Starting dynamic subtest: rcs0
[951.349463] Dynamic subtest rcs0: SUCCESS (0.725s)
[951.371195] Starting dynamic subtest: bcs0
[952.018391] Dynamic subtest bcs0: SUCCESS (0.664s)
[952.035840] Starting dynamic subtest: vcs0
[952.685427] Dynamic subtest vcs0: SUCCESS (0.662s)
[952.702658] Starting dynamic subtest: vcs1
[953.353439] Dynamic subtest vcs1: SUCCESS (0.663s)
[953.375280] Starting dynamic subtest: vecs0
[954.020360] Dynamic subtest vecs0: SUCCESS (0.662s)
[954.038035] Starting dynamic subtest: vecs1
[954.688388] Dynamic subtest vecs1: SUCCESS (0.663s)
[954.737236] Starting dynamic subtest: ccs0
[955.377356] Dynamic subtest ccs0: SUCCESS (0.684s)
[955.382899] Subtest busy-idle: SUCCESS (4.756s)
[955.590452] [114/131] ( 73s left) dmabuf_sync_file (export-before-signal)
[955.640136] Starting subtest: export-before-signal
[955.641007] Subtest export-before-signal: SUCCESS (0.001s)
[955.760578] [115/131] ( 73s left) gem_exec_reloc (basic-cpu-read)
[955.844166] Subtest basic-cpu-read: SKIP (0.000s)
[955.953123] [116/131] ( 73s left) kms_hdr (bpc-switch)
[956.142185] Starting subtest: bpc-switch
[959.470259] Starting dynamic subtest: pipe-A-DP-3
[960.507030] Dynamic subtest pipe-A-DP-3: SUCCESS (1.037s)
[960.508068] Subtest bpc-switch: SUCCESS (4.366s)
[960.886930] [117/131] ( 68s left) perf (i915-ref-count)
[961.060607] Starting subtest: i915-ref-count
[961.335098] Subtest i915-ref-count: SUCCESS (0.276s)
[961.499292] [118/131] ( 67s left) gem_ctx_isolation (nonpriv)
[961.583447] Starting subtest: nonpriv
[961.584363] Starting dynamic subtest: rcs0
[962.350994] Dynamic subtest rcs0: SUCCESS (0.767s)
[962.367021] Starting dynamic subtest: bcs0
[963.155452] Dynamic subtest bcs0: SUCCESS (0.803s)
[963.170980] Starting dynamic subtest: vcs0
[963.954248] Dynamic subtest vcs0: SUCCESS (0.798s)
[963.969502] Starting dynamic subtest: vcs1
[964.766169] Dynamic subtest vcs1: SUCCESS (0.811s)
[964.781655] Starting dynamic subtest: vecs0
[965.586902] Dynamic subtest vecs0: SUCCESS (0.819s)
[965.601284] Starting dynamic subtest: vecs1
[966.397169] Dynamic subtest vecs1: SUCCESS (0.809s)
[966.412319] Starting dynamic subtest: ccs0
[967.187241] Dynamic subtest ccs0: SUCCESS (0.789s)
[967.188162] Subtest nonpriv: SUCCESS (5.604s)
[967.582784] [119/131] ( 61s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[967.665342] Starting subtest: y-tiled-to-vebox-x-tiled
[967.667371] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[967.938391] [120/131] ( 61s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[968.121207] Starting subtest: plane-use-after-nonblocking-unbind
[968.122074] Starting dynamic subtest: pipe-A-DP-3
[968.200817] Dynamic subtest pipe-A-DP-3: SUCCESS (0.080s)
[968.312801] Starting dynamic subtest: pipe-B-DP-3
[968.500897] Dynamic subtest pipe-B-DP-3: SUCCESS (0.207s)
[968.558140] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.437s)
[968.833450] [121/131] ( 60s left) i915_hangman (engine-error-state-capture)
[968.930207] Starting subtest: engine-error-state-capture
[968.931087] Starting dynamic subtest: rcs0
[971.150605] Dynamic subtest rcs0: SUCCESS (2.220s)
[971.167845] Starting dynamic subtest: bcs0
[975.139492] Dynamic subtest bcs0: SUCCESS (3.987s)
[975.154987] Starting dynamic subtest: vcs0
[979.133324] Dynamic subtest vcs0: SUCCESS (3.992s)
[979.149915] Starting dynamic subtest: vcs1
[983.177403] Dynamic subtest vcs1: SUCCESS (4.043s)
[983.211942] Starting dynamic subtest: vecs0
[987.148341] Dynamic subtest vecs0: SUCCESS (3.969s)
[987.166332] Starting dynamic subtest: vecs1
[991.163177] Dynamic subtest vecs1: SUCCESS (4.013s)
[991.180777] Starting dynamic subtest: ccs0
[995.123141] Dynamic subtest ccs0: SUCCESS (3.958s)
[995.124068] Subtest engine-error-state-capture: SUCCESS (26.193s)
[995.327033] [122/131] ( 34s left) gem_exec_schedule (pi-shared-iova)
[995.532297] Starting subtest: pi-shared-iova
[995.533208] Starting dynamic subtest: rcs0
[995.792842] Dynamic subtest rcs0: SUCCESS (0.260s)
[995.807272] Starting dynamic subtest: bcs0
[995.967031] Dynamic subtest bcs0: SUCCESS (0.173s)
[995.981335] Starting dynamic subtest: vcs0
[996.149972] Dynamic subtest vcs0: SUCCESS (0.182s)
[996.164286] Starting dynamic subtest: vcs1
[996.335316] Dynamic subtest vcs1: SUCCESS (0.184s)
[996.349778] Starting dynamic subtest: vecs0
[996.522142] Dynamic subtest vecs0: SUCCESS (0.186s)
[996.536413] Starting dynamic subtest: vecs1
[996.705821] Dynamic subtest vecs1: SUCCESS (0.183s)
[996.720286] Starting dynamic subtest: ccs0
[996.896074] Dynamic subtest ccs0: SUCCESS (0.189s)
[996.897004] Subtest pi-shared-iova: SUCCESS (1.364s)
[997.363292] [123/131] ( 32s left) syncobj_wait (invalid-reset-illegal-handle)
[997.447153] Starting subtest: invalid-reset-illegal-handle
[997.448073] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[997.586392] [124/131] ( 32s left) syncobj_wait (single-wait-all-for-submit-signaled)
[997.663148] Starting subtest: single-wait-all-for-submit-signaled
[997.664062] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[997.862252] [125/131] ( 31s left) kms_cursor_crc (cursor-sliding-512x170)
[998.331758] Starting subtest: cursor-sliding-512x170
[998.333375] Subtest cursor-sliding-512x170: SKIP (0.001s)
[998.632169] [126/131] ( 31s left) kms_chamelium_hpd (hdmi-hpd-fast)
[998.904136] Subtest hdmi-hpd-fast: SKIP (0.000s)
[999.056565] [127/131] ( 30s left) gem_ctx_persistence (hostile)
[999.141287] Starting subtest: hostile
[1008.007338] Subtest hostile: SUCCESS (8.861s)
[1008.187450] [128/131] ( 21s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[1008.372946] Starting subtest: fbc-rgb565-draw-blt
[1011.184278] Subtest fbc-rgb565-draw-blt: SUCCESS (2.812s)
[1011.438286] [129/131] ( 18s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[1011.629665] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[1011.631292] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[1011.837835] [130/131] ( 18s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[1012.033850] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[1012.035591] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[1012.256103] [131/131] ( 17s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[1012.446952] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[1012.448712] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[1012.651634] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_exec_nop
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_pm_rps
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_panel_fitting
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_unref_active_buffers
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_rmfb
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_sequence
results: parsing output: 91/ for test: gem_gtt_cpu_tlb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: sysfs_preempt_timeout
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_pm_lpsp
results: parsing output: 99/ for test: gem_exec_capture
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ppgtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: kms_psr2_su
results: parsing output: 111/ for test: gem_tiling_max_stride
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_hdr
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.