[56.479070] Initializing watchdogs
[56.479131]   /dev/watchdog0
[56.494859] [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]
[56.499142] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.501234] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.504540] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[56.636585] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[63.468998] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.837s)
[63.610621] [002/133] (953s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[63.700026] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[63.702192] Starting dynamic subtest: pipe-A-eDP-1
[63.724976] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.732500] Starting dynamic subtest: pipe-B-eDP-1
[63.754378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.761219] Starting dynamic subtest: pipe-C-eDP-1
[63.784079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.792593] Starting dynamic subtest: pipe-D-eDP-1
[63.814068] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.818167] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[66.001898] [003/133] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[66.104713] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[66.107681] Starting dynamic subtest: pipe-A-eDP-1
[66.132827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.142449] Starting dynamic subtest: pipe-B-eDP-1
[66.163122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.169722] Starting dynamic subtest: pipe-C-eDP-1
[66.190575] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.197262] Starting dynamic subtest: pipe-D-eDP-1
[66.220157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.224852] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[68.263710] [004/133] (948s left) gem_softpin (overlap)
[68.339384] Starting subtest: overlap
[69.262653] Subtest overlap: SUCCESS (0.924s)
[69.362107] [005/133] (947s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[69.477066] Starting subtest: basic-flip-after-cursor-varying-size
[70.451296] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.975s)
[71.288292] [006/133] (945s left) kms_setmode (invalid-clone-single-crtc)
[71.360705] Starting subtest: invalid-clone-single-crtc
[71.367894] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[71.457383] [007/133] (945s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[71.523041] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[71.586692] [008/133] (945s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[71.677281] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[71.679565] Starting dynamic subtest: pipe-A
[71.701186] Dynamic subtest pipe-A: SKIP (0.018s)
[71.709323] Starting dynamic subtest: pipe-B
[71.736879] Dynamic subtest pipe-B: SKIP (0.037s)
[71.744106] Starting dynamic subtest: pipe-C
[71.772667] Dynamic subtest pipe-C: SKIP (0.034s)
[71.785698] Starting dynamic subtest: pipe-D
[71.802185] Dynamic subtest pipe-D: SKIP (0.030s)
[71.805926] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.119s)
[71.892829] [009/133] (945s left) i915_suspend (debugfs-reader)
[71.943406] Starting subtest: debugfs-reader
[90.249868] Subtest debugfs-reader: SUCCESS (3.251s)
[90.326586] [010/133] (927s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[90.457205] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[90.459590] Starting dynamic subtest: pipe-A-eDP-1
[97.112211] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.660s)
[97.119786] Starting dynamic subtest: pipe-B-eDP-1
[104.077447] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.964s)
[104.079356] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.625s)
[104.942028] [011/133] (912s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[105.024426] Starting subtest: invalid-bsd2-flag-on-vebox
[105.026404] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[105.136517] [012/133] (912s left) gem_mmap_offset (mmap-unmap)
[105.191072] Starting subtest: mmap-unmap
[105.193371] Starting dynamic subtest: smem0
[127.705819] Dynamic subtest smem0: SUCCESS (22.515s)
[127.708371] Subtest mmap-unmap: SUCCESS (22.515s)
[127.849395] [013/133] (889s left) kms_content_protection (lic-type-0)
[128.013993] Starting subtest: lic-type-0
[128.018333] Subtest lic-type-0: SKIP (0.000s)
[128.129996] [014/133] (889s left) gem_exec_balancer (parallel-bb-first)
[128.375941] Starting subtest: parallel-bb-first
[129.350013] Subtest parallel-bb-first: SUCCESS (0.974s)
[130.009634] [015/133] (887s left) gem_reg_read (timestamp-moving)
[130.066672] Starting subtest: timestamp-moving
[131.067572] Subtest timestamp-moving: SUCCESS (1.001s)
[131.155962] [016/133] (886s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[131.255268] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[138.075125] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.823s)
[138.214617] [017/133] (879s left) syncobj_timeline (single-wait-signaled)
[138.276060] Starting subtest: single-wait-signaled
[138.278437] Subtest single-wait-signaled: SUCCESS (0.001s)
[138.382993] [018/133] (879s left) gem_exec_reloc (basic-gtt-read-active)
[138.447804] Subtest basic-gtt-read-active: SKIP (0.000s)
[138.515677] [019/133] (879s left) syncobj_wait (reset-multiple-signaled)
[138.572240] Starting subtest: reset-multiple-signaled
[138.574451] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[138.663311] [020/133] (879s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[138.766445] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[139.855973] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.089s)
[139.977826] [021/133] (877s left) kms_vblank (ts-continuation-modeset)
[140.071999] Starting subtest: ts-continuation-modeset
[140.074050] Starting dynamic subtest: pipe-A-eDP-1
[141.615526] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.541s)
[141.628595] Starting dynamic subtest: pipe-D-eDP-1
[143.779908] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s)
[143.782113] Subtest ts-continuation-modeset: SUCCESS (3.705s)
[144.575237] [022/133] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[144.681600] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[144.685593] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[144.784043] [023/133] (873s left) kms_dp_aux_dev
[145.141704] [024/133] (872s left) gem_mmap_wc (close)
[145.201362] Subtest close: SKIP (0.000s)
[145.255005] [025/133] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[145.356605] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[149.947056] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.594s)
[151.091337] [026/133] (866s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[151.182357] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[151.184645] Starting dynamic subtest: pipe-A-eDP-1
[151.243542] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[151.250807] Starting dynamic subtest: pipe-B-eDP-1
[151.304992] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[151.313048] Starting dynamic subtest: pipe-C-eDP-1
[151.368122] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[151.376349] Starting dynamic subtest: pipe-D-eDP-1
[151.432874] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[151.436970] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[153.437862] [027/133] (864s left) gem_ctx_persistence (idempotent)
[153.493151] Starting subtest: idempotent
[153.495434] Subtest idempotent: SUCCESS (0.000s)
[153.610568] [028/133] (864s left) prime_mmap (test_reprime)
[153.661329] Starting subtest: test_reprime
[153.663296] Starting dynamic subtest: test_reprime-smem
[153.690453] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[153.692781] Subtest test_reprime: SUCCESS (0.031s)
[153.783398] [029/133] (864s left) kms_psr (fbc-psr-sprite-plane-move)
[153.878296] Starting subtest: fbc-psr-sprite-plane-move
[153.880443] Starting dynamic subtest: eDP-1
[153.884423] Dynamic subtest eDP-1: SKIP (0.000s)
[153.888406] Subtest fbc-psr-sprite-plane-move: SKIP (0.002s)
[153.954482] [030/133] (864s left) syncobj_eventfd (invalid-illegal-handle)
[154.015877] Starting subtest: invalid-illegal-handle
[154.018109] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[154.107674] [031/133] (864s left) gem_exec_schedule (preempt-contexts)
[154.172893] Starting subtest: preempt-contexts
[154.174826] Starting dynamic subtest: rcs0
[154.224902] Dynamic subtest rcs0: SUCCESS (0.060s)
[154.234191] Starting dynamic subtest: bcs0
[154.278408] Dynamic subtest bcs0: SUCCESS (0.053s)
[154.287004] Starting dynamic subtest: vcs0
[154.334781] Dynamic subtest vcs0: SUCCESS (0.056s)
[154.344499] Starting dynamic subtest: vcs1
[154.379336] Dynamic subtest vcs1: SUCCESS (0.044s)
[154.386962] Starting dynamic subtest: vecs0
[154.425031] Dynamic subtest vecs0: SUCCESS (0.045s)
[154.433039] Starting dynamic subtest: ccs0
[154.474814] Dynamic subtest ccs0: SUCCESS (0.049s)
[154.476855] Subtest preempt-contexts: SUCCESS (0.311s)
[156.050589] [032/133] (862s left) kms_atomic_interruptible (universal-setplane-primary)
[156.140722] Starting subtest: universal-setplane-primary
[156.143047] Starting dynamic subtest: pipe-A-eDP-1
[163.566131] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.424s)
[163.568316] Subtest universal-setplane-primary: SUCCESS (7.426s)
[164.416259] [033/133] (853s left) sw_sync (sync_multi_consumer)
[164.452694] Starting subtest: sync_multi_consumer
[164.893139] Subtest sync_multi_consumer: SUCCESS (0.444s)
[164.950647] [034/133] (853s left) gem_exec_fence (parallel)
[165.133677] Starting subtest: parallel
[165.136240] Starting dynamic subtest: rcs0
[167.288027] Dynamic subtest rcs0: SUCCESS (2.154s)
[167.298347] Starting dynamic subtest: bcs0
[169.443265] Dynamic subtest bcs0: SUCCESS (2.155s)
[169.453743] Starting dynamic subtest: vcs0
[171.595097] Dynamic subtest vcs0: SUCCESS (2.151s)
[171.605355] Starting dynamic subtest: vcs1
[173.745221] Dynamic subtest vcs1: SUCCESS (2.150s)
[173.755220] Starting dynamic subtest: vecs0
[175.895125] Dynamic subtest vecs0: SUCCESS (2.149s)
[175.908017] Starting dynamic subtest: ccs0
[178.049050] Dynamic subtest ccs0: SUCCESS (2.153s)
[178.051226] Subtest parallel: SUCCESS (12.917s)
[179.072453] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[179.075474] [035/133] (839s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[179.205586] Starting subtest: 2x-long-cursor-vs-flip-atomic
[179.210078] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[179.360766] [036/133] (838s left) syncobj_wait (invalid-reset-one-illegal-handle)
[179.425533] Starting subtest: invalid-reset-one-illegal-handle
[179.427851] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[179.539883] [037/133] (838s left) i915_hangman (gt-engine-error)
[179.595609] Starting subtest: gt-engine-error
[179.597604] Starting dynamic subtest: rcs0
[180.934434] Dynamic subtest rcs0: SUCCESS (1.338s)
[180.946233] Starting dynamic subtest: bcs0
[182.917012] Dynamic subtest bcs0: SUCCESS (1.980s)
[182.933140] Starting dynamic subtest: vcs0
[184.965560] Dynamic subtest vcs0: SUCCESS (2.046s)
[184.977264] Starting dynamic subtest: vcs1
[186.949769] Dynamic subtest vcs1: SUCCESS (1.981s)
[186.962067] Starting dynamic subtest: vecs0
[188.933745] Dynamic subtest vecs0: SUCCESS (1.982s)
[188.945433] Starting dynamic subtest: ccs0
[190.918763] Dynamic subtest ccs0: SUCCESS (1.983s)
[190.921680] Subtest gt-engine-error: SUCCESS (11.324s)
[190.999510] [038/133] (827s left) kms_prop_blob (invalid-get-prop-any)
[191.062469] Starting subtest: invalid-get-prop-any
[191.064390] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[191.165317] [039/133] (827s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[191.263087] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[191.265363] Starting dynamic subtest: pipe-A-eDP-1
[191.287689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[191.296869] Starting dynamic subtest: pipe-B-eDP-1
[191.318302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.326393] Starting dynamic subtest: pipe-C-eDP-1
[191.347864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.356016] Starting dynamic subtest: pipe-D-eDP-1
[191.377910] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.381929] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[193.480074] [040/133] (825s left) device_reset (cold-reset-bound)
[193.526678] Starting subtest: cold-reset-bound
[193.531505] Subtest cold-reset-bound: SKIP (0.000s)
[193.599487] [041/133] (824s left) gem_flink_basic (flink-lifetime)
[193.647611] Starting subtest: flink-lifetime
[193.649604] Subtest flink-lifetime: SUCCESS (0.002s)
[193.745609] [042/133] (824s left) kms_addfb_basic (addfb25-4-tiled)
[193.837354] Starting subtest: addfb25-4-tiled
[193.839535] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[193.922770] [043/133] (824s left) gem_ppgtt (shrink-vs-evict-pinned)
[193.982747] Starting subtest: shrink-vs-evict-pinned
[199.933729] Subtest shrink-vs-evict-pinned: SUCCESS (5.949s)
[200.026403] [044/133] (818s left) gem_exec_whisper (basic-fds-priority-all)
[200.077539] Starting subtest: basic-fds-priority-all
[224.061816] Subtest basic-fds-priority-all: SUCCESS (23.980s)
[224.248118] [045/133] (794s left) kms_flip (2x-flip-vs-dpms)
[224.350326] Starting subtest: 2x-flip-vs-dpms
[224.361689] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[224.440603] [046/133] (794s left) perf_pmu (semaphore-wait)
[224.483779] Starting subtest: semaphore-wait
[224.485698] Starting dynamic subtest: rcs0
[224.997399] Dynamic subtest rcs0: SUCCESS (0.513s)
[225.008202] Starting dynamic subtest: bcs0
[225.508833] Dynamic subtest bcs0: SUCCESS (0.510s)
[225.523924] Starting dynamic subtest: vcs0
[226.026917] Dynamic subtest vcs0: SUCCESS (0.512s)
[226.038833] Starting dynamic subtest: vcs1
[226.539603] Dynamic subtest vcs1: SUCCESS (0.511s)
[226.551712] Starting dynamic subtest: vecs0
[227.053214] Dynamic subtest vecs0: SUCCESS (0.511s)
[227.064945] Starting dynamic subtest: ccs0
[227.568674] Dynamic subtest ccs0: SUCCESS (0.513s)
[227.571576] Subtest semaphore-wait: SUCCESS (3.087s)
[228.978878] [047/133] (789s left) perf (invalid-oa-metric-set-id)
[229.099758] Starting subtest: invalid-oa-metric-set-id
[229.114478] Subtest invalid-oa-metric-set-id: SUCCESS (0.015s)
[229.152597] [048/133] (789s left) sysfs_preempt_timeout (timeout)
[229.212295] Starting subtest: timeout
[229.214604] Starting dynamic subtest: vecs0
[238.956467] Dynamic subtest vecs0: SUCCESS (9.740s)
[238.968352] Starting dynamic subtest: ccs0
[240.191246] Dynamic subtest ccs0: SUCCESS (1.233s)
[240.200323] Starting dynamic subtest: vcs0
[249.955367] Dynamic subtest vcs0: SUCCESS (9.761s)
[249.974222] Starting dynamic subtest: bcs0
[251.108355] Dynamic subtest bcs0: SUCCESS (1.152s)
[251.119530] Starting dynamic subtest: rcs0
[252.332192] Dynamic subtest rcs0: SUCCESS (1.223s)
[252.345712] Starting dynamic subtest: vcs1
[261.994374] Dynamic subtest vcs1: SUCCESS (9.657s)
[261.997126] Subtest timeout: SUCCESS (32.777s)
[262.069495] [049/133] (756s left) perf_pmu (busy-idle-no-semaphores)
[262.108963] Starting subtest: busy-idle-no-semaphores
[262.111423] Starting dynamic subtest: rcs0
[262.761443] Dynamic subtest rcs0: SUCCESS (0.652s)
[262.772715] Starting dynamic subtest: bcs0
[263.419381] Dynamic subtest bcs0: SUCCESS (0.655s)
[263.430787] Starting dynamic subtest: vcs0
[264.072474] Dynamic subtest vcs0: SUCCESS (0.651s)
[264.084194] Starting dynamic subtest: vcs1
[265.554052] Dynamic subtest vcs1: SUCCESS (1.480s)
[265.564602] Starting dynamic subtest: vecs0
[267.599085] Dynamic subtest vecs0: SUCCESS (2.042s)
[267.610899] Starting dynamic subtest: ccs0
[269.585271] Dynamic subtest ccs0: SUCCESS (1.984s)
[269.587871] Subtest busy-idle-no-semaphores: SUCCESS (7.478s)
[269.701287] [050/133] (749s left) gen9_exec_parse (bb-chained)
[269.762030] Subtest bb-chained: SKIP (0.000s)
[269.841583] [051/133] (749s left) kms_big_fb (linear-64bpp-rotate-180)
[269.938593] Starting subtest: linear-64bpp-rotate-180
[271.573844] Subtest linear-64bpp-rotate-180: SUCCESS (1.635s)
[271.727499] [052/133] (747s left) kms_flip (flip-vs-suspend-interruptible)
[271.828432] Starting subtest: flip-vs-suspend-interruptible
[271.830104] Starting dynamic subtest: A-eDP1
[321.280115] Dynamic subtest A-eDP1: SUCCESS (4.524s)
[321.294767] Starting dynamic subtest: B-eDP1
[370.265559] Dynamic subtest B-eDP1: SUCCESS (4.463s)
[370.277392] Starting dynamic subtest: C-eDP1
[419.268577] Dynamic subtest C-eDP1: SUCCESS (4.538s)
[419.284027] Starting dynamic subtest: D-eDP1
[468.284434] Dynamic subtest D-eDP1: SUCCESS (4.493s)
[468.287528] Subtest flip-vs-suspend-interruptible: SUCCESS (18.028s)
[469.460301] [053/133] (549s left) gem_spin_batch (legacy-resubmit-new)
[469.542680] Starting subtest: legacy-resubmit-new
[469.544569] Starting dynamic subtest: default
[469.552978] Dynamic subtest default: SUCCESS (0.012s)
[469.564042] Starting dynamic subtest: render
[469.566152] Dynamic subtest render: SUCCESS (0.004s)
[469.575104] Starting dynamic subtest: bsd
[469.577092] Dynamic subtest bsd: SUCCESS (0.007s)
[469.590347] Starting dynamic subtest: bsd1
[469.592482] Dynamic subtest bsd1: SUCCESS (0.007s)
[469.601448] Starting dynamic subtest: bsd2
[469.603318] Dynamic subtest bsd2: SUCCESS (0.003s)
[469.611863] Starting dynamic subtest: blt
[469.613689] Dynamic subtest blt: SUCCESS (0.004s)
[469.622205] Starting dynamic subtest: vebox
[469.624121] Dynamic subtest vebox: SUCCESS (0.003s)
[469.625996] Subtest legacy-resubmit-new: SUCCESS (0.050s)
[471.383469] [054/133] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[471.490539] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[471.495075] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[471.609857] [055/133] (547s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[471.701564] Starting subtest: extended-pageflip-modeset-hang-oldfb
[471.703455] Starting dynamic subtest: pipe-A
[479.595550] Dynamic subtest pipe-A: SUCCESS (7.891s)
[479.605499] Starting dynamic subtest: pipe-D
[488.182574] Dynamic subtest pipe-D: SUCCESS (8.581s)
[488.184929] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.476s)
[489.031752] [056/133] (530s left) kms_atomic (plane-overlay-legacy)
[489.128795] Starting subtest: plane-overlay-legacy
[489.130979] Starting dynamic subtest: pipe-A-eDP-1
[489.560172] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[489.562065] Subtest plane-overlay-legacy: SUCCESS (0.431s)
[490.381881] [057/133] (528s left) kms_psr (psr-sprite-plane-move)
[490.474696] Starting subtest: psr-sprite-plane-move
[490.476844] Starting dynamic subtest: eDP-1
[492.229222] Dynamic subtest eDP-1: SUCCESS (1.753s)
[492.231369] Subtest psr-sprite-plane-move: SUCCESS (1.754s)
[493.065804] [058/133] (526s left) gem_exec_create (madvise)
[493.138178] Starting subtest: madvise
[493.140557] Starting dynamic subtest: smem
[513.292058] Dynamic subtest smem: SUCCESS (20.148s)
[513.294678] Subtest madvise: SUCCESS (20.149s)
[514.153016] [059/133] (505s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[514.245764] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[514.250251] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[514.315968] [060/133] (505s left) gem_lmem_swapping (parallel-random)
[514.359702] Subtest parallel-random: SKIP (0.000s)
[514.410621] [061/133] (504s left) kms_flip (2x-plain-flip)
[514.498285] Starting subtest: 2x-plain-flip
[514.507085] Subtest 2x-plain-flip: SKIP (0.010s)
[514.583136] [062/133] (504s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[514.635676] Starting subtest: multi-wait-for-submit-submitted-signaled
[514.638001] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[514.722832] [063/133] (504s left) gem_mmap_gtt (fault-concurrent-x)
[514.771718] Subtest fault-concurrent-X: SKIP (0.000s)
[514.826786] [064/133] (504s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[514.912208] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[521.568711] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.657s)
[521.681002] [065/133] (497s left) prime_mmap_coherency (write)
[521.753301] Starting subtest: write
[527.127510] Subtest write: SUCCESS (5.373s)
[527.279125] [066/133] (492s left) gem_ctx_freq (sysfs)
[527.353498] Starting subtest: sysfs
[527.355914] Starting dynamic subtest: gt0
[532.887767] Dynamic subtest gt0: SUCCESS (5.533s)
[532.900133] Starting dynamic subtest: gt1
[574.369147] Dynamic subtest gt1: SUCCESS (41.471s)
[574.372164] Subtest sysfs: SUCCESS (47.006s)
[574.488011] [067/133] (445s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[574.585376] Starting subtest: fbcpsr-slowdraw
[599.801096] Subtest fbcpsr-slowdraw: SUCCESS (25.214s)
[599.940020] [068/133] (419s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[600.065056] Starting subtest: 2x-cursor-vs-flip-atomic
[600.069596] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[600.212092] [069/133] (419s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[600.335905] Starting subtest: flip-vs-cursor-toggle
[608.921102] Subtest flip-vs-cursor-toggle: SUCCESS (8.583s)
[609.734312] [070/133] (410s left) kms_pm_rpm (modeset-lpsp)
[611.563200] Starting subtest: modeset-lpsp
[613.016649] Subtest modeset-lpsp: SUCCESS (1.457s)
[613.103691] [071/133] (406s left) gem_exec_schedule (fairslice)
[613.192385] Starting subtest: fairslice
[613.194765] Starting dynamic subtest: rcs0
[615.201244] Dynamic subtest rcs0: SUCCESS (2.016s)
[615.213127] Starting dynamic subtest: bcs0
[617.218923] Dynamic subtest bcs0: SUCCESS (2.016s)
[617.229699] Starting dynamic subtest: vcs0
[619.239207] Dynamic subtest vcs0: SUCCESS (2.017s)
[619.250312] Starting dynamic subtest: vcs1
[621.257475] Dynamic subtest vcs1: SUCCESS (2.016s)
[621.266943] Starting dynamic subtest: vecs0
[623.273713] Dynamic subtest vecs0: SUCCESS (2.016s)
[623.288739] Starting dynamic subtest: ccs0
[625.291338] Dynamic subtest ccs0: SUCCESS (2.018s)
[625.293738] Subtest fairslice: SUCCESS (12.105s)
[625.610211] [072/133] (394s left) api_intel_bb (object-reloc-keep-cache)
[625.678771] Starting subtest: object-reloc-keep-cache
[625.685549] Subtest object-reloc-keep-cache: SKIP (0.005s)
[625.835259] [073/133] (394s left) perf_pmu (busy-check-all)
[625.881404] Starting subtest: busy-check-all
[625.883421] Starting dynamic subtest: rcs0
[626.450295] Dynamic subtest rcs0: SUCCESS (0.570s)
[626.462528] Starting dynamic subtest: bcs0
[627.003707] Dynamic subtest bcs0: SUCCESS (0.551s)
[627.015705] Starting dynamic subtest: vcs0
[628.385169] Dynamic subtest vcs0: SUCCESS (1.377s)
[628.398436] Starting dynamic subtest: vcs1
[630.389275] Dynamic subtest vcs1: SUCCESS (1.980s)
[630.399238] Starting dynamic subtest: vecs0
[632.417530] Dynamic subtest vecs0: SUCCESS (2.048s)
[632.430539] Starting dynamic subtest: ccs0
[632.972287] Dynamic subtest ccs0: SUCCESS (0.553s)
[632.974846] Subtest busy-check-all: SUCCESS (7.093s)
[633.087352] [074/133] (386s left) gem_ctx_exec (basic-close-race)
[633.143740] Starting subtest: basic-close-race
[639.159680] Subtest basic-close-race: SUCCESS (6.012s)
[639.290171] [075/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[639.397744] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[639.401717] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[639.489667] [076/133] (380s left) kms_flip (plain-flip-ts-check)
[639.576889] Starting subtest: plain-flip-ts-check
[639.578989] Starting dynamic subtest: A-eDP1
[648.461524] Dynamic subtest A-eDP1: SUCCESS (8.884s)
[648.475947] Starting dynamic subtest: B-eDP1
[657.289706] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[657.304735] Starting dynamic subtest: C-eDP1
[666.105770] Dynamic subtest C-eDP1: SUCCESS (8.812s)
[666.116727] Starting dynamic subtest: D-eDP1
[674.943716] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[674.949150] Subtest plain-flip-ts-check: SUCCESS (35.368s)
[676.125776] [077/133] (343s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[676.219114] Starting subtest: fbc-psr2-cursor-mmap-gtt
[676.221450] Starting dynamic subtest: eDP-1
[676.225803] Dynamic subtest eDP-1: SKIP (0.000s)
[676.230117] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[676.290528] [078/133] (343s left) api_intel_bb (blit-reloc-keep-cache)
[676.342166] Starting subtest: blit-reloc-keep-cache
[676.346333] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[676.470593] [079/133] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[676.571321] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[676.575342] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[676.680963] [080/133] (343s left) gem_softpin (evict-active)
[676.736386] Starting subtest: evict-active
[676.741877] Subtest evict-active: SUCCESS (0.005s)
[676.867189] [081/133] (343s left) kms_chamelium_frames (vga-frame-dump)
[677.243985] Subtest vga-frame-dump: SKIP (0.000s)
[678.036365] [082/133] (342s left) kms_color (ctm-green-to-red)
[678.131117] Starting subtest: ctm-green-to-red
[678.133368] Starting dynamic subtest: pipe-A-eDP-1
[678.821724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[678.831786] Starting dynamic subtest: pipe-B-eDP-1
[680.242770] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[680.254672] Starting dynamic subtest: pipe-C-eDP-1
[681.608172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[681.619602] Starting dynamic subtest: pipe-D-eDP-1
[682.939066] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[682.941295] Subtest ctm-green-to-red: SUCCESS (4.810s)
[683.778522] [083/133] (336s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[683.921185] Starting subtest: cursor-rapid-movement-32x32
[683.967173] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[684.227459] [084/133] (336s left) sw_sync (sync_merge_invalid)
[684.268253] Starting subtest: sync_merge_invalid
[684.288836] Subtest sync_merge_invalid: SUCCESS (0.021s)
[684.367075] [085/133] (336s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[684.420199] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[684.479116] [086/133] (335s left) kms_pm_dc (dc5-dpms-negative)
[685.585757] Starting subtest: dc5-dpms-negative
[685.590302] Subtest dc5-dpms-negative: SKIP (0.000s)
[685.656259] [087/133] (334s left) i915_pm_rpm (gem-idle)
[687.592886] Starting subtest: gem-idle
[693.793166] Subtest gem-idle: SUCCESS (6.204s)
[694.121550] [088/133] (326s left) kms_lease (page-flip-implicit-plane)
[695.350801] Starting subtest: page-flip-implicit-plane
[695.353149] Starting dynamic subtest: pipe-A-eDP-1
[695.858057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s)
[695.871211] Starting dynamic subtest: pipe-B-eDP-1
[696.977663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.115s)
[696.987789] Starting dynamic subtest: pipe-C-eDP-1
[698.084428] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[698.095555] Starting dynamic subtest: pipe-D-eDP-1
[699.213493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[699.215795] Subtest page-flip-implicit-plane: SUCCESS (3.862s)
[700.075933] [089/133] (320s left) gem_wait (busy)
[700.136611] Starting subtest: busy
[700.139030] Starting dynamic subtest: all-engines
[701.344582] Dynamic subtest all-engines: SUCCESS (1.206s)
[701.356415] Starting dynamic subtest: rcs0
[701.883822] Dynamic subtest rcs0: SUCCESS (0.538s)
[701.896665] Starting dynamic subtest: bcs0
[702.422409] Dynamic subtest bcs0: SUCCESS (0.537s)
[702.434461] Starting dynamic subtest: vcs0
[704.417128] Dynamic subtest vcs0: SUCCESS (1.992s)
[704.429447] Starting dynamic subtest: vcs1
[706.401070] Dynamic subtest vcs1: SUCCESS (1.981s)
[706.413308] Starting dynamic subtest: vecs0
[708.384849] Dynamic subtest vecs0: SUCCESS (1.981s)
[708.397810] Starting dynamic subtest: ccs0
[708.926035] Dynamic subtest ccs0: SUCCESS (0.540s)
[708.928626] Subtest busy: SUCCESS (8.788s)
[709.123545] [090/133] (311s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[709.235418] Starting subtest: 4-tiled-64bpp-rotate-90
[709.257922] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.022s)
[709.374580] [091/133] (311s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[709.484276] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[714.081023] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.599s)
[715.275501] [092/133] (305s left) gem_render_copy_redux (flink-interruptible)
[715.342056] Starting subtest: flink-interruptible
[716.088540] Subtest flink-interruptible: SUCCESS (0.747s)
[716.228434] [093/133] (304s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[716.282103] Starting subtest: invalid-single-wait-all-unsubmitted
[716.284115] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[716.361119] [094/133] (304s left) kms_addfb_basic (unused-modifier)
[716.408208] Starting subtest: unused-modifier
[716.410043] Subtest unused-modifier: SUCCESS (0.000s)
[716.555653] [095/133] (304s left) i915_drm_fdinfo (memory-info-idle)
[716.597703] Starting subtest: memory-info-idle
[716.599760] Starting dynamic subtest: smem0
[716.646336] Dynamic subtest smem0: SUCCESS (0.049s)
[716.649078] Subtest memory-info-idle: SUCCESS (0.049s)
[716.727376] [096/133] (304s left) gem_eio (kms)
[716.990781] Starting subtest: kms
[736.654618] Subtest kms: SUCCESS (19.659s)
[737.828991] [097/133] (283s left) gem_exec_fence (basic-busy)
[737.998870] Starting subtest: basic-busy
[738.001301] Starting dynamic subtest: rcs0
[738.077365] Dynamic subtest rcs0: SUCCESS (0.078s)
[738.091900] Starting dynamic subtest: bcs0
[738.131003] Dynamic subtest bcs0: SUCCESS (0.051s)
[738.143391] Starting dynamic subtest: vcs0
[738.186042] Dynamic subtest vcs0: SUCCESS (0.053s)
[738.195962] Starting dynamic subtest: vcs1
[738.242730] Dynamic subtest vcs1: SUCCESS (0.055s)
[738.252672] Starting dynamic subtest: vecs0
[738.301709] Dynamic subtest vecs0: SUCCESS (0.057s)
[738.311324] Starting dynamic subtest: ccs0
[738.361003] Dynamic subtest ccs0: SUCCESS (0.057s)
[738.363694] Subtest basic-busy: SUCCESS (0.364s)
[740.439974] [098/133] (280s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[740.530699] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[740.535072] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[740.603590] [099/133] (280s left) gem_fence_thrash (bo-write-verify-threaded-y)
[740.645748] Starting subtest: bo-write-verify-threaded-y
[740.664964] Subtest bo-write-verify-threaded-y: SKIP (0.017s)
[740.722069] [100/133] (280s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[740.817760] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[740.821610] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[740.925589] [101/133] (280s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[741.020373] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[741.024811] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[741.113722] [102/133] (280s left) kms_plane_multiple (tiling-4)
[741.210518] Starting subtest: tiling-4
[741.212355] Starting dynamic subtest: pipe-A-eDP-1
[744.948390] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.736s)
[744.959446] Starting dynamic subtest: pipe-B-eDP-1
[749.302585] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.355s)
[749.312779] Starting dynamic subtest: pipe-C-eDP-1
[753.651762] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.346s)
[753.661767] Starting dynamic subtest: pipe-D-eDP-1
[757.974296] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.319s)
[757.976721] Subtest tiling-4: SUCCESS (16.761s)
[758.784357] [103/133] (262s left) kms_feature_discovery (psr2)
[758.884412] Starting subtest: psr2
[758.886620] Subtest psr2: SUCCESS (0.000s)
[758.964895] [104/133] (262s left) kms_psr (psr-cursor-render)
[759.059699] Starting subtest: psr-cursor-render
[759.061807] Starting dynamic subtest: eDP-1
[760.782531] Dynamic subtest eDP-1: SUCCESS (1.723s)
[760.784974] Subtest psr-cursor-render: SUCCESS (1.724s)
[761.654974] [105/133] (259s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[761.777395] Starting subtest: basic-busy-flip-before-cursor-varying-size
[761.782131] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[761.923416] [106/133] (259s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[762.030296] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[762.034416] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[762.120628] [107/133] (259s left) syncobj_timeline (host-signal-ordered)
[762.178152] Starting subtest: host-signal-ordered
[762.180117] Subtest host-signal-ordered: SUCCESS (0.000s)
[762.269569] [108/133] (259s left) kms_addfb_basic (invalid-set-prop)
[762.322644] Starting subtest: invalid-set-prop
[762.326087] Subtest invalid-set-prop: SUCCESS (0.000s)
[762.454084] [109/133] (258s left) kms_psr (psr2-basic)
[762.553557] Starting subtest: psr2-basic
[762.555700] Starting dynamic subtest: eDP-1
[764.119919] Dynamic subtest eDP-1: SUCCESS (1.566s)
[764.122295] Subtest psr2-basic: SUCCESS (1.567s)
[764.921422] [110/133] (256s left) gem_mmap_gtt (basic-write-gtt)
[764.972018] Subtest basic-write-gtt: SKIP (0.000s)
[765.030060] [111/133] (256s left) kms_cursor_crc (cursor-onscreen-32x10)
[765.175077] Starting subtest: cursor-onscreen-32x10
[765.221799] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[765.529887] [112/133] (256s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[765.632497] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[765.635037] Starting dynamic subtest: pipe-A-eDP-1
[765.731108] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[765.742540] Starting dynamic subtest: pipe-B-eDP-1
[766.888942] Dynamic subtest pipe-B-eDP-1: SKIP (1.156s)
[766.893278] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.259s)
[768.095581] [113/133] (253s left) kms_chamelium_color (ctm-0-50)
[768.189931] Subtest ctm-0-50: SKIP (0.000s)
[768.236277] [114/133] (253s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[768.327157] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[774.915692] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.589s)
[775.053450] [115/133] (246s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[775.430146] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[776.250389] [116/133] (245s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[776.341153] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[776.343532] Starting dynamic subtest: pipe-A-default-mode
[777.529605] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[777.534385] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.188s)
[777.679887] [117/133] (244s left) gem_exec_schedule (preempt-queue-contexts-chain)
[777.759518] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[778.056571] [118/133] (243s left) kms_getfb (getfb-handle-not-fb)
[778.142122] Starting subtest: getfb-handle-not-fb
[778.144459] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[778.245773] [119/133] (243s left) kms_joiner (basic-force-ultra-joiner)
[778.338751] Starting subtest: basic-force-ultra-joiner
[778.342709] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[778.407451] [120/133] (243s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[778.492913] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[778.589374] [121/133] (243s left) kms_sequence (get-idle)
[778.685005] Starting subtest: get-idle
[778.687315] Starting dynamic subtest: pipe-A-eDP-1
[780.502242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[780.513391] Starting dynamic subtest: pipe-B-eDP-1
[782.975105] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s)
[782.986916] Starting dynamic subtest: pipe-C-eDP-1
[785.412087] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.436s)
[785.422546] Starting dynamic subtest: pipe-D-eDP-1
[787.837436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[787.839769] Subtest get-idle: SUCCESS (9.149s)
[788.644197] [122/133] (233s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[788.750668] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[789.442383] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[789.601270] [123/133] (232s left) fbdev (nullptr)
[789.642554] Starting subtest: nullptr
[789.644939] Subtest nullptr: SUCCESS (0.000s)
[789.704276] [124/133] (232s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[789.808085] Starting subtest: y-tiled-64bpp-rotate-0
[789.812261] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[789.904677] [125/133] (232s left) kms_plane (plane-position-covered)
[790.006980] Starting subtest: plane-position-covered
[790.534029] Starting dynamic subtest: pipe-A-plane-1
[791.825305] Dynamic subtest pipe-A-plane-1: SUCCESS (1.291s)
[791.835380] Starting dynamic subtest: pipe-A-plane-2
[793.148484] Dynamic subtest pipe-A-plane-2: SUCCESS (1.321s)
[793.160494] Starting dynamic subtest: pipe-A-plane-3
[794.469009] Dynamic subtest pipe-A-plane-3: SUCCESS (1.323s)
[794.480737] Starting dynamic subtest: pipe-A-plane-4
[795.769053] Dynamic subtest pipe-A-plane-4: SUCCESS (1.299s)
[795.780378] Starting dynamic subtest: pipe-A-plane-5
[795.796148] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[796.930621] Starting dynamic subtest: pipe-B-plane-1
[798.161625] Dynamic subtest pipe-B-plane-1: SUCCESS (1.240s)
[798.172583] Starting dynamic subtest: pipe-B-plane-2
[799.419272] Dynamic subtest pipe-B-plane-2: SUCCESS (1.257s)
[799.430855] Starting dynamic subtest: pipe-B-plane-3
[800.729375] Dynamic subtest pipe-B-plane-3: SUCCESS (1.309s)
[800.741817] Starting dynamic subtest: pipe-B-plane-4
[801.978991] Dynamic subtest pipe-B-plane-4: SUCCESS (1.249s)
[801.989951] Starting dynamic subtest: pipe-B-plane-5
[802.005365] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[802.007789] Subtest plane-position-covered: SUCCESS (11.997s)
[802.855233] [126/133] (219s left) perf (low-oa-exponent-permissions)
[802.962158] Starting subtest: low-oa-exponent-permissions
[802.990557] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[803.032981] [127/133] (219s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[803.087019] Starting subtest: x-tiled-to-vebox-yf-tiled
[803.091927] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[803.276913] [128/133] (218s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[803.354022] Starting subtest: yf-tiled-to-vebox-x-tiled
[803.358418] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[803.537847] [129/133] (218s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[803.627384] Starting subtest: psr-2p-primscrn-spr-indfb-move
[803.631438] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[803.724440] [130/133] (218s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[803.812604] Starting subtest: basic-max-pipe-crc-check
[803.817174] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[803.863035] [131/133] (218s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[803.918971] Starting subtest: multi-wait-all-for-submit-submitted
[804.020368] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[804.101532] [132/133] (218s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[804.202855] Starting subtest: psr-indfb-scaledprimary
[809.938878] Subtest psr-indfb-scaledprimary: SUCCESS (5.738s)
[810.052180] [133/133] (212s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[810.150728] Starting subtest: yf-tiled-64bpp-rotate-270
[810.155276] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[810.242981] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_setmode
results: parsing output: 6/ for test: gem_fenced_exec_thrash
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: i915_suspend
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_reg_read
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_dp_aux_dev
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: prime_mmap
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: kms_prop_blob
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: device_reset
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_ppgtt
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: sysfs_preempt_timeout
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_create
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: prime_mmap_coherency
results: parsing output: 65/ for test: gem_ctx_freq
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_ctx_exec
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: sw_sync
results: parsing output: 84/ for test: kms_pipe_b_c_ivb
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_wait
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy_redux
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_fence_thrash
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_chamelium_edid
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: kms_joiner
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_sequence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: fbdev
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_multipipe_modeset
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
Done.