[57.031500] Initializing watchdogs
[57.031632]   /dev/watchdog0
[57.046979] [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]
[57.051565] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.054018] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.057211] [001/132] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[57.185319] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[58.012040] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s)
[58.179288] [002/132] (959s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[58.266472] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[58.270946] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[59.398566] [003/132] (958s left) gem_softpin (noreloc-s3)
[59.467044] Starting subtest: noreloc-S3
[79.976280] Subtest noreloc-S3: SUCCESS (5.404s)
[80.098780] [004/132] (937s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[80.233506] Starting subtest: flip-vs-cursor-busy-crc-atomic
[81.039459] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.823s)
[81.815795] [005/132] (935s left) kms_plane_scaling (2x-scaler-multi-pipe)
[81.906168] Starting subtest: 2x-scaler-multi-pipe
[81.910662] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[82.014261] [006/132] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[82.112327] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[91.550175] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.550s)
[91.671611] [007/132] (926s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[91.786393] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[91.790598] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[91.884511] [008/132] (925s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[91.982292] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[96.395573] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.436s)
[97.566990] [009/132] (920s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[97.624838] Starting subtest: single-wait-for-submit-available-submitted
[97.627327] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[97.736069] [010/132] (920s left) kms_async_flips (crc)
[97.847041] Starting subtest: crc
[98.228186] Starting dynamic subtest: pipe-A-eDP-1
[101.184981] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.940s)
[101.545809] Starting dynamic subtest: pipe-B-eDP-1
[104.509823] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.959s)
[104.867301] Starting dynamic subtest: pipe-C-eDP-1
[107.797712] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.944s)
[108.176607] Starting dynamic subtest: pipe-D-eDP-1
[111.077031] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.881s)
[111.079432] Subtest crc: SUCCESS (13.215s)
[112.205841] [011/132] (905s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[112.326933] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[112.329392] Starting dynamic subtest: pipe-A-default-mode
[113.466720] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[113.471073] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.139s)
[113.622057] [012/132] (904s left) gem_lmem_swapping (heavy-verify-random)
[113.664805] Subtest heavy-verify-random: SKIP (0.000s)
[113.707967] [013/132] (904s left) kms_force_connector_basic (force-load-detect)
[113.774021] Starting subtest: force-load-detect
[113.778784] Subtest force-load-detect: SKIP (0.000s)
[113.897668] [014/132] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[114.000284] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[114.004383] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[114.119616] [015/132] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[114.219680] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[114.224170] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[114.313565] [016/132] (903s left) gem_eio (in-flight-contexts-10ms)
[114.525258] Starting subtest: in-flight-contexts-10ms
[128.560942] Subtest in-flight-contexts-10ms: SUCCESS (14.033s)
[128.693017] [017/132] (889s left) i915_hangman (gt-error-state-capture)
[128.771714] Starting subtest: gt-error-state-capture
[128.774396] Starting dynamic subtest: rcs0
[140.471000] Dynamic subtest rcs0: SUCCESS (11.702s)
[140.483319] Starting dynamic subtest: bcs0
[152.503268] Dynamic subtest bcs0: SUCCESS (12.034s)
[152.515487] Starting dynamic subtest: vcs0
[163.447722] Dynamic subtest vcs0: SUCCESS (10.946s)
[163.460033] Starting dynamic subtest: vcs1
[174.453710] Dynamic subtest vcs1: SUCCESS (11.005s)
[174.465117] Starting dynamic subtest: vecs0
[185.461853] Dynamic subtest vecs0: SUCCESS (11.002s)
[185.473228] Starting dynamic subtest: ccs0
[195.510295] Dynamic subtest ccs0: SUCCESS (10.045s)
[195.513005] Subtest gt-error-state-capture: SUCCESS (66.744s)
[195.643638] [018/132] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[195.753117] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[195.757640] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[195.844979] [019/132] (822s left) i915_drm_fdinfo (busy-check-all)
[195.892127] Starting subtest: busy-check-all
[195.894828] Starting dynamic subtest: rcs0
[195.899540] Dynamic subtest rcs0: SKIP (0.003s)
[195.910225] Starting dynamic subtest: bcs0
[195.914621] Dynamic subtest bcs0: SKIP (0.000s)
[195.923609] Starting dynamic subtest: vcs0
[195.928035] Dynamic subtest vcs0: SKIP (0.000s)
[195.936374] Starting dynamic subtest: vcs1
[195.940485] Dynamic subtest vcs1: SKIP (0.000s)
[195.948615] Starting dynamic subtest: vecs0
[195.952670] Dynamic subtest vecs0: SKIP (0.000s)
[195.960739] Starting dynamic subtest: ccs0
[195.964770] Dynamic subtest ccs0: SKIP (0.000s)
[195.968866] Subtest busy-check-all: SKIP (0.007s)
[196.003344] [020/132] (822s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[196.128115] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[196.130044] Starting dynamic subtest: pipe-A
[196.465026] Dynamic subtest pipe-A: SUCCESS (0.339s)
[196.473869] Starting dynamic subtest: pipe-B
[197.911558] Dynamic subtest pipe-B: SUCCESS (1.445s)
[197.920635] Starting dynamic subtest: pipe-C
[199.364819] Dynamic subtest pipe-C: SUCCESS (1.453s)
[199.375318] Starting dynamic subtest: pipe-D
[200.775985] Dynamic subtest pipe-D: SUCCESS (1.410s)
[200.778442] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.650s)
[201.935195] [021/132] (816s left) kms_flip (absolute-wf_vblank-interruptible)
[202.050900] Starting subtest: absolute-wf_vblank-interruptible
[202.053544] Starting dynamic subtest: A-eDP1
[210.796498] Dynamic subtest A-eDP1: SUCCESS (8.745s)
[210.808953] Starting dynamic subtest: B-eDP1
[219.562358] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[219.571951] Starting dynamic subtest: C-eDP1
[228.293809] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[228.304993] Starting dynamic subtest: D-eDP1
[237.020971] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[237.023990] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.927s)
[238.203415] [022/132] (780s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[238.275661] Starting subtest: invalid-bsd2-flag-on-vebox
[238.278026] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[238.373122] [023/132] (780s left) kms_psr (fbc-psr2-sprite-render)
[238.466984] Starting subtest: fbc-psr2-sprite-render
[238.469381] Starting dynamic subtest: eDP-1
[238.473790] Dynamic subtest eDP-1: SKIP (0.000s)
[238.478678] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[238.538259] [024/132] (779s left) gem_exec_whisper (basic-normal)
[238.606042] Starting subtest: basic-normal
[243.978977] Subtest basic-normal: SUCCESS (5.354s)
[244.143841] [025/132] (774s left) api_intel_allocator (execbuf-with-allocator)
[244.198506] Starting subtest: execbuf-with-allocator
[244.206841] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[244.340347] [026/132] (774s left) gem_flink_race (flink_close)
[244.381172] Starting subtest: flink_close
[249.484068] Subtest flink_close: SUCCESS (5.099s)
[249.553360] [027/132] (769s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[249.648835] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[249.651226] Starting dynamic subtest: pipe-A-eDP-1
[249.674333] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.686630] Starting dynamic subtest: pipe-B-eDP-1
[249.709351] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.718573] Starting dynamic subtest: pipe-C-eDP-1
[249.739868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[249.749073] Starting dynamic subtest: pipe-D-eDP-1
[249.771144] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.775565] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[251.942218] [028/132] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[252.051130] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[252.055187] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[252.147564] [029/132] (766s left) kms_content_protection (dp-mst-type-0-hdcp14)
[252.277969] Starting subtest: dp-mst-type-0-hdcp14
[252.282621] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[252.418752] [030/132] (766s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[252.544783] Starting subtest: cursor-vs-flip-atomic
[282.202176] Subtest cursor-vs-flip-atomic: SUCCESS (29.662s)
[283.073571] [031/132] (735s left) syncobj_wait (wait-all-complex)
[283.133976] Starting subtest: wait-all-complex
[283.351487] Subtest wait-all-complex: SUCCESS (0.217s)
[283.426218] [032/132] (735s left) device_reset (cold-reset-bound)
[283.466575] Starting subtest: cold-reset-bound
[283.471132] Subtest cold-reset-bound: SKIP (0.000s)
[283.534832] [033/132] (735s left) kms_plane_multiple (tiling-y)
[283.625979] Starting subtest: tiling-y
[283.630288] Subtest tiling-y: SKIP (0.000s)
[283.710721] [034/132] (735s left) gem_exec_capture (userptr)
[283.774994] Starting subtest: userptr
[284.617795] Subtest userptr: SUCCESS (0.842s)
[284.731257] [035/132] (734s left) sysfs_preempt_timeout (idempotent)
[284.782320] Starting subtest: idempotent
[284.784509] Starting dynamic subtest: vecs0
[284.786769] Dynamic subtest vecs0: SUCCESS (0.000s)
[284.797146] Starting dynamic subtest: ccs0
[284.798985] Dynamic subtest ccs0: SUCCESS (0.000s)
[284.808359] Starting dynamic subtest: vcs0
[284.810211] Dynamic subtest vcs0: SUCCESS (0.000s)
[284.821994] Starting dynamic subtest: bcs0
[284.824386] Dynamic subtest bcs0: SUCCESS (0.000s)
[284.834405] Starting dynamic subtest: rcs0
[284.836565] Dynamic subtest rcs0: SUCCESS (0.000s)
[284.845417] Starting dynamic subtest: vcs1
[284.847236] Dynamic subtest vcs1: SUCCESS (0.000s)
[284.849090] Subtest idempotent: SUCCESS (0.006s)
[284.893597] [036/132] (734s left) sw_sync (sync_merge_same)
[284.927257] Starting subtest: sync_merge_same
[284.929438] Subtest sync_merge_same: SUCCESS (0.000s)
[284.980354] [037/132] (733s left) prime_vgem (basic-gtt)
[285.134869] Starting subtest: basic-gtt
[285.140560] Subtest basic-gtt: SKIP (0.000s)
[285.240959] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[285.244158] [038/132] (733s left) kms_prop_blob (invalid-get-prop-any)
[285.296131] Starting subtest: invalid-get-prop-any
[285.298128] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[285.390228] [039/132] (733s left) gem_exec_parallel (userptr)
[285.448134] Starting subtest: userptr
[285.450395] Starting dynamic subtest: rcs0
[286.966204] Dynamic subtest rcs0: SUCCESS (1.518s)
[286.982182] Starting dynamic subtest: bcs0
[288.453770] Dynamic subtest bcs0: SUCCESS (1.486s)
[288.466627] Starting dynamic subtest: vcs0
[290.519197] Dynamic subtest vcs0: SUCCESS (2.062s)
[290.531659] Starting dynamic subtest: vcs1
[292.567500] Dynamic subtest vcs1: SUCCESS (2.047s)
[292.580558] Starting dynamic subtest: vecs0
[294.485927] Dynamic subtest vecs0: SUCCESS (1.917s)
[294.495701] Starting dynamic subtest: ccs0
[295.986277] Dynamic subtest ccs0: SUCCESS (1.500s)
[295.988965] Subtest userptr: SUCCESS (10.541s)
[296.179386] [040/132] (722s left) gem_flink_basic (flink-lifetime)
[296.233738] Starting subtest: flink-lifetime
[296.236446] Subtest flink-lifetime: SUCCESS (0.002s)
[296.333426] [041/132] (722s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[296.519973] Starting subtest: cursor-rapid-movement-64x64
[296.524958] Starting dynamic subtest: pipe-A-eDP-1
[297.061952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[297.090525] Starting dynamic subtest: pipe-D-eDP-1
[298.269881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[298.272279] Subtest cursor-rapid-movement-64x64: SUCCESS (1.749s)
[299.119253] [042/132] (720s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[299.217907] Starting subtest: disable-crc-after-crtc
[299.219960] Starting dynamic subtest: pipe-A-eDP-1
[300.855771] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.635s)
[300.867111] Starting dynamic subtest: pipe-B-eDP-1
[303.124199] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.268s)
[303.135748] Starting dynamic subtest: pipe-C-eDP-1
[305.390226] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.264s)
[305.401299] Starting dynamic subtest: pipe-D-eDP-1
[307.655191] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s)
[307.657489] Subtest disable-crc-after-crtc: SUCCESS (8.434s)
[308.474025] [043/132] (710s left) gem_mmap_offset (bad-object)
[308.532202] Starting subtest: bad-object
[308.534363] Subtest bad-object: SUCCESS (0.001s)
[308.649418] [044/132] (710s left) syncobj_eventfd (timeline-wait-before-signal)
[308.709844] Starting subtest: timeline-wait-before-signal
[308.739037] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[308.827964] [045/132] (710s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[308.925666] Starting subtest: psr-1p-pri-indfb-multidraw
[331.497690] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.571s)
[331.612022] [046/132] (687s left) gem_pxp (regular-baseline-src-copy-readible)
[331.742338] Starting subtest: regular-baseline-src-copy-readible
[331.797971] Subtest regular-baseline-src-copy-readible: SUCCESS (0.058s)
[331.905944] [047/132] (687s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[332.009093] Starting subtest: psr-rgb565-draw-mmap-cpu
[338.761413] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.754s)
[338.887485] [048/132] (680s left) kms_color (ctm-0-50)
[339.004200] Starting subtest: ctm-0-50
[339.006527] Starting dynamic subtest: pipe-A-eDP-1
[342.445708] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[342.455880] Starting dynamic subtest: pipe-B-eDP-1
[346.741838] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.294s)
[346.751591] Starting dynamic subtest: pipe-C-eDP-1
[350.792528] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.049s)
[350.802706] Starting dynamic subtest: pipe-D-eDP-1
[354.784148] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[354.786363] Subtest ctm-0-50: SUCCESS (15.782s)
[355.599282] [049/132] (663s left) gen9_exec_parse (bb-chained)
[355.661087] Subtest bb-chained: SKIP (0.000s)
[355.734411] [050/132] (663s left) i915_query (engine-info-invalid)
[355.788148] Starting subtest: engine-info-invalid
[355.790438] Subtest engine-info-invalid: SUCCESS (0.000s)
[355.895704] [051/132] (663s left) api_intel_bb (lot-of-buffers)
[355.970074] Starting subtest: lot-of-buffers
[357.026576] Subtest lot-of-buffers: SUCCESS (1.056s)
[357.575012] [052/132] (662s left) prime_busy (before-wait)
[357.637591] Starting subtest: before-wait
[357.643132] Starting dynamic subtest: rcs0
[357.679525] Dynamic subtest rcs0: SUCCESS (0.038s)
[357.691369] Starting dynamic subtest: bcs0
[357.733640] Dynamic subtest bcs0: SUCCESS (0.053s)
[357.746994] Starting dynamic subtest: vcs0
[357.775022] Dynamic subtest vcs0: SUCCESS (0.041s)
[357.784778] Starting dynamic subtest: vcs1
[357.815187] Dynamic subtest vcs1: SUCCESS (0.040s)
[357.824700] Starting dynamic subtest: vecs0
[357.856966] Dynamic subtest vecs0: SUCCESS (0.041s)
[357.866463] Starting dynamic subtest: ccs0
[357.897625] Dynamic subtest ccs0: SUCCESS (0.040s)
[358.006339] Subtest before-wait: SUCCESS (0.367s)
[358.080110] [053/132] (661s left) gem_exec_schedule (preempt-other)
[358.163103] Starting subtest: preempt-other
[358.165304] Starting dynamic subtest: rcs0
[358.300730] Dynamic subtest rcs0: SUCCESS (0.138s)
[358.310967] Starting dynamic subtest: bcs0
[358.421241] Dynamic subtest bcs0: SUCCESS (0.119s)
[358.432358] Starting dynamic subtest: vcs0
[358.537433] Dynamic subtest vcs0: SUCCESS (0.115s)
[358.548066] Starting dynamic subtest: vcs1
[358.662570] Dynamic subtest vcs1: SUCCESS (0.124s)
[358.673833] Starting dynamic subtest: vecs0
[358.784318] Dynamic subtest vecs0: SUCCESS (0.121s)
[358.795408] Starting dynamic subtest: ccs0
[358.910963] Dynamic subtest ccs0: SUCCESS (0.126s)
[358.913700] Subtest preempt-other: SUCCESS (0.749s)
[359.598230] [054/132] (660s left) gem_exec_reloc (basic-range-active)
[359.666145] Subtest basic-range-active: SKIP (0.000s)
[359.738475] [055/132] (659s left) kms_psr (fbc-psr2-cursor-plane-move)
[359.841982] Starting subtest: fbc-psr2-cursor-plane-move
[359.844240] Starting dynamic subtest: eDP-1
[359.848356] Dynamic subtest eDP-1: SKIP (0.000s)
[359.852490] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[359.927116] [056/132] (659s left) kms_flip (flip-vs-panning)
[360.023012] Starting subtest: flip-vs-panning
[360.025185] Starting dynamic subtest: A-eDP1
[368.723693] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[368.735379] Starting dynamic subtest: B-eDP1
[377.460948] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[377.473392] Starting dynamic subtest: C-eDP1
[386.176391] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[386.188991] Starting dynamic subtest: D-eDP1
[394.916296] Dynamic subtest D-eDP1: SUCCESS (8.737s)
[394.918519] Subtest flip-vs-panning: SUCCESS (34.898s)
[396.071269] [057/132] (623s left) kms_atomic (plane-invalid-params)
[396.169968] Starting subtest: plane-invalid-params
[396.173355] Starting dynamic subtest: pipe-A-eDP-1
[396.575368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[396.577732] Subtest plane-invalid-params: SUCCESS (0.408s)
[397.418722] [058/132] (622s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[397.518865] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[397.522973] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[397.629839] [059/132] (622s left) kms_lease (lease-revoke)
[397.717161] Starting subtest: lease-revoke
[397.719503] Starting dynamic subtest: pipe-A-eDP-1
[397.744962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[397.758820] Starting dynamic subtest: pipe-B-eDP-1
[397.775410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[397.785983] Starting dynamic subtest: pipe-C-eDP-1
[397.811268] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.034s)
[397.824749] Starting dynamic subtest: pipe-D-eDP-1
[397.848247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.030s)
[397.850411] Subtest lease-revoke: SUCCESS (0.132s)
[397.968151] [060/132] (621s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[398.080030] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[398.084405] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[398.202678] [061/132] (621s left) gem_exec_reloc (basic-gtt)
[398.251568] Subtest basic-gtt: SKIP (0.000s)
[398.324492] [062/132] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[398.408956] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[398.412633] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[398.518336] [063/132] (621s left) gem_ctx_isolation (preservation-reset)
[398.683987] Starting subtest: preservation-reset
[398.686986] Starting dynamic subtest: rcs0
[398.944531] Dynamic subtest rcs0: SUCCESS (0.262s)
[398.954933] Starting dynamic subtest: bcs0
[399.247703] Dynamic subtest bcs0: SUCCESS (0.302s)
[399.260875] Starting dynamic subtest: vcs0
[399.551100] Dynamic subtest vcs0: SUCCESS (0.302s)
[399.561086] Starting dynamic subtest: vcs1
[400.813133] Dynamic subtest vcs1: SUCCESS (1.261s)
[400.823613] Starting dynamic subtest: vecs0
[402.810433] Dynamic subtest vecs0: SUCCESS (1.996s)
[402.823550] Starting dynamic subtest: ccs0
[404.862532] Dynamic subtest ccs0: SUCCESS (2.051s)
[404.865150] Subtest preservation-reset: SUCCESS (6.183s)
[404.997005] [064/132] (615s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[405.081926] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[405.110161] Starting dynamic subtest: pipe-A-plane-0
[405.541270] Dynamic subtest pipe-A-plane-0: SUCCESS (0.432s)
[405.551067] Starting dynamic subtest: pipe-A-plane-3
[405.818652] Dynamic subtest pipe-A-plane-3: SUCCESS (0.276s)
[406.908443] Starting dynamic subtest: pipe-B-plane-0
[407.344461] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[407.359741] Starting dynamic subtest: pipe-B-plane-3
[407.608241] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[407.917136] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.834s)
[408.772884] [065/132] (611s left) kms_selftest (drm_dp_mst_helper)
[408.813389] Starting subtest: drm_dp_mst_helper
[408.869512] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[408.958237] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.091s)
[408.968490] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[409.061733] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.101s)
[409.072487] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[409.162181] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.100s)
[409.164042] Subtest drm_dp_mst_helper: SUCCESS (0.349s)
[409.338009] [066/132] (610s left) syncobj_wait (wait-for-submit-delayed-submit)
[409.400614] Starting subtest: wait-for-submit-delayed-submit
[409.503831] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[409.590367] [067/132] (610s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[409.658903] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[409.714116] [068/132] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[409.823277] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[416.304033] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.484s)
[416.440321] [069/132] (603s left) gem_sync (basic-store-all)
[416.519287] Starting subtest: basic-store-all
[420.706324] Subtest basic-store-all: SUCCESS (4.197s)
[420.899425] [070/132] (599s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[420.989957] Starting subtest: primary-4-tiled-reflect-x-0
[428.006510] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.019s)
[429.178123] [071/132] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[429.268177] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[429.272121] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.359633] [072/132] (591s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[429.415729] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[429.524685] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[429.613040] [073/132] (590s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[429.704104] Starting subtest: bad-rotation-90-y-tiled-ccs
[429.706328] Starting dynamic subtest: pipe-A-eDP-1
[429.728368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.741003] Starting dynamic subtest: pipe-B-eDP-1
[429.762626] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.772036] Starting dynamic subtest: pipe-C-eDP-1
[429.793188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.802499] Starting dynamic subtest: pipe-D-eDP-1
[429.824219] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.828284] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[431.941292] [074/132] (588s left) kms_draw_crc (draw-method-mmap-gtt)
[432.033861] Starting subtest: draw-method-mmap-gtt
[432.038275] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[432.129520] [075/132] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[432.222392] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[432.226570] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[432.325038] [076/132] (588s left) kms_prime (d3hot)
[432.412392] Subtest D3hot: SKIP (0.000s)
[432.521918] [077/132] (588s left) kms_cursor_crc (cursor-offscreen-512x170)
[432.826973] Starting subtest: cursor-offscreen-512x170
[432.831492] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[432.995754] [078/132] (587s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[433.095959] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[433.097762] Starting dynamic subtest: pipe-A-eDP-1
[443.774106] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.683s)
[443.784657] Starting dynamic subtest: pipe-B-eDP-1
[455.143131] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.366s)
[455.145341] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.052s)
[455.999796] [079/132] (564s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[456.103084] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[456.105349] Starting dynamic subtest: pipe-A-eDP-1
[462.007450] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.910s)
[462.018388] Starting dynamic subtest: pipe-B-eDP-1
[468.678971] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.669s)
[468.681607] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.581s)
[469.556635] [080/132] (551s left) gem_ctx_persistence (legacy-engines-mixed-process)
[469.618681] Starting subtest: legacy-engines-mixed-process
[469.620723] Starting dynamic subtest: render
[471.516683] Dynamic subtest render: SUCCESS (1.901s)
[471.529112] Starting dynamic subtest: bsd1
[473.558581] Dynamic subtest bsd1: SUCCESS (2.040s)
[473.570713] Starting dynamic subtest: bsd2
[475.540783] Dynamic subtest bsd2: SUCCESS (1.980s)
[475.552985] Starting dynamic subtest: blt
[477.517758] Dynamic subtest blt: SUCCESS (1.973s)
[477.529276] Starting dynamic subtest: vebox
[479.512812] Dynamic subtest vebox: SUCCESS (1.995s)
[479.515499] Subtest legacy-engines-mixed-process: SUCCESS (9.900s)
[479.605465] [081/132] (541s left) syncobj_wait (wait-all-for-submit-snapshot)
[479.667933] Starting subtest: wait-all-for-submit-snapshot
[479.748681] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[479.828839] [082/132] (541s left) kms_flip (basic-flip-vs-wf_vblank)
[479.930898] Starting subtest: basic-flip-vs-wf_vblank
[479.933205] Starting dynamic subtest: A-eDP1
[481.899169] Dynamic subtest A-eDP1: SUCCESS (1.970s)
[481.911952] Starting dynamic subtest: B-eDP1
[483.833557] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[483.846347] Starting dynamic subtest: C-eDP1
[485.758383] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[485.772258] Starting dynamic subtest: D-eDP1
[487.689902] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[487.692669] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.766s)
[488.908107] [083/132] (532s left) gem_exec_balancer (busy)
[488.963130] Starting subtest: busy
[490.519368] Subtest busy: SUCCESS (1.555s)
[490.875250] [084/132] (530s left) kms_vrr (flip-suspend)
[490.957023] Starting subtest: flip-suspend
[490.963326] Subtest flip-suspend: SKIP (0.000s)
[491.046611] [085/132] (529s left) gem_exec_params (secure-non-master)
[491.103244] Starting subtest: secure-non-master
[491.107810] Subtest secure-non-master: SKIP (0.000s)
[491.197373] [086/132] (529s left) gem_close_race (multigpu-basic-threads)
[491.258833] Starting subtest: multigpu-basic-threads
[491.263086] Subtest multigpu-basic-threads: SKIP (0.000s)
[491.477619] [087/132] (529s left) gem_exec_balancer (sliced)
[491.531715] Starting subtest: sliced
[491.535662] Subtest sliced: SKIP (0.000s)
[491.832211] [088/132] (529s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[491.932374] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[491.936892] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[492.004439] [089/132] (529s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[492.384547] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[493.213519] [090/132] (528s left) kms_pm_backlight (fade-with-dpms)
[493.303124] Starting subtest: fade-with-dpms
[495.399046] Starting dynamic subtest: eDP-1
[498.082311] Dynamic subtest eDP-1: SUCCESS (2.681s)
[498.084855] Subtest fade-with-dpms: SUCCESS (4.778s)
[498.894136] [091/132] (522s left) gem_partial_pwrite_pread (reads-display)
[498.959243] Subtest reads-display: SKIP (0.000s)
[499.033974] [092/132] (522s left) syncobj_wait (multi-wait-submitted)
[499.092235] Starting subtest: multi-wait-submitted
[499.195592] Subtest multi-wait-submitted: SUCCESS (0.103s)
[499.283498] [093/132] (522s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[499.379260] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[499.508990] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.133s)
[499.646168] [094/132] (521s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[499.750090] Starting subtest: yf-tiled-64bpp-rotate-270
[499.754099] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[499.860624] [095/132] (521s left) prime_mmap_coherency (read)
[499.925304] Starting subtest: read
[505.350807] Subtest read: SUCCESS (5.374s)
[505.424219] [096/132] (516s left) gem_exec_fence (syncobj-invalid-flags)
[505.891099] Starting subtest: syncobj-invalid-flags
[505.893472] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[507.629771] [097/132] (513s left) i915_pm_rpm (gem-idle)
[509.671753] Starting subtest: gem-idle
[515.870795] Subtest gem-idle: SUCCESS (6.191s)
[516.193809] [098/132] (505s left) gem_sync (basic-store-each)
[517.518044] Starting subtest: basic-store-each
[519.817306] Subtest basic-store-each: SUCCESS (2.312s)
[520.007151] [099/132] (501s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[520.111148] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[521.124002] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.013s)
[521.260053] [100/132] (500s left) gem_fence_thrash (bo-write-verify-x)
[521.296192] Starting subtest: bo-write-verify-x
[521.322265] Subtest bo-write-verify-x: SKIP (0.024s)
[521.382448] [101/132] (500s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[521.487933] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[521.491763] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[521.594534] [102/132] (500s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[521.687180] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[521.698492] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[521.800540] [103/132] (500s left) gem_mmap_wc (write-gtt-read-wc)
[521.855714] Subtest write-gtt-read-wc: SKIP (0.000s)
[521.911103] [104/132] (499s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[522.004542] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[522.806940] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[522.973746] [105/132] (498s left) gem_exec_reloc (basic-gtt-read)
[523.031691] Subtest basic-gtt-read: SKIP (0.000s)
[523.106616] [106/132] (498s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[523.198929] Starting subtest: x-tiled-32bpp-rotate-180
[524.588895] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[524.722714] [107/132] (497s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[524.815189] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[524.818719] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.915333] [108/132] (497s left) perf_pmu (idle-no-semaphores)
[524.957959] Starting subtest: idle-no-semaphores
[524.959887] Starting dynamic subtest: rcs0
[525.502902] Dynamic subtest rcs0: SUCCESS (0.544s)
[525.514570] Starting dynamic subtest: bcs0
[526.030275] Dynamic subtest bcs0: SUCCESS (0.525s)
[526.041970] Starting dynamic subtest: vcs0
[526.549307] Dynamic subtest vcs0: SUCCESS (0.516s)
[526.562677] Starting dynamic subtest: vcs1
[527.071980] Dynamic subtest vcs1: SUCCESS (0.519s)
[527.085791] Starting dynamic subtest: vecs0
[527.588293] Dynamic subtest vecs0: SUCCESS (0.513s)
[527.602101] Starting dynamic subtest: ccs0
[528.102991] Dynamic subtest ccs0: SUCCESS (0.512s)
[528.106116] Subtest idle-no-semaphores: SUCCESS (3.147s)
[528.222815] [109/132] (493s left) kms_vblank (query-idle-hang)
[528.334867] Starting subtest: query-idle-hang
[528.337118] Starting dynamic subtest: pipe-A-eDP-1
[554.330415] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.997s)
[554.346940] Starting dynamic subtest: pipe-D-eDP-1
[569.301638] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.962s)
[569.303987] Subtest query-idle-hang: SUCCESS (40.964s)
[570.166565] [110/132] (451s left) kms_flip (2x-flip-vs-panning-interruptible)
[570.262336] Starting subtest: 2x-flip-vs-panning-interruptible
[570.273712] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[570.350334] [111/132] (451s left) kms_chamelium_hpd (dp-hpd-storm)
[570.725196] Subtest dp-hpd-storm: SKIP (0.000s)
[571.588564] [112/132] (450s left) gem_exec_schedule (u-semaphore-resolve)
[571.660584] Starting subtest: u-semaphore-resolve
[571.688145] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[572.030237] [113/132] (450s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[572.132608] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[572.137052] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[572.228737] [114/132] (450s left) gem_softpin (reverse)
[572.284786] Starting subtest: reverse
[572.290461] Subtest reverse: SUCCESS (0.006s)
[572.427340] [115/132] (449s left) gem_vm_create (invalid-create)
[572.489672] Starting subtest: invalid-create
[572.494839] Subtest invalid-create: SUCCESS (0.002s)
[572.593878] [116/132] (449s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[572.698253] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[572.700576] Starting dynamic subtest: pipe-A-eDP-1
[572.724512] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[572.737446] Starting dynamic subtest: pipe-B-eDP-1
[572.759092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[572.770094] Starting dynamic subtest: pipe-C-eDP-1
[572.791656] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[572.801727] Starting dynamic subtest: pipe-D-eDP-1
[572.823634] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[572.827737] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[574.977866] [117/132] (447s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[575.065025] Starting subtest: plane-all-modeset-transition-internal-panels
[575.067126] Starting dynamic subtest: pipe-A-eDP-1
[576.414947] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.349s)
[576.700612] Starting dynamic subtest: pipe-B-eDP-1
[577.745651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[578.013625] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.948s)
[578.857126] [118/132] (443s left) kms_pm_backlight (bad-brightness)
[578.956107] Starting subtest: bad-brightness
[579.004631] Starting dynamic subtest: eDP-1
[579.342201] Dynamic subtest eDP-1: SUCCESS (0.336s)
[579.344851] Subtest bad-brightness: SUCCESS (0.387s)
[580.173087] [119/132] (442s left) syncobj_wait (wait-any-interrupted)
[580.232959] Starting subtest: wait-any-interrupted
[580.340247] Subtest wait-any-interrupted: SUCCESS (0.106s)
[580.430044] [120/132] (442s left) fbdev (read)
[580.484016] Starting subtest: read
[581.108246] Subtest read: SUCCESS (0.622s)
[581.174159] [121/132] (441s left) kms_psr (psr2-cursor-mmap-gtt)
[581.267419] Starting subtest: psr2-cursor-mmap-gtt
[581.269892] Starting dynamic subtest: eDP-1
[582.972132] Dynamic subtest eDP-1: SUCCESS (1.705s)
[582.974405] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.706s)
[583.762062] [122/132] (438s left) syncobj_timeline (invalid-signal-zero-handles)
[583.821014] Starting subtest: invalid-signal-zero-handles
[583.823197] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[583.915596] [123/132] (438s left) kms_cursor_legacy (single-move)
[584.041088] Starting subtest: single-move
[584.043258] Starting dynamic subtest: pipe-A
[589.484630] Dynamic subtest pipe-A: SUCCESS (5.383s)
[589.501037] Starting dynamic subtest: pipe-B
[594.870763] Dynamic subtest pipe-B: SUCCESS (5.382s)
[594.884621] Starting dynamic subtest: pipe-C
[600.253119] Dynamic subtest pipe-C: SUCCESS (5.379s)
[600.265674] Starting dynamic subtest: pipe-D
[605.609717] Dynamic subtest pipe-D: SUCCESS (5.379s)
[605.622429] Starting dynamic subtest: all-pipes
[611.027377] Dynamic subtest all-pipes: SUCCESS (5.386s)
[611.029354] Subtest single-move: SUCCESS (26.921s)
[611.145446] [124/132] (411s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[611.252307] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[611.256566] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[611.365013] [125/132] (411s left) gem_ringfill (basic-all)
[616.539993] Starting subtest: basic-all
[617.702167] Subtest basic-all: SUCCESS (1.162s)
[617.830902] [126/132] (405s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[617.898339] Starting subtest: multi-wait-available-unsubmitted-signaled
[617.900617] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[618.012979] [127/132] (404s left) kms_invalid_mode (bad-hsync-end)
[618.126975] Starting subtest: bad-hsync-end
[618.129128] Starting dynamic subtest: pipe-A-eDP-1
[618.410537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[618.422557] Starting dynamic subtest: pipe-B-eDP-1
[618.424674] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[618.434582] Starting dynamic subtest: pipe-C-eDP-1
[618.436984] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[618.447090] Starting dynamic subtest: pipe-D-eDP-1
[618.449381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[618.451580] Subtest bad-hsync-end: SUCCESS (0.290s)
[619.212069] [128/132] (403s left) kms_psr (pr-cursor-plane-onoff)
[619.305105] Starting subtest: pr-cursor-plane-onoff
[619.309598] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[619.377718] [129/132] (403s left) kms_cursor_crc (cursor-sliding-64x21)
[619.571394] Starting subtest: cursor-sliding-64x21
[619.616790] Subtest cursor-sliding-64x21: SKIP (0.039s)
[619.849567] [130/132] (403s left) gem_lmem_swapping (parallel-random-verify-ccs)
[619.897547] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[619.942954] [131/132] (403s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[620.033619] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[620.035975] Starting dynamic subtest: pipe-A-eDP-1
[636.281681] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.389s)
[636.293617] Starting dynamic subtest: pipe-B-eDP-1
[653.254910] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.420s)
[653.265260] Starting dynamic subtest: pipe-C-eDP-1
[670.312663] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.405s)
[670.325389] Starting dynamic subtest: pipe-D-eDP-1
[687.236032] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.364s)
[687.238701] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.583s)
[688.390726] [132/132] (334s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[688.492507] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[695.322480] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.833s)
[695.448360] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_force_connector_basic
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: i915_hangman
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: gem_flink_race
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: device_reset
results: parsing output: 32/ for test: kms_plane_multiple
results: parsing output: 33/ for test: gem_exec_capture
results: parsing output: 34/ for test: sysfs_preempt_timeout
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_prop_blob
results: parsing output: 38/ for test: gem_exec_parallel
results: parsing output: 39/ for test: gem_flink_basic
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_pipe_crc_basic
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: syncobj_eventfd
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_pxp
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_color
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: i915_query
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: prime_busy
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_isolation
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_selftest
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_pipe_b_c_ivb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_sync
results: parsing output: 69/ for test: kms_rotation_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_draw_crc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_prime
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_vrr
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: gem_close_race
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_chamelium_edid
results: parsing output: 89/ for test: kms_pm_backlight
results: parsing output: 90/ for test: gem_partial_pwrite_pread
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: prime_mmap_coherency
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: i915_pm_rpm
results: parsing output: 97/ for test: gem_sync
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_fence_thrash
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_chamelium_hpd
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: gem_vm_create
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_atomic_transition
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: fbdev
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_ringfill
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_invalid_mode
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.