[55.773825] Initializing watchdogs
[55.773871]   /dev/watchdog0
[55.789512] [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]
[55.794089] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.796392] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.799632] [001/133] (960s left) syncobj_basic (bad-fd-to-handle)
[55.869176] Starting subtest: bad-fd-to-handle
[55.871188] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[55.960217] [002/133] (960s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[56.066753] Starting subtest: fbc-psr2-cursor-mmap-cpu
[56.069199] Starting dynamic subtest: eDP-1
[56.073545] Dynamic subtest eDP-1: SKIP (0.000s)
[56.077642] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[56.133218] [003/133] (960s left) kms_concurrent (multi-plane-atomic-lowres)
[56.243929] Starting subtest: multi-plane-atomic-lowres
[56.246272] Starting dynamic subtest: pipe-A-eDP-1
[56.772389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[56.780325] Starting dynamic subtest: pipe-B-eDP-1
[58.013514] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[58.021946] Starting dynamic subtest: pipe-C-eDP-1
[59.248867] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[59.260709] Starting dynamic subtest: pipe-D-eDP-1
[60.489662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[60.491979] Subtest multi-plane-atomic-lowres: SUCCESS (4.246s)
[61.321453] [004/133] (955s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[61.427044] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[61.429415] Starting dynamic subtest: pipe-A-eDP-1
[61.489702] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[61.503342] Starting dynamic subtest: pipe-B-eDP-1
[61.561862] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[61.575951] Starting dynamic subtest: pipe-C-eDP-1
[61.634840] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[61.648739] Starting dynamic subtest: pipe-D-eDP-1
[61.706902] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[61.711450] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[63.673714] [005/133] (952s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[63.785911] Starting subtest: cursorB-vs-flipA-atomic-transitions
[63.790583] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[63.940907] [006/133] (952s left) gem_exec_balancer (semaphore)
[63.999282] Starting subtest: semaphore
[65.290248] Subtest semaphore: SUCCESS (1.288s)
[65.633799] [007/133] (950s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[65.735615] Starting subtest: 4-tiled-32bpp-rotate-270
[65.759128] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.021s)
[65.855804] [008/133] (950s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[65.970865] Starting subtest: 2x-flip-vs-cursor-legacy
[65.975246] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[66.113074] [009/133] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[66.208591] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[66.212654] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[66.303807] [010/133] (950s left) kms_flip (flip-vs-expired-vblank-interruptible)
[66.401932] Starting subtest: flip-vs-expired-vblank-interruptible
[66.404183] Starting dynamic subtest: A-eDP1
[75.085497] Dynamic subtest A-eDP1: SUCCESS (8.682s)
[75.093591] Starting dynamic subtest: B-eDP1
[83.700620] Dynamic subtest B-eDP1: SUCCESS (8.613s)
[83.708097] Starting dynamic subtest: C-eDP1
[92.316700] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[92.324743] Starting dynamic subtest: D-eDP1
[100.940554] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[100.944905] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.541s)
[102.124344] [011/133] (914s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[102.230088] Starting subtest: y-tiled-32bpp-rotate-270
[102.234224] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[102.341526] [012/133] (914s left) kms_invalid_mode (clock-too-high)
[102.436221] Starting subtest: clock-too-high
[102.438585] Starting dynamic subtest: pipe-A-eDP-1
[102.730580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[102.742192] Starting dynamic subtest: pipe-B-eDP-1
[102.746615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[102.758822] Starting dynamic subtest: pipe-C-eDP-1
[102.763161] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[102.770147] Starting dynamic subtest: pipe-D-eDP-1
[102.774724] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[102.777044] Subtest clock-too-high: SUCCESS (0.302s)
[103.537594] [013/133] (913s left) gem_exec_fence (submit3)
[103.720904] Starting subtest: submit3
[103.725726] Subtest submit3: SKIP (0.000s)
[105.358356] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[105.361753] [014/133] (911s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[105.469673] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[106.537874] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.069s)
[106.639185] [015/133] (910s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[106.725666] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[106.727692] Starting dynamic subtest: pipe-A-eDP-1
[106.747126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.762997] Starting dynamic subtest: pipe-B-eDP-1
[106.782280] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.791216] Starting dynamic subtest: pipe-C-eDP-1
[106.809492] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.817532] Starting dynamic subtest: pipe-D-eDP-1
[106.835395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.838920] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[109.009336] [016/133] (907s left) gem_tiled_wb
[109.135131] [017/133] (907s left) kms_addfb_basic (invalid-set-prop)
[109.187103] Starting subtest: invalid-set-prop
[109.189074] Subtest invalid-set-prop: SUCCESS (0.000s)
[109.316950] [018/133] (907s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[109.400172] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[109.412380] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[109.486064] [019/133] (907s left) gem_ccs (suspend-resume)
[109.542855] Starting subtest: suspend-resume
[109.547323] Subtest suspend-resume: SKIP (0.000s)
[109.652512] [020/133] (907s left) perf (non-sampling-read-error)
[109.777845] Starting subtest: non-sampling-read-error
[109.788776] Subtest non-sampling-read-error: SUCCESS (0.011s)
[109.829079] [021/133] (907s left) gem_ctx_param (invalid-size-set)
[109.888800] Starting subtest: invalid-size-set
[109.891249] Subtest invalid-size-set: SUCCESS (0.001s)
[109.982489] [022/133] (907s left) syncobj_eventfd (timeline-wait)
[110.042340] Starting subtest: timeline-wait
[110.053091] Subtest timeline-wait: SUCCESS (0.011s)
[110.139029] [023/133] (907s left) gem_ccs (block-copy-compressed)
[110.201359] Starting subtest: block-copy-compressed
[110.204927] Subtest block-copy-compressed: SKIP (0.000s)
[110.312407] [024/133] (906s left) i915_suspend (forcewake)
[110.369078] Starting subtest: forcewake
[142.835359] Subtest forcewake: SUCCESS (2.363s)
[142.928721] [025/133] (874s left) syncobj_wait (invalid-reset-illegal-handle)
[142.998001] Starting subtest: invalid-reset-illegal-handle
[143.000413] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[143.106740] [026/133] (874s left) gem_userptr_blits (sync-unmap-cycles)
[143.179711] Starting subtest: sync-unmap-cycles
[148.551527] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[148.684822] [027/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[148.779832] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[155.496824] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.721s)
[155.624377] [028/133] (861s left) gem_ctx_persistence (engines-hostile-preempt)
[155.684122] Starting subtest: engines-hostile-preempt
[155.686406] Starting dynamic subtest: rcs0
[155.761001] Dynamic subtest rcs0: SUCCESS (0.076s)
[155.772797] Starting dynamic subtest: bcs0
[155.785335] Dynamic subtest bcs0: SUCCESS (0.023s)
[155.793724] Starting dynamic subtest: vcs0
[157.425557] Dynamic subtest vcs0: SUCCESS (1.628s)
[157.434571] Starting dynamic subtest: vcs1
[159.362736] Dynamic subtest vcs1: SUCCESS (1.947s)
[159.375228] Starting dynamic subtest: vecs0
[161.366750] Dynamic subtest vecs0: SUCCESS (2.002s)
[161.379346] Starting dynamic subtest: ccs0
[161.390505] Dynamic subtest ccs0: SUCCESS (0.024s)
[161.392789] Subtest engines-hostile-preempt: SUCCESS (5.706s)
[161.516104] [029/133] (855s left) kms_universal_plane (universal-plane-functional)
[161.616157] Starting subtest: universal-plane-functional
[161.618534] Starting dynamic subtest: pipe-A-eDP-1
[165.618170] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.001s)
[165.627321] Starting dynamic subtest: pipe-B-eDP-1
[170.160520] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.542s)
[170.170174] Starting dynamic subtest: pipe-C-eDP-1
[174.481445] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.319s)
[174.491050] Starting dynamic subtest: pipe-D-eDP-1
[178.880462] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.394s)
[178.882684] Subtest universal-plane-functional: SUCCESS (17.262s)
[179.764719] [030/133] (837s left) gen9_exec_parse (basic-rejected)
[179.835608] Subtest basic-rejected: SKIP (0.000s)
[179.906139] [031/133] (837s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[179.960536] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[179.962606] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[180.054867] [032/133] (837s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[180.148229] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[180.150370] Starting dynamic subtest: pipe-A-eDP-1
[180.172006] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.184605] Starting dynamic subtest: pipe-B-eDP-1
[180.206082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.214603] Starting dynamic subtest: pipe-C-eDP-1
[180.236254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.244905] Starting dynamic subtest: pipe-D-eDP-1
[180.267786] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.272023] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[182.414260] [033/133] (835s left) gem_eio (in-flight-suspend)
[182.643362] Starting subtest: in-flight-suspend
[226.191236] Subtest in-flight-suspend: SUCCESS (13.838s)
[226.339097] [034/133] (791s left) i915_pm_rps (min-max-config-loaded)
[226.399447] Starting subtest: min-max-config-loaded
[226.404386] Subtest min-max-config-loaded: SKIP (0.001s)
[226.522931] [035/133] (791s left) gem_mmap_gtt (basic-write-gtt)
[226.569094] Subtest basic-write-gtt: SKIP (0.000s)
[226.632907] [036/133] (791s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[228.263494] Starting subtest: dpms-mode-unset-non-lpsp
[229.422774] Subtest dpms-mode-unset-non-lpsp: SKIP (1.159s)
[229.799237] [037/133] (787s left) gem_render_copy (linear-to-vebox-y-tiled)
[229.857132] Starting subtest: linear-to-vebox-y-tiled
[229.861656] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[230.057266] [038/133] (787s left) gem_vm_create (execbuf)
[230.125662] Starting subtest: execbuf
[230.132932] Subtest execbuf: SUCCESS (0.007s)
[230.252319] [039/133] (787s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[230.339328] Starting subtest: multiplane-rotation-cropping-bottom
[247.881750] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.538s)
[247.999004] [040/133] (769s left) gem_ctx_param (basic)
[248.064877] Starting subtest: basic
[248.066786] Subtest basic: SUCCESS (0.001s)
[248.173945] [041/133] (769s left) kms_psr (pr-basic)
[248.269664] Starting subtest: pr-basic
[248.273548] Subtest pr-basic: SKIP (0.000s)
[248.347328] [042/133] (769s left) gem_exec_whisper (basic-forked-all)
[248.407211] Starting subtest: basic-forked-all
[262.123414] Subtest basic-forked-all: SUCCESS (13.711s)
[262.315179] [043/133] (755s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[262.432147] Starting subtest: 2x-long-flip-vs-cursor-legacy
[262.436561] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[262.577251] [044/133] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[262.670250] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[269.858461] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.190s)
[270.007195] [045/133] (748s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[270.098737] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[276.747097] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.649s)
[276.866406] [046/133] (741s left) kms_chamelium_audio (hdmi-audio)
[277.246239] Subtest hdmi-audio: SKIP (0.000s)
[278.055350] [047/133] (740s left) gem_ctx_shared (single-timeline)
[278.108475] Starting subtest: single-timeline
[278.129411] Subtest single-timeline: SUCCESS (0.014s)
[278.362616] [048/133] (739s left) kms_big_fb (linear-32bpp-rotate-180)
[278.456189] Starting subtest: linear-32bpp-rotate-180
[280.034677] Subtest linear-32bpp-rotate-180: SUCCESS (1.579s)
[280.155791] [049/133] (738s left) device_reset (cold-reset-bound)
[280.204654] Starting subtest: cold-reset-bound
[280.208656] Subtest cold-reset-bound: SKIP (0.000s)
[280.265427] [050/133] (738s left) gem_exercise_blt (fast-copy)
[280.324200] Starting subtest: fast-copy
[280.326119] Starting dynamic subtest: linear-smem-smem
[280.350696] Dynamic subtest linear-smem-smem: SUCCESS (0.026s)
[280.359487] Starting dynamic subtest: xmajor-smem-smem
[280.369407] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[280.378340] Starting dynamic subtest: tile4-smem-smem
[280.387565] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[280.396360] Starting dynamic subtest: tile64-smem-smem
[280.405499] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[280.407455] Subtest fast-copy: SUCCESS (0.082s)
[280.524698] [051/133] (737s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[280.611261] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[280.613223] Starting dynamic subtest: pipe-A
[280.673730] Dynamic subtest pipe-A: SUCCESS (0.064s)
[280.684335] Starting dynamic subtest: pipe-B
[281.808611] Dynamic subtest pipe-B: SUCCESS (1.133s)
[281.820980] Starting dynamic subtest: pipe-C
[282.940094] Dynamic subtest pipe-C: SUCCESS (1.130s)
[282.949480] Starting dynamic subtest: pipe-D
[284.058435] Dynamic subtest pipe-D: SUCCESS (1.117s)
[284.060742] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.448s)
[285.242764] [052/133] (733s left) kms_addfb_basic (unused-pitches)
[285.289909] Starting subtest: unused-pitches
[285.291984] Subtest unused-pitches: SUCCESS (0.000s)
[285.438486] [053/133] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[285.533378] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[285.537687] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[285.643897] [054/133] (732s left) gem_exec_reloc (basic-write-gtt)
[285.697358] Subtest basic-write-gtt: SKIP (0.000s)
[285.780457] [055/133] (732s left) kms_chamelium_frames (hdmi-crc-multiple)
[286.162739] Subtest hdmi-crc-multiple: SKIP (0.000s)
[286.940089] [056/133] (731s left) gem_mmap_offset (pf-nonblock)
[286.996469] Starting subtest: pf-nonblock
[287.001428] Subtest pf-nonblock: SUCCESS (0.006s)
[287.125149] [057/133] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[287.241962] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[295.013898] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.774s)
[295.151420] [058/133] (723s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[295.242121] Starting subtest: primary-y-tiled-reflect-x-270
[295.246210] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[295.332136] [059/133] (723s left) kms_draw_crc (draw-method-pwrite)
[295.434626] Starting subtest: draw-method-pwrite
[295.436767] Starting dynamic subtest: xrgb8888-untiled
[296.033265] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[296.044959] Starting dynamic subtest: rgb565-untiled
[296.477848] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[296.487706] Starting dynamic subtest: xrgb2101010-untiled
[297.011286] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.531s)
[297.020891] Starting dynamic subtest: xbgr16161616f-untiled
[297.788790] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[297.798628] Starting dynamic subtest: xrgb8888-xtiled
[299.589545] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.799s)
[299.599109] Starting dynamic subtest: rgb565-xtiled
[300.689469] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[300.699658] Starting dynamic subtest: xrgb2101010-xtiled
[302.478971] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.788s)
[302.488772] Starting dynamic subtest: xbgr16161616f-xtiled
[305.757524] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.277s)
[305.767131] Starting dynamic subtest: xrgb8888-4tiled
[306.857778] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[306.867922] Starting dynamic subtest: rgb565-4tiled
[307.424636] Dynamic subtest rgb565-4tiled: SUCCESS (0.565s)
[307.434185] Starting dynamic subtest: xrgb2101010-4tiled
[308.524682] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s)
[308.537417] Starting dynamic subtest: xbgr16161616f-4tiled
[311.558800] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.032s)
[311.561151] Subtest draw-method-pwrite: SUCCESS (16.124s)
[311.666614] [060/133] (707s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[311.764029] Starting subtest: yf-tiled-64bpp-rotate-0
[311.768017] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[311.868273] [061/133] (706s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[311.964119] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[312.060764] [062/133] (706s left) kms_cursor_crc (cursor-alpha-opaque)
[312.144948] Starting subtest: cursor-alpha-opaque
[312.146815] Starting dynamic subtest: pipe-A-eDP-1
[312.756489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[312.766488] Starting dynamic subtest: pipe-D-eDP-1
[314.033045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[314.035333] Subtest cursor-alpha-opaque: SUCCESS (1.890s)
[314.840116] [063/133] (704s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[314.963935] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[314.966196] Starting dynamic subtest: pipe-A-eDP-1
[320.817587] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.858s)
[320.828162] Starting dynamic subtest: pipe-B-eDP-1
[327.488594] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.667s)
[327.490891] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.528s)
[328.357419] [064/133] (690s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[328.415156] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[328.417029] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[328.513277] [065/133] (690s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[328.606929] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[328.609178] Starting dynamic subtest: pipe-A-eDP-1
[328.631950] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.643836] Starting dynamic subtest: pipe-B-eDP-1
[328.662741] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.673613] Starting dynamic subtest: pipe-C-eDP-1
[328.695304] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.704145] Starting dynamic subtest: pipe-D-eDP-1
[328.726243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.730605] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[330.942108] [066/133] (688s left) prime_mmap_coherency (read)
[330.999929] Starting subtest: read
[336.376367] Subtest read: SUCCESS (5.374s)
[336.515101] [067/133] (682s left) kms_cursor_legacy (forked-bo)
[336.634495] Starting subtest: forked-bo
[336.636818] Starting dynamic subtest: pipe-A
[342.119337] Dynamic subtest pipe-A: SUCCESS (5.481s)
[342.131927] Starting dynamic subtest: pipe-B
[347.604045] Dynamic subtest pipe-B: SUCCESS (5.481s)
[347.616074] Starting dynamic subtest: pipe-C
[353.073251] Dynamic subtest pipe-C: SUCCESS (5.466s)
[353.084984] Starting dynamic subtest: pipe-D
[358.540394] Dynamic subtest pipe-D: SUCCESS (5.464s)
[358.555004] Starting dynamic subtest: all-pipes
[364.047585] Dynamic subtest all-pipes: SUCCESS (5.504s)
[364.050003] Subtest forked-bo: SUCCESS (27.407s)
[364.199069] [068/133] (654s left) kms_cursor_edge_walk (256x256-left-edge)
[364.300778] Starting subtest: 256x256-left-edge
[364.303094] Starting dynamic subtest: pipe-A-eDP-1
[367.780069] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[367.789819] Starting dynamic subtest: pipe-D-eDP-1
[370.911402] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[370.913535] Subtest 256x256-left-edge: SUCCESS (6.610s)
[371.720618] [069/133] (647s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[371.817985] Starting subtest: psr-rgb565-draw-mmap-gtt
[371.821922] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[371.912855] [070/133] (647s left) gem_flink_basic (bad-open)
[371.974305] Starting subtest: bad-open
[371.976479] Subtest bad-open: SUCCESS (0.000s)
[372.077057] [071/133] (647s left) gem_exec_gttfill (multigpu-basic)
[372.248551] Starting subtest: multigpu-basic
[386.213858] Subtest multigpu-basic: SUCCESS (13.962s)
[386.267394] [072/133] (633s left) perf_pmu (most-busy-check-all)
[386.342742] Starting subtest: most-busy-check-all
[386.345765] Starting dynamic subtest: rcs0
[388.138818] Dynamic subtest rcs0: SUCCESS (1.794s)
[388.152926] Starting dynamic subtest: bcs0
[390.122890] Dynamic subtest bcs0: SUCCESS (1.981s)
[390.135756] Starting dynamic subtest: vcs0
[392.107089] Dynamic subtest vcs0: SUCCESS (1.981s)
[392.120851] Starting dynamic subtest: vcs1
[394.091299] Dynamic subtest vcs1: SUCCESS (1.981s)
[394.105268] Starting dynamic subtest: vecs0
[396.138917] Dynamic subtest vecs0: SUCCESS (2.044s)
[396.152597] Starting dynamic subtest: ccs0
[398.123571] Dynamic subtest ccs0: SUCCESS (1.981s)
[398.126362] Subtest most-busy-check-all: SUCCESS (11.779s)
[398.215833] [073/133] (621s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[398.340149] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[403.619316] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.281s)
[404.749913] [074/133] (614s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[404.845157] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[404.847452] Starting dynamic subtest: pipe-A-default-mode
[407.557331] Dynamic subtest pipe-A-default-mode: SUCCESS (2.711s)
[407.559629] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.713s)
[408.410887] [075/133] (610s left) kms_psr (psr2-sprite-render)
[408.516612] Starting subtest: psr2-sprite-render
[408.518869] Starting dynamic subtest: eDP-1
[410.218217] Dynamic subtest eDP-1: SUCCESS (1.699s)
[410.220432] Subtest psr2-sprite-render: SUCCESS (1.700s)
[411.085596] [076/133] (608s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[411.463695] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[412.294166] [077/133] (607s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[412.401434] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[412.405525] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[412.518938] [078/133] (607s left) kms_psr (fbc-psr-sprite-plane-onoff)
[412.623325] Starting subtest: fbc-psr-sprite-plane-onoff
[412.625777] Starting dynamic subtest: eDP-1
[412.630379] Dynamic subtest eDP-1: SKIP (0.000s)
[412.634721] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.003s)
[412.708070] [079/133] (606s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[412.797359] Starting subtest: fbcpsr-modesetfrombusy
[418.992407] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.198s)
[419.125885] [080/133] (600s left) gem_eio (in-flight-internal-1us)
[419.329080] Starting subtest: in-flight-internal-1us
[421.153509] Subtest in-flight-internal-1us: SUCCESS (1.822s)
[421.309269] [081/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[421.432539] Starting subtest: fbcpsr-2p-rte
[421.436908] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[421.517568] [082/133] (598s left) gem_mmap_gtt (cpuset-basic-small-copy)
[421.570457] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[421.634575] [083/133] (598s left) syncobj_timeline (single-wait-signaled)
[421.695719] Starting subtest: single-wait-signaled
[421.698174] Subtest single-wait-signaled: SUCCESS (0.000s)
[421.790954] [084/133] (598s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[421.856844] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[421.861489] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[422.053367] [085/133] (597s left) perf_pmu (semaphore-wait-idle)
[422.102434] Starting subtest: semaphore-wait-idle
[422.104524] Starting dynamic subtest: rcs0
[422.615917] Dynamic subtest rcs0: SUCCESS (0.512s)
[422.628394] Starting dynamic subtest: bcs0
[423.130991] Dynamic subtest bcs0: SUCCESS (0.512s)
[423.142852] Starting dynamic subtest: vcs0
[423.644933] Dynamic subtest vcs0: SUCCESS (0.511s)
[423.657784] Starting dynamic subtest: vcs1
[424.160303] Dynamic subtest vcs1: SUCCESS (0.511s)
[424.174049] Starting dynamic subtest: vecs0
[424.677443] Dynamic subtest vecs0: SUCCESS (0.513s)
[424.691243] Starting dynamic subtest: ccs0
[425.193964] Dynamic subtest ccs0: SUCCESS (0.513s)
[425.196815] Subtest semaphore-wait-idle: SUCCESS (3.092s)
[426.168484] [086/133] (593s left) gem_pipe_control_store_loop (reused-buffer)
[426.224683] Starting subtest: reused-buffer
[428.380979] Subtest reused-buffer: SUCCESS (2.155s)
[428.490198] [087/133] (591s left) kms_getfb (getfb-handle-not-fb)
[428.583685] Starting subtest: getfb-handle-not-fb
[428.585997] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[428.691169] [088/133] (591s left) prime_mmap_coherency (write)
[428.754580] Starting subtest: write
[434.130350] Subtest write: SUCCESS (5.374s)
[434.309956] [089/133] (585s left) gem_exec_params (cliprects-invalid)
[434.379392] Starting subtest: cliprects-invalid
[434.381817] Subtest cliprects-invalid: SUCCESS (0.000s)
[434.481471] [090/133] (585s left) kms_pm_rpm (modeset-pc8-residency-stress)
[436.250454] Starting subtest: modeset-pc8-residency-stress
[436.255214] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[436.818017] [091/133] (583s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[436.925375] Starting subtest: 4-tiled-16bpp-rotate-180
[438.159403] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.235s)
[438.285954] [092/133] (581s left) i915_drm_fdinfo (virtual-busy-idle-all)
[438.330285] Starting subtest: virtual-busy-idle-all
[438.334833] Subtest virtual-busy-idle-all: SKIP (0.000s)
[438.399446] [093/133] (581s left) gem_ctx_persistence (legacy-engines-hostile)
[438.473404] Starting subtest: legacy-engines-hostile
[438.475357] Starting dynamic subtest: render
[438.624146] Dynamic subtest render: SUCCESS (0.150s)
[438.639583] Starting dynamic subtest: bsd1
[438.708450] Dynamic subtest bsd1: SUCCESS (0.080s)
[438.723307] Starting dynamic subtest: bsd2
[438.812231] Dynamic subtest bsd2: SUCCESS (0.101s)
[438.827504] Starting dynamic subtest: blt
[438.908061] Dynamic subtest blt: SUCCESS (0.093s)
[438.923147] Starting dynamic subtest: vebox
[438.997337] Dynamic subtest vebox: SUCCESS (0.086s)
[438.999461] Subtest legacy-engines-hostile: SUCCESS (0.525s)
[439.089888] [094/133] (581s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[439.184281] Starting subtest: x-tiled-32bpp-rotate-270
[439.205419] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[439.344302] [095/133] (580s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[439.433925] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[439.435936] Starting dynamic subtest: pipe-A-eDP-1
[439.554732] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[439.567040] Starting dynamic subtest: pipe-B-eDP-1
[440.687310] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[440.691750] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.255s)
[441.881737] [096/133] (578s left) kms_plane (planar-pixel-format-settings)
[441.986926] Starting subtest: planar-pixel-format-settings
[442.051765] Subtest planar-pixel-format-settings: SUCCESS (0.065s)
[442.171035] [097/133] (578s left) syncobj_wait (multi-wait-submitted-signaled)
[442.226101] Starting subtest: multi-wait-submitted-signaled
[442.227982] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[442.326373] [098/133] (578s left) kms_properties (plane-properties-atomic)
[442.421999] Starting subtest: plane-properties-atomic
[442.424333] Starting dynamic subtest: pipe-A-eDP-1
[442.984876] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[442.996285] Starting dynamic subtest: pipe-B-eDP-1
[444.249736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[444.261732] Starting dynamic subtest: pipe-C-eDP-1
[445.561602] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.312s)
[445.572123] Starting dynamic subtest: pipe-D-eDP-1
[446.803356] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[446.805669] Subtest plane-properties-atomic: SUCCESS (4.381s)
[447.600341] [099/133] (572s left) prime_vgem (basic-write)
[447.672235] Starting subtest: basic-write
[447.690536] Subtest basic-write: SKIP (0.016s)
[447.805634] [100/133] (572s left) gem_exec_schedule (preemptive-hang)
[448.000677] Starting subtest: preemptive-hang
[448.003101] Starting dynamic subtest: rcs0
[457.240368] Dynamic subtest rcs0: SUCCESS (9.243s)
[457.252407] Starting dynamic subtest: bcs0
[466.263631] Dynamic subtest bcs0: SUCCESS (9.023s)
[466.275545] Starting dynamic subtest: vcs0
[475.283472] Dynamic subtest vcs0: SUCCESS (9.021s)
[475.293844] Starting dynamic subtest: vcs1
[484.243055] Dynamic subtest vcs1: SUCCESS (8.957s)
[484.252930] Starting dynamic subtest: vecs0
[493.203879] Dynamic subtest vecs0: SUCCESS (8.959s)
[493.215453] Starting dynamic subtest: ccs0
[502.232474] Dynamic subtest ccs0: SUCCESS (9.030s)
[502.235075] Subtest preemptive-hang: SUCCESS (54.243s)
[502.475193] [101/133] (518s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[502.584756] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[502.586995] Starting dynamic subtest: pipe-A-eDP-1
[502.657809] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[502.671339] Starting dynamic subtest: pipe-B-eDP-1
[503.760582] Dynamic subtest pipe-B-eDP-1: SKIP (1.101s)
[503.764722] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.180s)
[504.954694] [102/133] (515s left) gem_softpin (overlap)
[505.011646] Starting subtest: overlap
[505.952724] Subtest overlap: SUCCESS (0.940s)
[506.069086] [103/133] (514s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[506.164483] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[509.849348] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.689s)
[511.034309] [104/133] (509s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[511.142528] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[511.144792] Starting dynamic subtest: A-eDP1
[514.767988] Dynamic subtest A-eDP1: SUCCESS (3.626s)
[514.778733] Starting dynamic subtest: B-eDP1
[518.065402] Dynamic subtest B-eDP1: SUCCESS (3.295s)
[518.078615] Starting dynamic subtest: C-eDP1
[521.179657] Dynamic subtest C-eDP1: SUCCESS (3.114s)
[521.190680] Starting dynamic subtest: D-eDP1
[524.305216] Dynamic subtest D-eDP1: SUCCESS (3.124s)
[524.307524] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.168s)
[525.100436] [105/133] (495s left) gem_exec_schedule (semaphore-codependency)
[525.183717] Starting subtest: semaphore-codependency
[525.188526] Subtest semaphore-codependency: SUCCESS (0.010s)
[525.522385] [106/133] (495s left) kms_flip (flip-vs-expired-vblank)
[525.624980] Starting subtest: flip-vs-expired-vblank
[525.627111] Starting dynamic subtest: A-eDP1
[534.292453] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[534.303215] Starting dynamic subtest: B-eDP1
[542.924885] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[542.935934] Starting dynamic subtest: C-eDP1
[551.552039] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[551.568431] Starting dynamic subtest: D-eDP1
[560.183152] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[560.188854] Subtest flip-vs-expired-vblank: SUCCESS (34.563s)
[561.360349] [107/133] (459s left) gem_mmap_offset (partial-mmap)
[561.418967] Starting subtest: partial-mmap
[561.421145] Starting dynamic subtest: smem0
[561.423398] Dynamic subtest smem0: SUCCESS (0.004s)
[561.425303] Subtest partial-mmap: SUCCESS (0.005s)
[561.545993] [108/133] (459s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[561.641172] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[561.645022] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[561.726148] [109/133] (459s left) perf_pmu (all-busy-check-all)
[561.775069] Starting subtest: all-busy-check-all
[563.117067] Subtest all-busy-check-all: SUCCESS (1.339s)
[563.240178] [110/133] (457s left) kms_color (ctm-negative)
[563.348215] Starting subtest: ctm-negative
[563.350460] Starting dynamic subtest: pipe-A-eDP-1
[564.059855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[564.071100] Starting dynamic subtest: pipe-B-eDP-1
[565.478790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[565.489753] Starting dynamic subtest: pipe-C-eDP-1
[566.856945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[566.868088] Starting dynamic subtest: pipe-D-eDP-1
[568.179940] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[568.182147] Subtest ctm-negative: SUCCESS (4.831s)
[568.991396] [111/133] (451s left) kms_lease (lease-unleased-crtc)
[569.087056] Starting subtest: lease-unleased-crtc
[569.089362] Starting dynamic subtest: pipe-A-eDP-1
[569.386557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[569.400933] Starting dynamic subtest: pipe-B-eDP-1
[570.139373] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.749s)
[570.152469] Starting dynamic subtest: pipe-C-eDP-1
[570.154710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[570.165473] Starting dynamic subtest: pipe-D-eDP-1
[570.167756] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[570.169995] Subtest lease-unleased-crtc: SUCCESS (1.065s)
[570.504079] [112/133] (450s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[570.606193] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[570.636273] Starting dynamic subtest: pipe-A-plane-0
[571.297492] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[571.308101] Starting dynamic subtest: pipe-A-plane-3
[571.775712] Dynamic subtest pipe-A-plane-3: SUCCESS (0.477s)
[572.889091] Starting dynamic subtest: pipe-B-plane-0
[573.547009] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[573.558321] Starting dynamic subtest: pipe-B-plane-3
[573.969159] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[574.290549] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.687s)
[575.195411] [113/133] (445s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[575.300475] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[575.304807] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[575.405436] [114/133] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[575.496995] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[575.500988] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[575.598754] [115/133] (445s left) i915_drm_fdinfo (virtual-busy-all)
[575.640456] Starting subtest: virtual-busy-all
[575.645166] Subtest virtual-busy-all: SKIP (0.000s)
[575.706565] [116/133] (445s left) kms_plane_lowres (tiling-yf)
[575.807630] Starting subtest: tiling-yf
[575.811553] Subtest tiling-yf: SKIP (0.000s)
[575.893786] [117/133] (445s left) perf (low-oa-exponent-permissions)
[575.993669] Starting subtest: low-oa-exponent-permissions
[576.030039] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[576.079294] [118/133] (445s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[576.185897] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[581.216575] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.032s)
[582.378814] [119/133] (438s left) kms_pipe_crc_basic (hang-read-crc)
[582.482922] Starting subtest: hang-read-crc
[582.485057] Starting dynamic subtest: pipe-A-eDP-1
[584.556355] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[584.567986] Starting dynamic subtest: pipe-B-eDP-1
[587.345662] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.786s)
[587.359061] Starting dynamic subtest: pipe-C-eDP-1
[589.981930] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s)
[589.993443] Starting dynamic subtest: pipe-D-eDP-1
[592.640392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[592.642827] Subtest hang-read-crc: SUCCESS (10.159s)
[593.484297] [120/133] (427s left) sysfs_preempt_timeout (invalid)
[593.553739] Starting subtest: invalid
[593.556018] Starting dynamic subtest: vecs0
[593.558323] Dynamic subtest vecs0: SUCCESS (0.000s)
[593.569700] Starting dynamic subtest: ccs0
[593.572489] Dynamic subtest ccs0: SUCCESS (0.000s)
[593.582928] Starting dynamic subtest: vcs0
[593.585193] Dynamic subtest vcs0: SUCCESS (0.000s)
[593.597530] Starting dynamic subtest: bcs0
[593.599667] Dynamic subtest bcs0: SUCCESS (0.000s)
[593.610047] Starting dynamic subtest: rcs0
[593.611921] Dynamic subtest rcs0: SUCCESS (0.000s)
[593.622430] Starting dynamic subtest: vcs1
[593.624570] Dynamic subtest vcs1: SUCCESS (0.000s)
[593.626679] Subtest invalid: SUCCESS (0.006s)
[593.684599] [121/133] (427s left) syncobj_timeline (invalid-signal-illegal-point)
[593.758829] Starting subtest: invalid-signal-illegal-point
[593.761231] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[593.866415] [122/133] (427s left) kms_vblank (wait-forked-hang)
[593.967714] Starting subtest: wait-forked-hang
[593.969988] Starting dynamic subtest: pipe-A-eDP-1
[620.838678] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.865s)
[620.854405] Starting dynamic subtest: pipe-D-eDP-1
[635.878765] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s)
[635.881244] Subtest wait-forked-hang: SUCCESS (41.908s)
[636.728540] [123/133] (384s left) perf_pmu (busy-check-all)
[636.771432] Starting subtest: busy-check-all
[636.773690] Starting dynamic subtest: rcs0
[637.321896] Dynamic subtest rcs0: SUCCESS (0.550s)
[637.335546] Starting dynamic subtest: bcs0
[637.872833] Dynamic subtest bcs0: SUCCESS (0.549s)
[637.886542] Starting dynamic subtest: vcs0
[639.083136] Dynamic subtest vcs0: SUCCESS (1.206s)
[639.096806] Starting dynamic subtest: vcs1
[641.131333] Dynamic subtest vcs1: SUCCESS (2.044s)
[641.145101] Starting dynamic subtest: vecs0
[643.115196] Dynamic subtest vecs0: SUCCESS (1.980s)
[643.128811] Starting dynamic subtest: ccs0
[643.670496] Dynamic subtest ccs0: SUCCESS (0.554s)
[643.673156] Subtest busy-check-all: SUCCESS (6.900s)
[643.765313] [124/133] (377s left) api_intel_bb (lot-of-buffers)
[643.828038] Starting subtest: lot-of-buffers
[644.879634] Subtest lot-of-buffers: SUCCESS (1.052s)
[645.579531] [125/133] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[645.680152] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[653.113937] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.435s)
[653.231318] [126/133] (368s left) gem_spin_batch (legacy-resubmit)
[653.296611] Starting subtest: legacy-resubmit
[653.298938] Starting dynamic subtest: default
[653.303582] Dynamic subtest default: SUCCESS (0.006s)
[653.314957] Starting dynamic subtest: render
[653.317640] Dynamic subtest render: SUCCESS (0.001s)
[653.327836] Starting dynamic subtest: bsd
[653.329805] Dynamic subtest bsd: SUCCESS (0.002s)
[653.339957] Starting dynamic subtest: bsd1
[653.341821] Dynamic subtest bsd1: SUCCESS (0.001s)
[653.351923] Starting dynamic subtest: bsd2
[653.353794] Dynamic subtest bsd2: SUCCESS (0.002s)
[653.363659] Starting dynamic subtest: blt
[653.365588] Dynamic subtest blt: SUCCESS (0.002s)
[653.375468] Starting dynamic subtest: vebox
[653.377371] Dynamic subtest vebox: SUCCESS (0.002s)
[653.379243] Subtest legacy-resubmit: SUCCESS (0.022s)
[653.554091] [127/133] (368s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[653.658150] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[653.660387] Starting dynamic subtest: pipe-A-default-mode
[656.404211] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[656.406608] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.749s)
[657.252154] [128/133] (364s left) api_intel_allocator (gem-pool)
[657.314095] Starting subtest: gem-pool
[657.319078] Subtest gem-pool: SUCCESS (0.008s)
[657.436805] [129/133] (364s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[657.536765] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[657.541108] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[657.637324] [130/133] (364s left) syncobj_wait (invalid-wait-bad-flags)
[657.698373] Starting subtest: invalid-wait-bad-flags
[657.700642] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[657.820284] [131/133] (364s left) gem_exec_balancer (bonded-chain)
[657.878779] Starting subtest: bonded-chain
[664.901919] Subtest bonded-chain: SUCCESS (7.020s)
[665.253179] [132/133] (356s left) kms_cursor_crc (cursor-random-max-size)
[665.575941] Starting subtest: cursor-random-max-size
[665.582085] Subtest cursor-random-max-size: SKIP (0.000s)
[665.705064] [133/133] (356s left) prime_mmap_kms (buffer-sharing)
[665.793024] Starting subtest: buffer-sharing
[666.236462] Subtest buffer-sharing: SUCCESS (0.443s)
[667.089250] Closing watchdogs
results: parsing output: 0/ for test: syncobj_basic
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_concurrent
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_invalid_mode
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_tiled_wb
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_ccs
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: gem_ctx_param
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: gem_ccs
results: parsing output: 23/ for test: i915_suspend
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_universal_plane
results: parsing output: 29/ for test: gen9_exec_parse
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: i915_pm_rps
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: gem_vm_create
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_exec_whisper
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_chamelium_audio
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: device_reset
results: parsing output: 49/ for test: gem_exercise_blt
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_chamelium_frames
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: kms_draw_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: prime_mmap_coherency
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_cursor_edge_walk
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_flink_basic
results: parsing output: 70/ for test: gem_exec_gttfill
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip_scaled_crc
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_pipe_control_store_loop
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: prime_mmap_coherency
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: i915_drm_fdinfo
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: prime_vgem
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: sysfs_preempt_timeout
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_spin_batch
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: api_intel_allocator
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: prime_mmap_kms
Done.