[53.659209] Initializing watchdogs
[53.659258]   /dev/watchdog0
[53.673550] [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]
[53.677961] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.680588] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.683777] [001/131] (960s left) gem_ctx_isolation (nonpriv-switch)
[53.754493] Starting subtest: nonpriv-switch
[53.756714] Starting dynamic subtest: rcs0
[54.063641] Dynamic subtest rcs0: SUCCESS (0.320s)
[54.073821] Starting dynamic subtest: bcs0
[54.436518] Dynamic subtest bcs0: SUCCESS (0.384s)
[54.444260] Starting dynamic subtest: vcs0
[54.783392] Dynamic subtest vcs0: SUCCESS (0.358s)
[54.790045] Starting dynamic subtest: vcs1
[56.201886] Dynamic subtest vcs1: SUCCESS (1.456s)
[56.209162] Starting dynamic subtest: vecs0
[58.192245] Dynamic subtest vecs0: SUCCESS (2.033s)
[58.200206] Starting dynamic subtest: ccs0
[60.258527] Dynamic subtest ccs0: SUCCESS (2.100s)
[60.260895] Subtest nonpriv-switch: SUCCESS (6.651s)
[60.507032] [002/131] (953s left) gem_pxp (hw-rejects-pxp-context)
[60.634497] Starting subtest: hw-rejects-pxp-context
[60.639110] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[60.760468] [003/131] (953s left) gem_exec_reloc (basic-gtt-read-noreloc)
[60.813098] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[60.890153] [004/131] (953s left) kms_color (ctm-negative)
[60.997803] Starting subtest: ctm-negative
[60.999709] Starting dynamic subtest: pipe-A-eDP-1
[61.730719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[61.739289] Starting dynamic subtest: pipe-B-eDP-1
[63.093914] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[63.105718] Starting dynamic subtest: pipe-C-eDP-1
[64.373621] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s)
[64.382108] Starting dynamic subtest: pipe-D-eDP-1
[65.687927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[65.690771] Subtest ctm-negative: SUCCESS (4.735s)
[66.540796] [005/131] (947s left) syncobj_eventfd (timeline-wait-signaled)
[66.599197] Starting subtest: timeline-wait-signaled
[66.601193] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[66.704785] [006/131] (947s left) gem_exec_balancer (hog)
[66.771893] Starting subtest: hog
[66.776511] Subtest hog: SKIP (0.000s)
[67.089248] [007/131] (947s left) gem_partial_pwrite_pread (writes-after-reads-display)
[67.144158] Subtest writes-after-reads-display: SKIP (0.000s)
[67.226073] [008/131] (947s left) i915_drm_fdinfo (context-close-stress)
[67.264284] Starting subtest: context-close-stress
[77.978698] Subtest context-close-stress: SUCCESS (10.746s)
[78.106707] [009/131] (936s left) i915_drm_fdinfo (memory-info-active)
[78.147541] Starting subtest: memory-info-active
[78.149490] Starting dynamic subtest: smem0
[80.802438] Dynamic subtest smem0: SUCCESS (2.659s)
[80.804593] Subtest memory-info-active: SUCCESS (2.659s)
[80.899875] [010/131] (933s left) syncobj_timeline (single-wait-for-submit-signaled)
[80.947351] Starting subtest: single-wait-for-submit-signaled
[80.949330] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[81.048775] [011/131] (933s left) kms_pm_dc (dc5-psr)
[82.149041] Starting subtest: dc5-psr
[85.123261] Subtest dc5-psr: SUCCESS (2.978s)
[85.932575] [012/131] (928s left) kms_big_fb (linear-16bpp-rotate-0)
[86.038908] Starting subtest: linear-16bpp-rotate-0
[87.327493] Subtest linear-16bpp-rotate-0: SUCCESS (1.288s)
[87.481033] [013/131] (927s left) perf (non-system-wide-paranoid)
[87.605410] Starting subtest: non-system-wide-paranoid
[87.631268] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[87.666507] [014/131] (926s left) gem_exec_schedule (semaphore-resolve)
[87.743567] Starting subtest: semaphore-resolve
[87.774201] Subtest semaphore-resolve: SUCCESS (0.035s)
[88.145606] [015/131] (926s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[88.250481] Starting subtest: psr-indfb-scaledprimary
[93.957455] Subtest psr-indfb-scaledprimary: SUCCESS (5.709s)
[94.090542] [016/131] (920s left) kms_cursor_crc (cursor-sliding-32x32)
[94.235894] Starting subtest: cursor-sliding-32x32
[94.282056] Subtest cursor-sliding-32x32: SKIP (0.041s)
[94.582565] [017/131] (920s left) api_intel_bb (blit-reloc-purge-cache)
[94.637545] Starting subtest: blit-reloc-purge-cache
[94.642212] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[94.787403] [018/131] (920s left) gem_exec_whisper (basic-queues-priority)
[94.849171] Starting subtest: basic-queues-priority
[118.013720] Subtest basic-queues-priority: SUCCESS (23.162s)
[118.206771] [019/131] (896s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[123.231437] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[123.236040] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.003s)
[124.082203] [020/131] (890s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[129.070271] Starting subtest: pr-cursor-plane-update-sf
[129.074866] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[129.936982] [021/131] (885s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[130.032770] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[130.034913] Starting dynamic subtest: pipe-A-eDP-1
[130.930112] Dynamic subtest pipe-A-eDP-1: FAIL (0.309s)
[130.940433] Starting dynamic subtest: pipe-B-eDP-1
[131.358734] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.016s)
[131.625660] Subtest plane-all-modeset-transition-fencing-internal-panels: FAIL (1.592s)
[132.474382] [022/131] (882s left) i915_module_load (reload-with-fault-injection)
[132.509811] Starting subtest: reload-with-fault-injection
[174.236946] Subtest reload-with-fault-injection: SUCCESS (41.726s)
[174.263522] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[174.266511] [023/131] (840s left) kms_draw_crc (draw-method-mmap-cpu)
[175.784972] Starting subtest: draw-method-mmap-cpu
[175.787282] Starting dynamic subtest: xrgb8888-untiled
[176.020617] Dynamic subtest xrgb8888-untiled: SUCCESS (0.237s)
[176.028487] Starting dynamic subtest: rgb565-untiled
[176.231648] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[176.239989] Starting dynamic subtest: xrgb2101010-untiled
[176.420429] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[176.428431] Starting dynamic subtest: xbgr16161616f-untiled
[176.609118] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.188s)
[176.616782] Starting dynamic subtest: xrgb8888-xtiled
[176.720312] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[176.727860] Starting dynamic subtest: rgb565-xtiled
[176.842560] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[176.850272] Starting dynamic subtest: xrgb2101010-xtiled
[176.953537] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[176.961290] Starting dynamic subtest: xbgr16161616f-xtiled
[177.065060] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[177.072794] Starting dynamic subtest: xrgb8888-4tiled
[177.209050] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s)
[177.216899] Starting dynamic subtest: rgb565-4tiled
[177.342464] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[177.352178] Starting dynamic subtest: xrgb2101010-4tiled
[177.475899] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[177.483859] Starting dynamic subtest: xbgr16161616f-4tiled
[177.598282] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[177.600191] Subtest draw-method-mmap-cpu: SUCCESS (1.815s)
[177.719602] [FACT kms_draw_crc (draw-method-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[177.723069] [024/131] (837s left) gem_mmap_gtt (pf-nonblock)
[177.786081] Subtest pf-nonblock: SKIP (0.000s)
[177.835508] [025/131] (837s left) gem_eio (in-flight-internal-1us)
[177.969979] Starting subtest: in-flight-internal-1us
[179.963553] Subtest in-flight-internal-1us: SUCCESS (1.993s)
[180.112524] [026/131] (835s left) sysfs_preempt_timeout (idempotent)
[180.178161] Starting subtest: idempotent
[180.180334] Starting dynamic subtest: vecs0
[180.182619] Dynamic subtest vecs0: SUCCESS (0.000s)
[180.191697] Starting dynamic subtest: ccs0
[180.193559] Dynamic subtest ccs0: SUCCESS (0.000s)
[180.201541] Starting dynamic subtest: vcs0
[180.203471] Dynamic subtest vcs0: SUCCESS (0.000s)
[180.211615] Starting dynamic subtest: bcs0
[180.213513] Dynamic subtest bcs0: SUCCESS (0.000s)
[180.221432] Starting dynamic subtest: rcs0
[180.223314] Dynamic subtest rcs0: SUCCESS (0.000s)
[180.230984] Starting dynamic subtest: vcs1
[180.232942] Dynamic subtest vcs1: SUCCESS (0.000s)
[180.234867] Subtest idempotent: SUCCESS (0.005s)
[180.315833] [027/131] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[180.412923] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[187.128519] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.719s)
[187.274050] [028/131] (827s left) gem_lmem_swapping (heavy-random)
[187.316097] Subtest heavy-random: SKIP (0.000s)
[187.358734] [029/131] (827s left) gem_exec_fence (syncobj-timeline-wait)
[187.904092] Starting subtest: syncobj-timeline-wait
[188.925709] Subtest syncobj-timeline-wait: SUCCESS (1.022s)
[189.188206] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[189.192023] [030/131] (826s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[189.290191] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[189.294049] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[189.414596] [031/131] (825s left) gem_eio (in-flight-contexts-1us)
[189.574598] Starting subtest: in-flight-contexts-1us
[199.924757] Subtest in-flight-contexts-1us: SUCCESS (10.349s)
[200.106272] [032/131] (815s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[200.196514] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[200.200657] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[200.296184] [033/131] (815s left) kms_lease (lease-invalid-plane)
[200.385037] Starting subtest: lease-invalid-plane
[200.387337] Starting dynamic subtest: pipe-A-eDP-1
[200.389499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[200.398239] Starting dynamic subtest: pipe-B-eDP-1
[200.400545] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[200.409213] Starting dynamic subtest: pipe-C-eDP-1
[200.411368] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[200.419606] Starting dynamic subtest: pipe-D-eDP-1
[200.421475] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[200.423346] Subtest lease-invalid-plane: SUCCESS (0.004s)
[200.470598] [034/131] (814s left) kms_cursor_crc (cursor-offscreen-512x170)
[200.777491] Starting subtest: cursor-offscreen-512x170
[200.782050] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[200.940950] [035/131] (814s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[201.043924] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[201.047544] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[201.162683] [036/131] (814s left) perf (gen12-invalid-class-instance)
[201.299636] Starting subtest: gen12-invalid-class-instance
[201.312419] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[201.354276] [037/131] (814s left) gem_exec_balancer (busy)
[201.414295] Starting subtest: busy
[202.911050] Subtest busy: SUCCESS (1.495s)
[203.279104] [038/131] (812s left) kms_flip (plain-flip-ts-check)
[203.385092] Starting subtest: plain-flip-ts-check
[203.387260] Starting dynamic subtest: A-eDP1
[212.244358] Dynamic subtest A-eDP1: SUCCESS (8.861s)
[212.254977] Starting dynamic subtest: B-eDP1
[221.073616] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[221.083787] Starting dynamic subtest: C-eDP1
[229.887637] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[229.898449] Starting dynamic subtest: D-eDP1
[238.726909] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[238.732103] Subtest plain-flip-ts-check: SUCCESS (35.347s)
[239.929371] [039/131] (775s left) kms_psr (psr-cursor-render)
[240.019128] Starting subtest: psr-cursor-render
[240.021338] Starting dynamic subtest: eDP-1
[241.701268] Dynamic subtest eDP-1: SUCCESS (1.680s)
[241.703454] Subtest psr-cursor-render: SUCCESS (1.681s)
[242.581194] [040/131] (773s left) kms_prime (basic-crc-vgem)
[242.676193] Starting subtest: basic-crc-vgem
[242.678604] Starting dynamic subtest: second-to-first
[243.591076] Dynamic subtest second-to-first: SUCCESS (0.919s)
[243.593061] Subtest basic-crc-vgem: SUCCESS (0.919s)
[243.736507] [041/131] (772s left) sw_sync (alloc_fence)
[243.774680] Starting subtest: alloc_fence
[243.776638] Subtest alloc_fence: SUCCESS (0.000s)
[243.850271] [042/131] (771s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[243.976761] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[243.978742] Starting dynamic subtest: pipe-A
[243.986557] Dynamic subtest pipe-A: SKIP (0.004s)
[243.996291] Starting dynamic subtest: pipe-B
[244.003890] Dynamic subtest pipe-B: SKIP (0.018s)
[244.012755] Starting dynamic subtest: pipe-C
[244.020462] Dynamic subtest pipe-C: SKIP (0.018s)
[244.028980] Starting dynamic subtest: pipe-D
[244.040193] Dynamic subtest pipe-D: SKIP (0.019s)
[244.043719] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.062s)
[244.149968] [043/131] (771s left) kms_flip (flip-vs-expired-vblank-interruptible)
[244.248729] Starting subtest: flip-vs-expired-vblank-interruptible
[244.250731] Starting dynamic subtest: A-eDP1
[252.873915] Dynamic subtest A-eDP1: SUCCESS (8.623s)
[252.888712] Starting dynamic subtest: B-eDP1
[261.503627] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[261.512769] Starting dynamic subtest: C-eDP1
[270.115076] Dynamic subtest C-eDP1: SUCCESS (8.609s)
[270.126910] Starting dynamic subtest: D-eDP1
[278.758595] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[278.763116] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.505s)
[279.934843] [044/131] (735s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[280.035104] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[280.037382] Starting dynamic subtest: pipe-A-default-mode
[280.328930] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[280.333536] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.291s)
[281.175708] [045/131] (734s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[281.256057] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[281.260362] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[282.405088] [046/131] (733s left) syncobj_wait (wait-for-submit-snapshot)
[282.456561] Starting subtest: wait-for-submit-snapshot
[282.538912] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[282.636926] [047/131] (733s left) kms_vblank (wait-busy-hang)
[282.735045] Starting subtest: wait-busy-hang
[282.737275] Starting dynamic subtest: pipe-A-eDP-1
[309.655292] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.913s)
[309.670205] Starting dynamic subtest: pipe-D-eDP-1
[324.699712] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[324.702397] Subtest wait-busy-hang: SUCCESS (41.959s)
[325.579402] [048/131] (690s left) gem_wait (invalid-buf)
[325.631426] Starting subtest: invalid-buf
[325.633668] Subtest invalid-buf: SUCCESS (0.000s)
[325.896182] [049/131] (690s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[325.997759] Starting subtest: pipe-fbc-rte
[326.004200] Starting dynamic subtest: pipe-B-eDP-1
[331.491070] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.496s)
[331.498832] Subtest pipe-fbc-rte: SUCCESS (5.498s)
[333.811571] [050/131] (682s left) gem_exec_reloc (basic-cpu-gtt-active)
[333.870075] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[333.960443] [051/131] (682s left) gem_exec_params (secure-non-root)
[334.028649] Starting subtest: secure-non-root
[334.033230] Subtest secure-non-root: SKIP (0.000s)
[334.154607] [052/131] (682s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[334.251589] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[341.293031] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.043s)
[342.425890] [053/131] (673s left) gem_ctx_persistence (file)
[342.493499] Starting subtest: file
[342.650962] Subtest file: SUCCESS (0.157s)
[342.789997] [054/131] (673s left) fbdev (unaligned-write)
[342.829593] Starting subtest: unaligned-write
[342.927757] Subtest unaligned-write: SUCCESS (0.100s)
[343.015497] [055/131] (673s left) gem_userptr_blits (sync-unmap-cycles)
[343.090681] Starting subtest: sync-unmap-cycles
[348.464055] Subtest sync-unmap-cycles: SUCCESS (5.374s)
[348.625586] [056/131] (667s left) syncobj_wait (multi-wait-submitted-signaled)
[348.682979] Starting subtest: multi-wait-submitted-signaled
[348.685059] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[348.816648] [057/131] (667s left) gen9_exec_parse (allowed-all)
[348.876950] Subtest allowed-all: SKIP (0.000s)
[348.954257] [058/131] (667s left) kms_plane (planar-pixel-format-settings)
[349.058815] Starting subtest: planar-pixel-format-settings
[349.086530] Subtest planar-pixel-format-settings: SUCCESS (0.030s)
[349.224255] [059/131] (667s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[349.320544] Starting subtest: fbc-psr-sprite-mmap-gtt
[349.322481] Starting dynamic subtest: eDP-1
[349.325928] Dynamic subtest eDP-1: SKIP (0.000s)
[349.329364] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[349.416828] [060/131] (667s left) gem_basic (multigpu-create-close)
[349.480162] Starting subtest: multigpu-create-close
[349.483774] Subtest multigpu-create-close: SKIP (0.000s)
[349.611075] [061/131] (666s left) kms_busy (extended-modeset-hang-newfb)
[349.718585] Starting subtest: extended-modeset-hang-newfb
[349.720531] Starting dynamic subtest: pipe-A
[383.746172] Dynamic subtest pipe-A: SUCCESS (34.024s)
[383.755775] Starting dynamic subtest: pipe-D
[406.798076] Dynamic subtest pipe-D: SUCCESS (23.049s)
[406.800393] Subtest extended-modeset-hang-newfb: SUCCESS (57.077s)
[407.614389] [062/131] (609s left) kms_atomic (crtc-invalid-params)
[407.714347] Starting subtest: crtc-invalid-params
[407.716727] Starting dynamic subtest: pipe-A-eDP-1
[408.089891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[408.092130] Subtest crtc-invalid-params: SUCCESS (0.373s)
[408.985437] [063/131] (607s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[409.085439] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[409.089669] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[409.200996] [064/131] (607s left) gem_userptr_blits (invalid-null-pointer)
[409.270791] Starting subtest: invalid-null-pointer
[409.272779] Subtest invalid-null-pointer: SUCCESS (0.001s)
[409.414890] [065/131] (607s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[409.510132] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[416.180236] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.671s)
[416.329504] [066/131] (600s left) kms_psr (pr-sprite-plane-move)
[416.426163] Starting subtest: pr-sprite-plane-move
[416.430490] Subtest pr-sprite-plane-move: SKIP (0.000s)
[416.509030] [067/131] (600s left) kms_cursor_crc (cursor-onscreen-512x170)
[416.802991] Starting subtest: cursor-onscreen-512x170
[416.807396] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[416.997201] [068/131] (599s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[417.096967] Starting subtest: yf-tiled-32bpp-rotate-270
[417.101396] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[417.215157] [069/131] (599s left) gem_mmap_gtt (fault-concurrent)
[417.280535] Subtest fault-concurrent: SKIP (0.000s)
[417.349808] [070/131] (599s left) perf_pmu (semaphore-busy)
[417.383134] Starting subtest: semaphore-busy
[417.385216] Starting dynamic subtest: rcs0
[419.059774] Dynamic subtest rcs0: SUCCESS (1.675s)
[419.070565] Starting dynamic subtest: bcs0
[420.689658] Dynamic subtest bcs0: SUCCESS (1.627s)
[420.700440] Starting dynamic subtest: vcs0
[424.400040] Dynamic subtest vcs0: SUCCESS (3.707s)
[424.410902] Starting dynamic subtest: vcs1
[430.416825] Dynamic subtest vcs1: SUCCESS (6.014s)
[430.427456] Starting dynamic subtest: vecs0
[436.432193] Dynamic subtest vecs0: SUCCESS (6.013s)
[436.442747] Starting dynamic subtest: ccs0
[439.503973] Dynamic subtest ccs0: SUCCESS (3.069s)
[439.506262] Subtest semaphore-busy: SUCCESS (22.119s)
[439.654429] [071/131] (577s left) prime_mmap (test_correct_cpu_write)
[439.728081] Starting subtest: test_correct_cpu_write
[439.730420] Starting dynamic subtest: test_correct_cpu_write-smem
[439.732650] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[439.734931] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[439.848913] [072/131] (577s left) gem_mmap (basic-small-bo)
[439.908141] Subtest basic-small-bo: SKIP (0.000s)
[439.998090] [073/131] (577s left) kms_chamelium_color (ctm-red-to-blue)
[440.096314] Subtest ctm-red-to-blue: SKIP (0.000s)
[440.142434] [074/131] (577s left) gem_mmap_offset (clear-via-pagefault)
[440.209535] Starting subtest: clear-via-pagefault
[440.211787] Starting dynamic subtest: smem0
[473.739042] Dynamic subtest smem0: SUCCESS (33.524s)
[473.741339] Subtest clear-via-pagefault: SUCCESS (33.526s)
[473.850743] [075/131] (543s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[473.950322] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[473.952643] Starting dynamic subtest: pipe-A-eDP-1
[474.014710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[474.024410] Starting dynamic subtest: pipe-B-eDP-1
[474.075540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[474.085297] Starting dynamic subtest: pipe-C-eDP-1
[474.138071] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[474.147811] Starting dynamic subtest: pipe-D-eDP-1
[474.198811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[474.200937] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.248s)
[476.456496] [076/131] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[476.568314] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[481.160670] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.596s)
[482.351487] [077/131] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[482.446381] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[482.450590] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[482.548819] [078/131] (534s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[482.641148] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[482.643425] Starting dynamic subtest: pipe-A-eDP-1
[482.663583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[482.673620] Starting dynamic subtest: pipe-B-eDP-1
[482.692654] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[482.701317] Starting dynamic subtest: pipe-C-eDP-1
[482.720209] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[482.728628] Starting dynamic subtest: pipe-D-eDP-1
[482.747141] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[482.749013] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[484.909100] [079/131] (532s left) kms_selftest (drm_plane_helper)
[484.945768] Starting subtest: drm_plane_helper
[484.991231] Starting dynamic subtest: drm_test_check_plane_state
[485.107536] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.114s)
[485.117563] Starting dynamic subtest: drm_test_check_invalid_plane_state
[485.220267] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.113s)
[485.222412] Subtest drm_plane_helper: SUCCESS (0.274s)
[485.392978] [080/131] (532s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[485.478103] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[485.480421] Starting dynamic subtest: pipe-A-default-mode
[485.782336] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[485.786303] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.304s)
[486.654414] [081/131] (530s left) kms_invalid_mode (bad-hsync-start)
[486.756508] Starting subtest: bad-hsync-start
[486.758714] Starting dynamic subtest: pipe-A-eDP-1
[487.047531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[487.056997] Starting dynamic subtest: pipe-B-eDP-1
[487.058960] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[487.067474] Starting dynamic subtest: pipe-C-eDP-1
[487.069807] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[487.078716] Starting dynamic subtest: pipe-D-eDP-1
[487.081055] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[487.083240] Subtest bad-hsync-start: SUCCESS (0.297s)
[487.877137] [082/131] (529s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[487.972804] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[487.977221] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.114990] [083/131] (529s left) kms_flip (plain-flip-interruptible)
[488.210618] Starting subtest: plain-flip-interruptible
[488.212995] Starting dynamic subtest: A-eDP1
[489.853777] Dynamic subtest A-eDP1: SUCCESS (1.642s)
[489.865223] Starting dynamic subtest: B-eDP1
[491.492885] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[491.504612] Starting dynamic subtest: C-eDP1
[493.110558] Dynamic subtest C-eDP1: SUCCESS (1.616s)
[493.121265] Starting dynamic subtest: D-eDP1
[494.747096] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[494.749304] Subtest plain-flip-interruptible: SUCCESS (6.540s)
[495.931724] [084/131] (521s left) gem_vm_create (invalid-create)
[495.990851] Starting subtest: invalid-create
[495.993195] Subtest invalid-create: SUCCESS (0.002s)
[496.106993] [085/131] (521s left) kms_pipe_crc_basic (nonblocking-crc)
[496.201102] Starting subtest: nonblocking-crc
[496.203379] Starting dynamic subtest: pipe-A-eDP-1
[496.921627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[496.932090] Starting dynamic subtest: pipe-B-eDP-1
[498.318470] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[498.328046] Starting dynamic subtest: pipe-C-eDP-1
[499.705405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[499.715940] Starting dynamic subtest: pipe-D-eDP-1
[501.041421] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[501.043400] Subtest nonblocking-crc: SUCCESS (4.840s)
[501.854238] [086/131] (515s left) gem_ctx_persistence (many-contexts)
[501.910517] Starting subtest: many-contexts
[547.119973] Subtest many-contexts: SUCCESS (45.207s)
[547.210640] [087/131] (470s left) kms_plane (plane-position-covered)
[547.311721] Starting subtest: plane-position-covered
[547.807383] Starting dynamic subtest: pipe-A-plane-1
[549.133195] Dynamic subtest pipe-A-plane-1: SUCCESS (1.327s)
[549.142972] Starting dynamic subtest: pipe-A-plane-2
[550.428049] Dynamic subtest pipe-A-plane-2: SUCCESS (1.295s)
[550.437711] Starting dynamic subtest: pipe-A-plane-3
[551.653944] Dynamic subtest pipe-A-plane-3: SUCCESS (1.225s)
[551.664883] Starting dynamic subtest: pipe-A-plane-4
[552.888061] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[552.898587] Starting dynamic subtest: pipe-A-plane-5
[552.911951] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[554.058861] Starting dynamic subtest: pipe-B-plane-1
[555.273051] Dynamic subtest pipe-B-plane-1: SUCCESS (1.222s)
[555.282576] Starting dynamic subtest: pipe-B-plane-2
[556.528806] Dynamic subtest pipe-B-plane-2: SUCCESS (1.254s)
[556.539612] Starting dynamic subtest: pipe-B-plane-3
[557.747456] Dynamic subtest pipe-B-plane-3: SUCCESS (1.217s)
[557.758221] Starting dynamic subtest: pipe-B-plane-4
[558.993789] Dynamic subtest pipe-B-plane-4: SUCCESS (1.244s)
[559.005898] Starting dynamic subtest: pipe-B-plane-5
[559.017181] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[559.019415] Subtest plane-position-covered: SUCCESS (11.705s)
[559.827515] [088/131] (457s left) kms_psr (fbc-psr2-primary-blt)
[559.924173] Starting subtest: fbc-psr2-primary-blt
[559.926347] Starting dynamic subtest: eDP-1
[559.930339] Dynamic subtest eDP-1: SKIP (0.000s)
[559.934272] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[560.026121] [089/131] (457s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[560.124269] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[569.434467] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (9.314s)
[569.571217] [090/131] (448s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[569.666284] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[569.668572] Starting dynamic subtest: pipe-A-eDP-1
[569.677797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.688056] Starting dynamic subtest: pipe-B-eDP-1
[569.697191] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.706546] Starting dynamic subtest: pipe-C-eDP-1
[569.715394] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.724452] Starting dynamic subtest: pipe-D-eDP-1
[569.733288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.737727] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[571.963405] [091/131] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[572.056769] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[572.060825] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[572.155960] [092/131] (445s left) kms_addfb_basic (bo-too-small)
[572.250496] Starting subtest: bo-too-small
[572.252413] Subtest bo-too-small: SUCCESS (0.000s)
[572.379179] [093/131] (445s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[572.482131] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[573.317070] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[573.505700] [094/131] (444s left) gem_exec_reloc (basic-cpu-gtt)
[573.567870] Subtest basic-cpu-gtt: SKIP (0.000s)
[573.663569] [095/131] (444s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[573.757496] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[573.867874] [096/131] (444s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[573.928813] Starting subtest: multi-wait-all-for-submit-available-submitted
[573.930749] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[574.064495] [097/131] (444s left) kms_big_fb (linear-64bpp-rotate-180)
[574.165437] Starting subtest: linear-64bpp-rotate-180
[575.820209] Subtest linear-64bpp-rotate-180: SUCCESS (1.656s)
[576.013162] [098/131] (442s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[576.083362] Starting subtest: x-tiled-to-vebox-yf-tiled
[576.086782] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[576.286162] [099/131] (441s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[576.414176] Starting subtest: short-flip-after-cursor-atomic-transitions
[577.364046] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.951s)
[578.207240] [100/131] (440s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[578.298119] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[578.300317] Starting dynamic subtest: pipe-A-eDP-1
[578.324923] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[578.336362] Starting dynamic subtest: pipe-B-eDP-1
[578.360224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[578.369096] Starting dynamic subtest: pipe-C-eDP-1
[578.392806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[578.401545] Starting dynamic subtest: pipe-D-eDP-1
[578.425635] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[578.430051] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[580.489743] [101/131] (437s left) gem_exec_schedule (thriceslice)
[580.566128] Starting subtest: thriceslice
[580.568077] Starting dynamic subtest: rcs0
[580.584378] Dynamic subtest rcs0: SUCCESS (0.029s)
[580.594971] Starting dynamic subtest: bcs0
[580.633820] Dynamic subtest bcs0: SUCCESS (0.048s)
[580.648303] Starting dynamic subtest: vcs0
[580.684732] Dynamic subtest vcs0: SUCCESS (0.050s)
[580.696451] Starting dynamic subtest: vcs1
[580.714875] Dynamic subtest vcs1: SUCCESS (0.029s)
[580.724073] Starting dynamic subtest: vecs0
[580.743482] Dynamic subtest vecs0: SUCCESS (0.028s)
[580.752794] Starting dynamic subtest: ccs0
[580.774226] Dynamic subtest ccs0: SUCCESS (0.029s)
[580.776582] Subtest thriceslice: SUCCESS (0.220s)
[581.083699] [102/131] (437s left) prime_self_import (export-vs-gem_close-race)
[581.113179] Starting subtest: export-vs-gem_close-race
[586.211103] Subtest export-vs-gem_close-race: SUCCESS (5.097s)
[586.304730] [103/131] (432s left) kms_atomic_transition (plane-all-transition-fencing)
[586.395189] Starting subtest: plane-all-transition-fencing
[586.397715] Starting dynamic subtest: pipe-A-eDP-1
[588.893185] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[589.215086] Starting dynamic subtest: pipe-B-eDP-1
[592.413062] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.210s)
[592.712060] Subtest plane-all-transition-fencing: SUCCESS (6.316s)
[593.555470] [104/131] (424s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[593.668903] Starting subtest: psr-1p-primscrn-cur-indfb-move
[600.866568] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.199s)
[601.003461] [105/131] (417s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[601.069722] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[601.129810] [106/131] (417s left) api_intel_allocator (fork-simple-once)
[601.189065] Starting subtest: fork-simple-once
[601.202313] Subtest fork-simple-once: SUCCESS (0.016s)
[601.348113] [107/131] (417s left) gem_exec_fence (submit)
[601.523502] Starting subtest: submit
[601.528079] Subtest submit: SKIP (0.000s)
[603.026973] [108/131] (415s left) gem_ringfill (engines-basic)
[608.919349] Starting subtest: engines-basic
[608.921422] Starting dynamic subtest: rcs0
[608.983960] Dynamic subtest rcs0: SUCCESS (0.066s)
[608.996571] Starting dynamic subtest: bcs0
[609.027772] Dynamic subtest bcs0: SUCCESS (0.042s)
[609.039798] Starting dynamic subtest: vcs0
[609.070815] Dynamic subtest vcs0: SUCCESS (0.042s)
[609.080781] Starting dynamic subtest: vcs1
[609.112824] Dynamic subtest vcs1: SUCCESS (0.040s)
[609.123080] Starting dynamic subtest: vecs0
[609.155020] Dynamic subtest vecs0: SUCCESS (0.040s)
[609.165927] Starting dynamic subtest: ccs0
[609.200907] Dynamic subtest ccs0: SUCCESS (0.044s)
[609.203529] Subtest engines-basic: SUCCESS (0.285s)
[609.303959] [109/131] (409s left) gem_exec_reloc (basic-wc-read-active)
[609.367672] Subtest basic-wc-read-active: SKIP (0.000s)
[609.448497] [110/131] (409s left) kms_cursor_legacy (forked-move)
[609.566427] Starting subtest: forked-move
[609.568589] Starting dynamic subtest: pipe-A
[615.028325] Dynamic subtest pipe-A: SUCCESS (5.460s)
[615.039594] Starting dynamic subtest: pipe-B
[620.502080] Dynamic subtest pipe-B: SUCCESS (5.471s)
[620.511389] Starting dynamic subtest: pipe-C
[625.966184] Dynamic subtest pipe-C: SUCCESS (5.462s)
[625.976781] Starting dynamic subtest: pipe-D
[631.447516] Dynamic subtest pipe-D: SUCCESS (5.479s)
[631.459335] Starting dynamic subtest: all-pipes
[636.942627] Dynamic subtest all-pipes: SUCCESS (5.493s)
[636.945104] Subtest forked-move: SUCCESS (27.375s)
[637.105107] [111/131] (381s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[637.488637] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[638.264761] [112/131] (380s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[638.329463] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[638.433999] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[638.533826] [113/131] (380s left) prime_mmap (test_userptr)
[638.586614] Starting subtest: test_userptr
[638.588620] Starting dynamic subtest: test_userptr-smem
[638.590576] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[638.592543] Subtest test_userptr: SUCCESS (0.001s)
[638.713347] [114/131] (380s left) gem_close_race (basic-threads)
[638.774865] Starting subtest: basic-threads
[640.108235] Subtest basic-threads: SUCCESS (1.333s)
[640.306350] [115/131] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[640.414597] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[640.418828] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[640.537194] [116/131] (378s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[640.631290] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[640.633625] Starting dynamic subtest: pipe-A-default-mode
[640.918803] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[640.923693] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s)
[641.724183] [117/131] (377s left) gem_ctx_create (basic-files)
[641.787551] Starting subtest: basic-files
[643.795462] Subtest basic-files: SUCCESS (2.008s)
[645.048142] [118/131] (373s left) kms_psr (fbc-pr-dpms)
[645.150075] Starting subtest: fbc-pr-dpms
[645.154056] Subtest fbc-pr-dpms: SKIP (0.000s)
[645.245123] [119/131] (373s left) gem_tiled_wc
[645.369396] [120/131] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[645.475792] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[645.480251] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[645.580311] [121/131] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[645.676147] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[645.680563] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[645.813546] [122/131] (373s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[645.911718] Starting subtest: 4-tiled-32bpp-rotate-0
[647.379820] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.468s)
[647.546480] [123/131] (371s left) kms_sequence (queue-busy)
[647.632395] Starting subtest: queue-busy
[647.634095] Starting dynamic subtest: pipe-A-eDP-1
[649.555329] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[649.565072] Starting dynamic subtest: pipe-B-eDP-1
[652.180164] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.622s)
[652.192958] Starting dynamic subtest: pipe-C-eDP-1
[654.809338] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.629s)
[654.819553] Starting dynamic subtest: pipe-D-eDP-1
[657.356944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[657.359338] Subtest queue-busy: SUCCESS (9.726s)
[658.184139] [124/131] (361s left) gem_exec_schedule (implicit-read-write)
[658.270042] Starting subtest: implicit-read-write
[658.272335] Starting dynamic subtest: rcs0
[658.370229] Dynamic subtest rcs0: SUCCESS (0.110s)
[658.382497] Starting dynamic subtest: vcs0
[658.448647] Dynamic subtest vcs0: SUCCESS (0.077s)
[658.461968] Starting dynamic subtest: vcs1
[658.524265] Dynamic subtest vcs1: SUCCESS (0.075s)
[658.536955] Starting dynamic subtest: vecs0
[658.597464] Dynamic subtest vecs0: SUCCESS (0.073s)
[658.609691] Starting dynamic subtest: ccs0
[658.687063] Dynamic subtest ccs0: SUCCESS (0.089s)
[658.689852] Subtest implicit-read-write: SUCCESS (0.427s)
[660.031605] [125/131] (359s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[660.129396] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[660.270408] [126/131] (359s left) i915_pm_rpm (system-suspend)
[662.094609] Starting subtest: system-suspend
[680.406247] Subtest system-suspend: SUCCESS (2.992s)
[680.788742] [127/131] (338s left) dmabuf (all-tests)
[680.836030] Starting subtest: all-tests
[680.838502] Starting dynamic subtest: sanitycheck
[680.949781] Dynamic subtest sanitycheck: SUCCESS (0.119s)
[680.963537] Starting dynamic subtest: dma_fence
[681.235084] Dynamic subtest dma_fence: SUCCESS (0.290s)
[681.248213] Starting dynamic subtest: dma_fence_chain
[689.860107] Dynamic subtest dma_fence_chain: SUCCESS (8.762s)
[689.873927] Starting dynamic subtest: dma_fence_unwrap
[690.015352] Dynamic subtest dma_fence_unwrap: SUCCESS (0.154s)
[690.028254] Starting dynamic subtest: dma_resv
[690.162732] Dynamic subtest dma_resv: SUCCESS (0.147s)
[690.165153] Subtest all-tests: SUCCESS (9.483s)
[690.242451] [128/131] (329s left) kms_addfb_basic (size-max)
[690.343714] Starting subtest: size-max
[690.345571] Subtest size-max: SUCCESS (0.000s)
[690.490524] [129/131] (328s left) syncobj_timeline (reset-signaled)
[690.545367] Starting subtest: reset-signaled
[690.547619] Subtest reset-signaled: SUCCESS (0.000s)
[690.686906] [130/131] (328s left) prime_busy (after-wait)
[690.739980] Starting subtest: after-wait
[690.745914] Starting dynamic subtest: rcs0
[690.790530] Dynamic subtest rcs0: SUCCESS (0.047s)
[690.802405] Starting dynamic subtest: bcs0
[690.871059] Dynamic subtest bcs0: SUCCESS (0.081s)
[690.880768] Starting dynamic subtest: vcs0
[690.909981] Dynamic subtest vcs0: SUCCESS (0.038s)
[690.921206] Starting dynamic subtest: vcs1
[690.951782] Dynamic subtest vcs1: SUCCESS (0.041s)
[690.962460] Starting dynamic subtest: vecs0
[690.993292] Dynamic subtest vecs0: SUCCESS (0.041s)
[691.004641] Starting dynamic subtest: ccs0
[691.035468] Dynamic subtest ccs0: SUCCESS (0.041s)
[691.141980] Subtest after-wait: SUCCESS (0.403s)
[691.244659] [131/131] (328s left) syncobj_timeline (invalid-query-bad-pad)
[691.297821] Starting subtest: invalid-query-bad-pad
[691.300125] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[691.422720] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_isolation
results: parsing output: 1/ for test: gem_pxp
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_color
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_partial_pwrite_pread
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: i915_module_load
results: parsing output: 22/ for test: kms_draw_crc
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: sysfs_preempt_timeout
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_prime
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: fbdev
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_busy
results: parsing output: 61/ for test: kms_atomic
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: prime_mmap
results: parsing output: 71/ for test: gem_mmap
results: parsing output: 72/ for test: kms_chamelium_color
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: gem_vm_create
results: parsing output: 84/ for test: kms_pipe_crc_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: prime_self_import
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: gem_ringfill
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: gem_close_race
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_ctx_create
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_tiled_wc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_sequence
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: i915_pm_rpm
results: parsing output: 126/ for test: dmabuf
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: prime_busy
results: parsing output: 130/ for test: syncobj_timeline
Done.