[58.564716] Initializing watchdogs
[58.564767]   /dev/watchdog0
[58.578758] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.582908] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.585114] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.588333] [001/132] (960s left) gem_exec_balancer (noheartbeat)
[58.873128] Starting subtest: noheartbeat
[58.878029] Subtest noheartbeat: SKIP (0.000s)
[59.019048] [002/132] (960s left) prime_vgem (basic-gtt)
[59.118963] Starting subtest: basic-gtt
[59.123611] Subtest basic-gtt: SKIP (0.000s)
[59.244109] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[59.247050] [003/132] (959s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[59.356402] Starting subtest: fbc-1p-pri-indfb-multidraw
[72.896048] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.582s)
[74.264158] [004/132] (944s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[74.360898] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[83.664049] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.307s)
[83.823442] [005/132] (935s left) kms_rmfb (rmfb-ioctl)
[83.922441] Starting subtest: rmfb-ioctl
[83.924631] Starting dynamic subtest: pipe-A-eDP-1
[84.026788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[84.036844] Starting dynamic subtest: pipe-B-eDP-1
[85.255420] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s)
[85.264139] Starting dynamic subtest: pipe-C-eDP-1
[86.476507] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.220s)
[86.486948] Starting dynamic subtest: pipe-D-eDP-1
[87.617560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[87.619868] Subtest rmfb-ioctl: SUCCESS (3.696s)
[88.852931] [006/132] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[88.956714] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[95.536921] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.581s)
[95.711026] [007/132] (923s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[96.107641] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[96.956796] [008/132] (922s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[97.072619] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[97.075506] Starting dynamic subtest: pipe-A-default-mode
[98.244048] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[98.248349] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.174s)
[98.446460] [009/132] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[98.549628] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[98.553691] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[98.686218] [010/132] (920s left) gem_exec_reloc (basic-write-read-noreloc)
[98.763185] Subtest basic-write-read-noreloc: SKIP (0.000s)
[98.855648] [011/132] (920s left) kms_draw_crc (draw-method-blt)
[98.945121] Starting subtest: draw-method-blt
[98.947276] Starting dynamic subtest: xrgb8888-untiled
[99.176777] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[99.184694] Starting dynamic subtest: rgb565-untiled
[99.409926] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[99.417913] Starting dynamic subtest: xrgb2101010-untiled
[99.632169] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[99.639329] Starting dynamic subtest: xbgr16161616f-untiled
[99.854510] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[99.862756] Starting dynamic subtest: xrgb8888-xtiled
[99.976911] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[99.985233] Starting dynamic subtest: rgb565-xtiled
[100.099473] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[100.111427] Starting dynamic subtest: xrgb2101010-xtiled
[100.210107] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[100.218558] Starting dynamic subtest: xbgr16161616f-xtiled
[100.321239] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[100.329159] Starting dynamic subtest: xrgb8888-4tiled
[100.432366] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[100.440813] Starting dynamic subtest: rgb565-4tiled
[100.532216] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[100.539934] Starting dynamic subtest: xrgb2101010-4tiled
[100.643411] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[100.650968] Starting dynamic subtest: xbgr16161616f-4tiled
[100.765528] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[100.767487] Subtest draw-method-blt: SUCCESS (1.822s)
[100.941402] [012/132] (918s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[101.042982] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[101.044886] Starting dynamic subtest: pipe-A-eDP-1
[101.063271] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.073032] Starting dynamic subtest: pipe-B-eDP-1
[101.091519] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.100139] Starting dynamic subtest: pipe-C-eDP-1
[101.117783] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.124765] Starting dynamic subtest: pipe-D-eDP-1
[101.142783] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.146302] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[103.295692] [013/132] (916s left) perf (gen12-group-exclusive-stream-sample-oa)
[103.452027] Starting subtest: gen12-group-exclusive-stream-sample-oa
[103.472141] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.022s)
[103.522488] [014/132] (916s left) gem_create (hog-create)
[103.587479] Starting subtest: hog-create
[103.589869] Starting dynamic subtest: smem0
[136.952079] Dynamic subtest smem0: SUCCESS (33.360s)
[136.954880] Subtest hog-create: SUCCESS (33.362s)
[137.168709] [015/132] (882s left) kms_cdclk (plane-scaling)
[137.273656] Starting subtest: plane-scaling
[137.275786] Starting dynamic subtest: pipe-A-eDP-1
[137.566369] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[137.575925] Starting dynamic subtest: pipe-B-eDP-1
[137.580930] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[137.589872] Starting dynamic subtest: pipe-C-eDP-1
[137.594460] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[137.601577] Starting dynamic subtest: pipe-D-eDP-1
[137.605720] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[137.609833] Subtest plane-scaling: SKIP (0.296s)
[138.424616] [016/132] (881s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[138.524095] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[138.528313] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[138.662621] [017/132] (881s left) gem_softpin (softpin)
[138.732720] Starting subtest: softpin
[171.027654] Subtest softpin: SUCCESS (32.287s)
[171.199975] [018/132] (848s left) kms_joiner (basic-force-ultra-joiner)
[171.308657] Starting subtest: basic-force-ultra-joiner
[171.312821] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[171.398242] [019/132] (848s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[171.505327] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[171.516944] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[171.658228] [020/132] (848s left) syncobj_timeline (reset-multiple-signaled)
[171.722134] Starting subtest: reset-multiple-signaled
[171.724583] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[171.864521] [021/132] (848s left) drm_mm (drm_mm)
[171.897035] Starting subtest: drm_mm
[171.955604] Starting dynamic subtest: drm_test_mm_init
[172.097441] Dynamic subtest drm_test_mm_init: SUCCESS (0.141s)
[172.106503] Starting dynamic subtest: drm_test_mm_debug
[172.227451] Dynamic subtest drm_test_mm_debug: SUCCESS (0.128s)
[172.234949] Starting dynamic subtest: drm_test_mm_align32
[172.375722] Dynamic subtest drm_test_mm_align32: SUCCESS (0.148s)
[172.384105] Starting dynamic subtest: drm_test_mm_align64
[172.515557] Dynamic subtest drm_test_mm_align64: SUCCESS (0.140s)
[172.524536] Starting dynamic subtest: drm_test_mm_lowest
[172.662087] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.145s)
[172.669089] Starting dynamic subtest: drm_test_mm_highest
[172.791572] Dynamic subtest drm_test_mm_highest: SUCCESS (0.128s)
[172.793936] Subtest drm_mm: SUCCESS (0.894s)
[173.001175] [022/132] (846s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[177.985455] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[177.989970] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[178.860390] [023/132] (841s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[178.966765] Starting subtest: plane-ctm3x4-lut1d
[178.979965] Starting dynamic subtest: pipe-A-eDP-1
[179.710438] Dynamic subtest pipe-A-eDP-1: FAIL (0.349s)
[180.414787] Starting dynamic subtest: pipe-B-eDP-1
[181.237040] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[181.756047] Starting dynamic subtest: pipe-C-eDP-1
[182.571944] Dynamic subtest pipe-C-eDP-1: FAIL (0.236s)
[183.087864] Starting dynamic subtest: pipe-D-eDP-1
[183.909404] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[183.911693] Subtest plane-ctm3x4-lut1d: FAIL (4.642s)
[184.490904] [024/132] (835s left) kms_psr (fbc-psr-primary-mmap-gtt)
[184.608020] Starting subtest: fbc-psr-primary-mmap-gtt
[184.610297] Starting dynamic subtest: eDP-1
[184.614588] Dynamic subtest eDP-1: SKIP (0.000s)
[184.618921] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[184.707065] [025/132] (835s left) gem_exec_schedule (u-semaphore-user)
[184.778391] Starting subtest: u-semaphore-user
[184.830755] Subtest u-semaphore-user: SUCCESS (0.060s)
[185.939258] [026/132] (834s left) gem_userptr_blits (unsync-unmap-cycles)
[186.011486] Subtest unsync-unmap-cycles: SKIP (0.000s)
[186.179774] [027/132] (833s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[186.292752] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[186.294973] Starting dynamic subtest: pipe-A-default-mode
[186.590333] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[186.594967] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.295s)
[187.416145] [028/132] (832s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[187.525528] Starting subtest: fbc-rgb565-draw-pwrite
[192.109802] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.587s)
[193.332941] [029/132] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[193.437507] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[200.995034] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.560s)
[201.201251] [030/132] (819s left) kms_cursor_edge_walk (256x256-right-edge)
[201.314899] Starting subtest: 256x256-right-edge
[201.317215] Starting dynamic subtest: pipe-A-eDP-1
[204.820576] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[204.829330] Starting dynamic subtest: pipe-D-eDP-1
[207.942928] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[207.945349] Subtest 256x256-right-edge: SUCCESS (6.629s)
[208.773961] [031/132] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[208.875363] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[213.244386] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.371s)
[214.408758] [032/132] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[214.517056] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[214.521533] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[214.668707] [033/132] (805s left) i915_pm_rc6_residency (media-rc6-accuracy)
[214.735215] Starting subtest: media-rc6-accuracy
[214.739916] Subtest media-rc6-accuracy: SKIP (0.000s)
[214.868765] [034/132] (805s left) kms_async_flips (async-flip-hang)
[214.968341] Starting subtest: async-flip-hang
[215.361685] Starting dynamic subtest: pipe-A-eDP-1
[230.389043] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.025s)
[230.778627] Starting dynamic subtest: pipe-B-eDP-1
[246.388881] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.614s)
[246.784442] Starting dynamic subtest: pipe-C-eDP-1
[262.447748] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.664s)
[262.830188] Starting dynamic subtest: pipe-D-eDP-1
[278.384156] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.557s)
[278.386487] Subtest async-flip-hang: SUCCESS (63.413s)
[279.596171] [035/132] (740s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[279.697390] Starting subtest: fbc-rgb101010-draw-render
[284.317653] Subtest fbc-rgb101010-draw-render: SUCCESS (4.623s)
[285.506381] [036/132] (734s left) kms_pm_dc (dc5-psr)
[286.621030] Starting subtest: dc5-psr
[289.615303] Subtest dc5-psr: SUCCESS (2.992s)
[290.427785] [037/132] (730s left) kms_getfb (getfb-handle-valid)
[290.538586] Starting subtest: getfb-handle-valid
[290.540734] Subtest getfb-handle-valid: SUCCESS (0.000s)
[290.681394] [038/132] (729s left) perf (oa-formats)
[290.790769] Starting subtest: oa-formats
[290.793189] Starting dynamic subtest: 0-rcs0
[290.804627] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[290.813864] Starting dynamic subtest: 1-vcs0
[290.828374] Dynamic subtest 1-vcs0: SUCCESS (0.022s)
[290.830562] Subtest oa-formats: SUCCESS (0.038s)
[290.876024] [039/132] (729s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[290.955437] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[290.959622] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[291.160997] [040/132] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[291.264496] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[291.268712] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[291.433863] [041/132] (729s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[291.544702] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[291.546921] Starting dynamic subtest: pipe-A-eDP-1
[308.093103] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.488s)
[308.102690] Starting dynamic subtest: pipe-B-eDP-1
[326.057484] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[326.066978] Starting dynamic subtest: pipe-C-eDP-1
[344.035416] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.805s)
[344.045035] Starting dynamic subtest: pipe-D-eDP-1
[362.034478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.745s)
[362.036808] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (13.913s)
[368.313596] [042/132] (657s left) gem_exec_fence (keep-in-fence)
[368.510806] Starting subtest: keep-in-fence
[368.513292] Starting dynamic subtest: rcs0
[368.608222] Dynamic subtest rcs0: SUCCESS (0.101s)
[368.619057] Starting dynamic subtest: bcs0
[368.666802] Dynamic subtest bcs0: SUCCESS (0.059s)
[368.677250] Starting dynamic subtest: vcs0
[370.454640] Dynamic subtest vcs0: SUCCESS (1.837s)
[370.465508] Starting dynamic subtest: vcs1
[372.501131] Dynamic subtest vcs1: SUCCESS (2.093s)
[372.512799] Starting dynamic subtest: vecs0
[374.485863] Dynamic subtest vecs0: SUCCESS (2.018s)
[374.497212] Starting dynamic subtest: ccs0
[374.717851] Dynamic subtest ccs0: SUCCESS (0.234s)
[374.720454] Subtest keep-in-fence: SUCCESS (6.355s)
[376.609522] [043/132] (649s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[376.725548] Starting subtest: psr-rgb565-draw-pwrite
[383.747250] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.079s)
[383.896943] [044/132] (641s left) perf (per-context-mode-unprivileged)
[384.011232] Starting subtest: per-context-mode-unprivileged
[384.015790] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[384.057900] [045/132] (641s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[384.170555] Starting subtest: x-tiled-8bpp-rotate-0
[385.368597] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.202s)
[385.549336] [046/132] (640s left) gem_lmem_swapping (parallel-random-verify-ccs)
[385.590209] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[385.639618] [047/132] (640s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[385.748477] Starting subtest: 4-tiled-64bpp-rotate-180
[387.374066] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.631s)
[387.606258] [048/132] (638s left) gem_exec_schedule (preempt)
[387.679860] Starting subtest: preempt
[387.681777] Starting dynamic subtest: rcs0
[387.698514] Dynamic subtest rcs0: SUCCESS (0.024s)
[387.709412] Starting dynamic subtest: bcs0
[387.739675] Dynamic subtest bcs0: SUCCESS (0.041s)
[387.748094] Starting dynamic subtest: vcs0
[387.760007] Dynamic subtest vcs0: SUCCESS (0.020s)
[387.768100] Starting dynamic subtest: vcs1
[387.779931] Dynamic subtest vcs1: SUCCESS (0.019s)
[387.788303] Starting dynamic subtest: vecs0
[387.801586] Dynamic subtest vecs0: SUCCESS (0.021s)
[387.809965] Starting dynamic subtest: ccs0
[387.823496] Dynamic subtest ccs0: SUCCESS (0.021s)
[387.825449] Subtest preempt: SUCCESS (0.150s)
[389.597658] [049/132] (636s left) kms_flip (2x-wf_vblank-ts-check)
[389.686663] Starting subtest: 2x-wf_vblank-ts-check
[389.697550] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[389.834992] [050/132] (636s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[389.944051] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[389.946220] Starting dynamic subtest: pipe-A-eDP-1
[389.966036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[389.976195] Starting dynamic subtest: pipe-B-eDP-1
[389.994989] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[390.003292] Starting dynamic subtest: pipe-C-eDP-1
[390.021376] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[390.029602] Starting dynamic subtest: pipe-D-eDP-1
[390.048325] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[390.050428] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.013s)
[392.230280] [051/132] (633s left) sw_sync (alloc_timeline)
[392.267434] Starting subtest: alloc_timeline
[392.269733] Subtest alloc_timeline: SUCCESS (0.000s)
[392.345094] [052/132] (633s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[392.412031] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[392.414392] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[392.555120] [053/132] (633s left) kms_atomic_transition (modeset-transition-nonblocking)
[392.641748] Starting subtest: modeset-transition-nonblocking
[392.643983] Starting dynamic subtest: 1x-outputs
[403.453318] Dynamic subtest 1x-outputs: SUCCESS (10.817s)
[403.456206] Subtest modeset-transition-nonblocking: SUCCESS (10.818s)
[404.341356] [054/132] (621s left) kms_pm_rpm (cursor)
[406.675760] Starting subtest: cursor
[406.680637] Subtest cursor: SKIP (0.000s)
[407.077023] [055/132] (619s left) kms_selftest (drm_damage_helper)
[407.117588] Starting subtest: drm_damage_helper
[407.136429] Starting dynamic subtest: drm_test_damage_iter_no_damage
[407.255891] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.117s)
[407.266026] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[407.361385] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.106s)
[407.371584] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[407.491079] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.127s)
[407.501441] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[407.599352] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.110s)
[407.609808] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[407.722196] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.119s)
[407.732627] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[407.831433] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.110s)
[407.841673] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[407.957272] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.123s)
[407.966002] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[408.086082] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.129s)
[408.095631] Starting dynamic subtest: drm_test_damage_iter_single_damage
[408.187132] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.101s)
[408.197506] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[408.327056] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.137s)
[408.335915] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[408.410443] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.083s)
[408.419191] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[408.523543] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.112s)
[408.532137] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[408.605899] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.082s)
[408.614384] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[408.744479] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.137s)
[408.752831] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[408.872899] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.128s)
[408.881687] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[409.013198] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.140s)
[409.021417] Starting dynamic subtest: drm_test_damage_iter_damage
[409.117039] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.103s)
[409.125813] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[409.233029] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.114s)
[409.241530] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[409.307479] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.075s)
[409.315728] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[409.396463] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.089s)
[409.409615] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[409.508963] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.111s)
[409.510839] Subtest drm_damage_helper: SUCCESS (2.393s)
[409.719724] [056/132] (616s left) gem_userptr_blits (unsync-overlap)
[409.795380] Subtest unsync-overlap: SKIP (0.000s)
[409.958395] [057/132] (616s left) kms_psr (pr-sprite-mmap-gtt)
[410.052006] Starting subtest: pr-sprite-mmap-gtt
[410.056240] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[410.147914] [058/132] (616s left) kms_psr (psr-sprite-mmap-gtt)
[410.245034] Starting subtest: psr-sprite-mmap-gtt
[410.247315] Starting dynamic subtest: eDP-1
[411.668134] Dynamic subtest eDP-1: SKIP (1.421s)
[411.673442] Subtest psr-sprite-mmap-gtt: SKIP (1.423s)
[411.861389] [059/132] (614s left) gem_exec_parallel (basic)
[411.927666] Starting subtest: basic
[411.929939] Starting dynamic subtest: rcs0
[413.376229] Dynamic subtest rcs0: SUCCESS (1.452s)
[413.385308] Starting dynamic subtest: bcs0
[414.870612] Dynamic subtest bcs0: SUCCESS (1.492s)
[414.882764] Starting dynamic subtest: vcs0
[416.492585] Dynamic subtest vcs0: SUCCESS (1.619s)
[416.504108] Starting dynamic subtest: vcs1
[418.517960] Dynamic subtest vcs1: SUCCESS (2.024s)
[418.529892] Starting dynamic subtest: vecs0
[420.438367] Dynamic subtest vecs0: SUCCESS (1.918s)
[420.449809] Starting dynamic subtest: ccs0
[421.942213] Dynamic subtest ccs0: SUCCESS (1.502s)
[421.945012] Subtest basic: SUCCESS (10.021s)
[422.152857] [060/132] (604s left) kms_content_protection (content-type-change)
[422.300335] Starting subtest: content-type-change
[422.304314] Subtest content-type-change: SKIP (0.000s)
[422.465930] [061/132] (604s left) gem_mmap_wc (write-read-distinct)
[422.526461] Subtest write-read-distinct: SKIP (0.000s)
[422.600539] [062/132] (604s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[422.707764] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[423.498507] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[423.730835] [063/132] (602s left) gem_ctx_persistence (engines-mixed-process)
[423.794339] Starting subtest: engines-mixed-process
[423.796549] Starting dynamic subtest: rcs0
[425.497451] Dynamic subtest rcs0: SUCCESS (1.703s)
[425.509013] Starting dynamic subtest: bcs0
[427.484088] Dynamic subtest bcs0: SUCCESS (1.986s)
[427.495493] Starting dynamic subtest: vcs0
[429.473986] Dynamic subtest vcs0: SUCCESS (1.989s)
[429.485085] Starting dynamic subtest: vcs1
[431.469136] Dynamic subtest vcs1: SUCCESS (1.994s)
[431.480852] Starting dynamic subtest: vecs0
[433.530013] Dynamic subtest vecs0: SUCCESS (2.060s)
[433.541743] Starting dynamic subtest: ccs0
[435.469124] Dynamic subtest ccs0: SUCCESS (1.938s)
[435.471991] Subtest engines-mixed-process: SUCCESS (11.680s)
[435.576587] [064/132] (591s left) kms_chamelium_edid (vga-edid-read)
[435.976235] Subtest vga-edid-read: SKIP (0.000s)
[436.779481] [065/132] (589s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[436.908647] Starting subtest: 2x-long-flip-vs-cursor-atomic
[436.913229] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[437.076541] [066/132] (589s left) gem_exec_create (legacy)
[437.132177] Starting subtest: legacy
[437.134459] Starting dynamic subtest: smem
[440.469653] Dynamic subtest smem: SUCCESS (3.339s)
[440.472579] Subtest legacy: SUCCESS (3.341s)
[440.682309] [067/132] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[440.785556] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[440.789497] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[440.918541] [068/132] (585s left) gem_softpin (zero)
[440.971880] Starting subtest: zero
[440.976409] Subtest zero: SUCCESS (0.004s)
[441.142445] [069/132] (585s left) gem_exec_flush (basic-wb-ro-before-default)
[441.217760] Starting subtest: basic-wb-ro-before-default
[446.681256] Subtest basic-wb-ro-before-default: SUCCESS (5.466s)
[446.896095] [070/132] (580s left) kms_big_fb (linear-64bpp-rotate-90)
[447.010468] Starting subtest: linear-64bpp-rotate-90
[447.030958] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[447.172577] [071/132] (579s left) gem_userptr_blits (set-cache-level)
[447.247680] Starting subtest: set-cache-level
[447.251784] Subtest set-cache-level: SKIP (0.000s)
[447.419050] [072/132] (579s left) perf_pmu (busy)
[447.461060] Starting subtest: busy
[447.463418] Starting dynamic subtest: rcs0
[448.052039] Dynamic subtest rcs0: SUCCESS (0.590s)
[448.063531] Starting dynamic subtest: bcs0
[448.623101] Dynamic subtest bcs0: SUCCESS (0.570s)
[448.635338] Starting dynamic subtest: vcs0
[450.517976] Dynamic subtest vcs0: SUCCESS (1.892s)
[450.530437] Starting dynamic subtest: vcs1
[452.501265] Dynamic subtest vcs1: SUCCESS (1.981s)
[452.513217] Starting dynamic subtest: vecs0
[454.485505] Dynamic subtest vecs0: SUCCESS (1.982s)
[454.498736] Starting dynamic subtest: ccs0
[455.065411] Dynamic subtest ccs0: SUCCESS (0.579s)
[455.067851] Subtest busy: SUCCESS (7.610s)
[455.214266] [073/132] (571s left) gem_basic (multigpu-create-close)
[455.281940] Starting subtest: multigpu-create-close
[455.286459] Subtest multigpu-create-close: SKIP (0.000s)
[455.418116] [074/132] (571s left) gen9_exec_parse (bb-secure)
[455.496897] Subtest bb-secure: SKIP (0.000s)
[455.585268] [075/132] (571s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[455.653733] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[455.656116] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[455.796438] [076/132] (571s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[460.774814] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[460.779569] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[461.631054] [077/132] (565s left) kms_lease (lease-invalid-crtc)
[461.741943] Starting subtest: lease-invalid-crtc
[461.744122] Starting dynamic subtest: pipe-A-eDP-1
[461.746403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[461.756372] Starting dynamic subtest: pipe-B-eDP-1
[461.758503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[461.767202] Starting dynamic subtest: pipe-C-eDP-1
[461.769466] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[461.778413] Starting dynamic subtest: pipe-D-eDP-1
[461.780563] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[461.782687] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[461.840758] [078/132] (565s left) gem_pwrite_snooped
[461.986576] [079/132] (565s left) gem_exec_reloc (basic-write-wc-noreloc)
[462.058002] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[462.138944] [080/132] (565s left) kms_flip (wf_vblank-ts-check-interruptible)
[462.235242] Starting subtest: wf_vblank-ts-check-interruptible
[462.237493] Starting dynamic subtest: A-eDP1
[471.151942] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[471.163831] Starting dynamic subtest: B-eDP1
[480.086307] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[480.096348] Starting dynamic subtest: C-eDP1
[489.006217] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[489.021541] Starting dynamic subtest: D-eDP1
[497.936293] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[497.938467] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.694s)
[499.191471] [081/132] (528s left) gem_ctx_persistence (legacy-engines-queued)
[499.255672] Starting subtest: legacy-engines-queued
[499.257960] Starting dynamic subtest: render
[499.341571] Dynamic subtest render: SUCCESS (0.085s)
[499.356593] Starting dynamic subtest: bsd1
[500.467839] Dynamic subtest bsd1: SUCCESS (1.122s)
[500.479888] Starting dynamic subtest: bsd2
[502.453276] Dynamic subtest bsd2: SUCCESS (1.982s)
[502.465407] Starting dynamic subtest: blt
[502.482345] Dynamic subtest blt: SUCCESS (0.027s)
[502.491228] Starting dynamic subtest: vebox
[504.435948] Dynamic subtest vebox: SUCCESS (1.950s)
[504.438708] Subtest legacy-engines-queued: SUCCESS (5.181s)
[504.541526] [082/132] (522s left) gem_exercise_blt (fast-copy)
[504.605414] Starting subtest: fast-copy
[504.607670] Starting dynamic subtest: linear-smem-smem
[504.632144] Dynamic subtest linear-smem-smem: SUCCESS (0.029s)
[504.645150] Starting dynamic subtest: xmajor-smem-smem
[504.650661] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[504.660293] Starting dynamic subtest: tile4-smem-smem
[504.670868] Dynamic subtest tile4-smem-smem: SUCCESS (0.019s)
[504.680496] Starting dynamic subtest: tile64-smem-smem
[504.690872] Dynamic subtest tile64-smem-smem: SUCCESS (0.019s)
[504.693140] Subtest fast-copy: SUCCESS (0.088s)
[504.867108] [083/132] (522s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[504.973043] Starting subtest: bo-too-small-due-to-tiling
[504.977438] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[505.115761] [084/132] (522s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[505.179795] Starting subtest: multi-wait-all-for-submit-signaled
[505.182008] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[505.313718] [085/132] (522s left) kms_cursor_crc (cursor-random-512x512)
[505.626915] Starting subtest: cursor-random-512x512
[505.630765] Subtest cursor-random-512x512: SKIP (0.001s)
[505.835666] [086/132] (521s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[505.903028] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[505.960897] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[506.050950] [087/132] (521s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[506.144350] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[506.146281] Starting dynamic subtest: pipe-A-default-mode
[506.442250] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[506.446530] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.297s)
[507.321581] [088/132] (520s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[507.420851] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[507.423064] Starting dynamic subtest: pipe-A-eDP-1
[507.444717] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[507.454424] Starting dynamic subtest: pipe-B-eDP-1
[507.475260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[507.484551] Starting dynamic subtest: pipe-C-eDP-1
[507.505220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[507.514645] Starting dynamic subtest: pipe-D-eDP-1
[507.535242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[507.538934] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[509.698493] [089/132] (518s left) kms_plane_multiple (2x-tiling-none)
[509.799752] Starting subtest: 2x-tiling-none
[509.804060] Subtest 2x-tiling-none: SKIP (0.000s)
[509.897548] [090/132] (517s left) kms_psr (fbc-psr2-sprite-blt)
[509.988242] Starting subtest: fbc-psr2-sprite-blt
[509.990630] Starting dynamic subtest: eDP-1
[509.994907] Dynamic subtest eDP-1: SKIP (0.000s)
[509.999261] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[510.085953] [091/132] (517s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[510.193364] Starting subtest: y-tiled-16bpp-rotate-270
[510.197315] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[510.312227] [092/132] (517s left) i915_query (engine-info-invalid)
[510.372722] Starting subtest: engine-info-invalid
[510.374612] Subtest engine-info-invalid: SUCCESS (0.000s)
[510.514558] [093/132] (517s left) gem_ctx_param (invalid-size-set)
[510.575482] Starting subtest: invalid-size-set
[510.577807] Subtest invalid-size-set: SUCCESS (0.001s)
[510.711865] [094/132] (517s left) kms_fbcon_fbt (psr-suspend)
[510.766967] Starting subtest: psr-suspend
[561.877567] Subtest psr-suspend: SUCCESS (20.614s)
[562.966280] [095/132] (466s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[563.028641] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[563.133770] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[563.231414] [096/132] (465s left) kms_pm_rpm (universal-planes)
[565.366635] Starting subtest: universal-planes
[565.368799] Starting dynamic subtest: plane-33
[573.648749] Dynamic subtest plane-33: SUCCESS (8.359s)
[573.660940] Starting dynamic subtest: plane-63
[581.910087] Dynamic subtest plane-63: SUCCESS (8.293s)
[581.922533] Starting dynamic subtest: plane-93
[590.489054] Dynamic subtest plane-93: SUCCESS (8.591s)
[590.501924] Starting dynamic subtest: plane-123
[598.787681] Dynamic subtest plane-123: SUCCESS (8.303s)
[598.800109] Starting dynamic subtest: plane-133
[607.070749] Dynamic subtest plane-133: SUCCESS (8.275s)
[607.083723] Starting dynamic subtest: plane-143
[615.682868] Dynamic subtest plane-143: SUCCESS (8.607s)
[615.685305] Subtest universal-planes: SUCCESS (50.446s)
[616.091049] [097/132] (413s left) gem_exec_reloc (basic-write-read)
[616.176220] Subtest basic-write-read: SKIP (0.000s)
[616.267529] [098/132] (412s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[616.369819] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[616.374205] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.497630] [099/132] (412s left) kms_cursor_crc (cursor-onscreen-32x32)
[616.651009] Starting subtest: cursor-onscreen-32x32
[616.716093] Subtest cursor-onscreen-32x32: SKIP (0.061s)
[617.029895] [100/132] (412s left) syncobj_wait (invalid-wait-bad-flags)
[617.088275] Starting subtest: invalid-wait-bad-flags
[617.090142] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[617.207134] [101/132] (412s left) gem_exec_whisper (basic-contexts-forked-all)
[617.268472] Starting subtest: basic-contexts-forked-all
[636.283726] Subtest basic-contexts-forked-all: SUCCESS (19.012s)
[636.493232] [102/132] (392s left) gem_fenced_exec_thrash (2-spare-fences)
[636.559008] Subtest 2-spare-fences: SKIP (0.000s)
[636.650736] [103/132] (392s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[636.751275] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[636.755333] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[636.884339] [104/132] (392s left) api_intel_bb (add-remove-objects)
[636.942318] Starting subtest: add-remove-objects
[636.947098] Subtest add-remove-objects: SUCCESS (0.007s)
[637.101333] [105/132] (392s left) kms_vblank (invalid)
[637.202106] Starting subtest: invalid
[637.204458] Starting dynamic subtest: pipe-A-eDP-1
[637.609556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[637.611729] Subtest invalid: SUCCESS (0.407s)
[638.498636] [106/132] (391s left) gem_mmap_wc (bad-object)
[638.556166] Subtest bad-object: SKIP (0.000s)
[638.617500] [107/132] (390s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[638.735277] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[638.739609] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[638.875422] [108/132] (390s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[638.941871] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[639.027620] [109/132] (390s left) gem_tiled_fence_blits (normal)
[639.092820] Subtest normal: SKIP (0.000s)
[639.175674] [110/132] (390s left) gem_exec_alignment (pi)
[639.246573] Starting subtest: pi
[691.367792] Subtest pi: SUCCESS (52.118s)
[692.585610] [111/132] (337s left) gem_mmap (bad-object)
[692.694378] Subtest bad-object: SKIP (0.000s)
[692.751096] [112/132] (337s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[692.864255] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[692.866457] Starting dynamic subtest: pipe-A
[693.160609] Dynamic subtest pipe-A: SUCCESS (0.299s)
[693.173840] Starting dynamic subtest: pipe-B
[694.505168] Dynamic subtest pipe-B: SUCCESS (1.342s)
[694.530731] Starting dynamic subtest: pipe-C
[695.915829] Dynamic subtest pipe-C: SUCCESS (1.409s)
[695.927267] Starting dynamic subtest: pipe-D
[697.217384] Dynamic subtest pipe-D: SUCCESS (1.301s)
[697.219646] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.356s)
[698.400431] [113/132] (331s left) i915_hangman (engine-error-state-capture)
[698.470161] Starting subtest: engine-error-state-capture
[698.472524] Starting dynamic subtest: rcs0
[702.168339] Dynamic subtest rcs0: SUCCESS (3.697s)
[702.182432] Starting dynamic subtest: bcs0
[708.119724] Dynamic subtest bcs0: SUCCESS (5.949s)
[708.132111] Starting dynamic subtest: vcs0
[714.135603] Dynamic subtest vcs0: SUCCESS (6.013s)
[714.149430] Starting dynamic subtest: vcs1
[720.153315] Dynamic subtest vcs1: SUCCESS (6.015s)
[720.167095] Starting dynamic subtest: vecs0
[726.168571] Dynamic subtest vecs0: SUCCESS (6.013s)
[726.182363] Starting dynamic subtest: ccs0
[732.119798] Dynamic subtest ccs0: SUCCESS (5.950s)
[732.122934] Subtest engine-error-state-capture: SUCCESS (33.654s)
[732.290005] [114/132] (297s left) perf (low-oa-exponent-permissions)
[732.425452] Starting subtest: low-oa-exponent-permissions
[732.459150] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[732.507859] [115/132] (297s left) gem_softpin (noreloc)
[732.571683] Starting subtest: noreloc
[737.970243] Subtest noreloc: SUCCESS (5.397s)
[738.142171] [116/132] (291s left) perf (enable-disable)
[738.241147] Starting subtest: enable-disable
[738.243462] Starting dynamic subtest: 0-rcs0
[740.526935] Dynamic subtest 0-rcs0: SUCCESS (2.284s)
[740.537596] Starting dynamic subtest: 1-vcs1
[745.015006] Dynamic subtest 1-vcs1: SUCCESS (4.488s)
[745.017548] Subtest enable-disable: SUCCESS (6.774s)
[745.069124] [117/132] (284s left) kms_pipe_crc_basic (nonblocking-crc)
[745.168242] Starting subtest: nonblocking-crc
[745.170667] Starting dynamic subtest: pipe-A-eDP-1
[745.920697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[745.931931] Starting dynamic subtest: pipe-B-eDP-1
[747.409969] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[747.421482] Starting dynamic subtest: pipe-C-eDP-1
[748.763613] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[748.774103] Starting dynamic subtest: pipe-D-eDP-1
[750.095727] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[750.097774] Subtest nonblocking-crc: SUCCESS (4.928s)
[750.914209] [118/132] (279s left) sysfs_preempt_timeout (timeout)
[750.980592] Starting subtest: timeout
[750.982556] Starting dynamic subtest: vecs0
[760.202347] Dynamic subtest vecs0: SUCCESS (9.222s)
[760.215293] Starting dynamic subtest: ccs0
[761.576096] Dynamic subtest ccs0: SUCCESS (1.374s)
[761.589600] Starting dynamic subtest: vcs0
[771.216148] Dynamic subtest vcs0: SUCCESS (9.638s)
[771.232414] Starting dynamic subtest: bcs0
[772.547385] Dynamic subtest bcs0: SUCCESS (1.331s)
[772.560873] Starting dynamic subtest: rcs0
[773.827360] Dynamic subtest rcs0: SUCCESS (1.278s)
[773.840609] Starting dynamic subtest: vcs1
[783.177720] Dynamic subtest vcs1: SUCCESS (9.349s)
[783.180169] Subtest timeout: SUCCESS (32.206s)
[783.281220] [119/132] (246s left) gem_mmap_gtt (hang-busy)
[783.349951] Subtest hang-busy: SKIP (0.000s)
[783.411343] [120/132] (246s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[783.507590] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[783.511810] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[783.632351] [121/132] (246s left) i915_drm_fdinfo (all-busy-idle-check-all)
[783.678865] Starting subtest: all-busy-idle-check-all
[783.683370] Subtest all-busy-idle-check-all: SKIP (0.004s)
[783.787432] [122/132] (246s left) perf_pmu (init-sema)
[783.826662] Starting subtest: init-sema
[783.829009] Starting dynamic subtest: rcs0
[783.831723] Dynamic subtest rcs0: SUCCESS (0.001s)
[783.842325] Starting dynamic subtest: bcs0
[783.844525] Dynamic subtest bcs0: SUCCESS (0.000s)
[783.854648] Starting dynamic subtest: vcs0
[783.856896] Dynamic subtest vcs0: SUCCESS (0.000s)
[783.866916] Starting dynamic subtest: vcs1
[783.868863] Dynamic subtest vcs1: SUCCESS (0.000s)
[783.878453] Starting dynamic subtest: vecs0
[783.880421] Dynamic subtest vecs0: SUCCESS (0.000s)
[783.889934] Starting dynamic subtest: ccs0
[783.891872] Dynamic subtest ccs0: SUCCESS (0.000s)
[783.893829] Subtest init-sema: SUCCESS (0.007s)
[783.983507] [123/132] (246s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[784.079420] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[791.125479] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.050s)
[791.311671] [124/132] (238s left) gem_exec_schedule (fairslice)
[791.383151] Starting subtest: fairslice
[791.385591] Starting dynamic subtest: rcs0
[793.393145] Dynamic subtest rcs0: SUCCESS (2.018s)
[793.405190] Starting dynamic subtest: bcs0
[795.409972] Dynamic subtest bcs0: SUCCESS (2.014s)
[795.421169] Starting dynamic subtest: vcs0
[797.430309] Dynamic subtest vcs0: SUCCESS (2.017s)
[797.442431] Starting dynamic subtest: vcs1
[799.447986] Dynamic subtest vcs1: SUCCESS (2.017s)
[799.459221] Starting dynamic subtest: vecs0
[801.469877] Dynamic subtest vecs0: SUCCESS (2.016s)
[801.482206] Starting dynamic subtest: ccs0
[803.512817] Dynamic subtest ccs0: SUCCESS (2.014s)
[803.514896] Subtest fairslice: SUCCESS (12.101s)
[803.805246] [125/132] (226s left) gem_exec_reloc (basic-wc-cpu)
[803.878371] Subtest basic-wc-cpu: SKIP (0.000s)
[803.957565] [126/132] (226s left) syncobj_timeline (wait-all-for-submit-complex)
[804.021196] Starting subtest: wait-all-for-submit-complex
[804.235079] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[804.341129] [127/132] (226s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[804.467644] Starting subtest: cursorB-vs-flipB-legacy
[804.472230] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[804.661797] [128/132] (225s left) gem_exec_flush (basic-wb-set-default)
[804.746640] Starting subtest: basic-wb-set-default
[810.201330] Subtest basic-wb-set-default: SUCCESS (5.453s)
[810.412709] [129/132] (220s left) gem_pxp (reject-modify-context-protection-off-2)
[810.525050] Starting subtest: reject-modify-context-protection-off-2
[810.527423] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[810.671002] [130/132] (219s left) api_intel_bb (misplaced-blitter)
[810.734505] Starting subtest: misplaced-blitter
[810.744223] Subtest misplaced-blitter: SUCCESS (0.012s)
[810.934599] [131/132] (219s left) kms_psr (fbc-pr-dpms)
[811.030004] Starting subtest: fbc-pr-dpms
[811.034387] Subtest fbc-pr-dpms: SKIP (0.000s)
[811.131428] [132/132] (219s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[811.242295] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[811.246318] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[811.358210] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_rmfb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_chamelium_hpd
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_exec_reloc
results: parsing output: 10/ for test: kms_draw_crc
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_create
results: parsing output: 14/ for test: kms_cdclk
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: kms_joiner
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: drm_mm
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_color_pipeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rc6_residency
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: sw_sync
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_selftest
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: kms_chamelium_edid
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_create
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: gem_pwrite_snooped
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: gem_exercise_blt
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: sriov_basic
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_plane_multiple
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: gem_ctx_param
results: parsing output: 93/ for test: kms_fbcon_fbt
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_exec_whisper
results: parsing output: 101/ for test: gem_fenced_exec_thrash
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_tiled_fence_blits
results: parsing output: 109/ for test: gem_exec_alignment
results: parsing output: 110/ for test: gem_mmap
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: i915_hangman
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: sysfs_preempt_timeout
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_big_fb
Done.