[58.046944] Initializing watchdogs
[58.046994]   /dev/watchdog0
[58.060943] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.065432] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.067473] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.069194] [001/132] (960s left) kms_pm_dc (dc9-dpms)
[59.179096] Starting subtest: dc9-dpms
[60.593716] Subtest dc9-dpms: SUCCESS (1.425s)
[60.683494] [002/132] (957s left) gem_exec_schedule (semaphore-resolve)
[60.745914] Starting subtest: semaphore-resolve
[60.790222] Subtest semaphore-resolve: SUCCESS (0.044s)
[61.156199] [003/132] (957s left) gem_exec_params (mmapped)
[61.214162] Starting subtest: mmapped
[61.217077] Subtest mmapped: SUCCESS (0.003s)
[61.355615] [004/132] (957s left) kms_psr (psr-primary-page-flip)
[61.440493] Starting subtest: psr-primary-page-flip
[61.441519] Starting dynamic subtest: eDP-1
[63.127031] Dynamic subtest eDP-1: SUCCESS (1.696s)
[63.127959] Subtest psr-primary-page-flip: SUCCESS (1.697s)
[64.007779] [005/132] (954s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[64.056522] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[64.057770] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[64.169429] [006/132] (954s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[64.277976] Starting subtest: cursorA-vs-flipA-toggle
[75.424191] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.171s)
[76.310874] [007/132] (942s left) gem_exec_create (forked)
[76.376334] Starting subtest: forked
[76.377358] Starting dynamic subtest: smem
[97.883275] Dynamic subtest smem: SUCCESS (21.501s)
[97.885243] Subtest forked: SUCCESS (21.502s)
[98.079247] [008/132] (920s left) gem_exec_reloc (basic-gtt-cpu)
[98.127476] Subtest basic-gtt-cpu: SKIP (0.000s)
[98.202659] [009/132] (920s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[98.296943] Starting subtest: x-tiled-addfb-size-offset-overflow
[98.298097] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[98.417727] [010/132] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[98.524152] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[105.778150] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.254s)
[105.977884] [011/132] (912s left) perf_pmu (faulting-read)
[106.020167] Starting subtest: faulting-read
[106.021069] Starting dynamic subtest: wb
[106.021959] Dynamic subtest wb: SUCCESS (0.001s)
[106.032345] Starting dynamic subtest: wc
[106.033242] Dynamic subtest wc: SUCCESS (0.000s)
[106.039772] Starting dynamic subtest: uc
[106.040671] Dynamic subtest uc: SUCCESS (0.000s)
[106.041556] Subtest faulting-read: SUCCESS (0.004s)
[106.165737] [012/132] (912s left) gem_ctx_persistence (engines-persistence)
[106.218183] Starting subtest: engines-persistence
[106.219114] Starting dynamic subtest: rcs0
[107.040031] Dynamic subtest rcs0: SUCCESS (0.822s)
[107.050382] Starting dynamic subtest: bcs0
[107.827841] Dynamic subtest bcs0: SUCCESS (0.787s)
[107.837124] Starting dynamic subtest: vcs0
[108.658805] Dynamic subtest vcs0: SUCCESS (0.830s)
[108.669584] Starting dynamic subtest: vcs1
[109.477876] Dynamic subtest vcs1: SUCCESS (0.818s)
[109.487922] Starting dynamic subtest: vecs0
[110.242877] Dynamic subtest vecs0: SUCCESS (0.764s)
[110.252403] Starting dynamic subtest: ccs0
[111.029832] Dynamic subtest ccs0: SUCCESS (0.786s)
[111.031307] Subtest engines-persistence: SUCCESS (4.812s)
[111.125607] [013/132] (907s left) gem_mmap_gtt (ptrace)
[111.182129] Subtest ptrace: SKIP (0.000s)
[111.241901] [014/132] (907s left) kms_flip (dpms-off-confusion-interruptible)
[111.340477] Starting subtest: dpms-off-confusion-interruptible
[111.343469] Starting dynamic subtest: A-eDP1
[120.017185] Dynamic subtest A-eDP1: SUCCESS (8.674s)
[120.025529] Starting dynamic subtest: B-eDP1
[128.644595] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[128.654086] Starting dynamic subtest: C-eDP1
[137.355707] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[137.362205] Starting dynamic subtest: D-eDP1
[145.986171] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[145.988426] Subtest dpms-off-confusion-interruptible: SUCCESS (34.645s)
[147.178256] [015/132] (871s left) syncobj_wait (multi-wait-submitted-signaled)
[147.239092] Starting subtest: multi-wait-submitted-signaled
[147.240150] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[147.349232] [016/132] (871s left) kms_cursor_crc (cursor-sliding-512x170)
[147.621161] Starting subtest: cursor-sliding-512x170
[147.622950] Subtest cursor-sliding-512x170: SKIP (0.001s)
[147.798058] [017/132] (871s left) kms_big_fb (linear-8bpp-rotate-270)
[147.893244] Starting subtest: linear-8bpp-rotate-270
[147.913716] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[148.075259] [018/132] (871s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[148.160228] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[148.161139] Starting dynamic subtest: pipe-A
[148.223458] Dynamic subtest pipe-A: SUCCESS (0.064s)
[148.232514] Starting dynamic subtest: pipe-B
[149.384319] Dynamic subtest pipe-B: SUCCESS (1.160s)
[149.398174] Starting dynamic subtest: pipe-C
[150.484369] Dynamic subtest pipe-C: SUCCESS (1.099s)
[150.492343] Starting dynamic subtest: pipe-D
[151.624769] Dynamic subtest pipe-D: SUCCESS (1.139s)
[151.625730] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.465s)
[152.788458] [019/132] (866s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[157.838442] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[157.841350] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[158.715569] [020/132] (860s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[158.808642] Starting subtest: psr-rgb565-draw-pwrite
[165.751367] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.944s)
[165.902717] [021/132] (853s left) prime_busy (after-wait)
[165.956446] Starting subtest: after-wait
[165.958152] Starting dynamic subtest: rcs0
[166.007796] Dynamic subtest rcs0: SUCCESS (0.049s)
[166.016744] Starting dynamic subtest: bcs0
[166.071675] Dynamic subtest bcs0: SUCCESS (0.063s)
[166.079804] Starting dynamic subtest: vcs0
[166.110964] Dynamic subtest vcs0: SUCCESS (0.039s)
[166.117994] Starting dynamic subtest: vcs1
[166.151805] Dynamic subtest vcs1: SUCCESS (0.040s)
[166.159219] Starting dynamic subtest: vecs0
[166.192269] Dynamic subtest vecs0: SUCCESS (0.040s)
[166.199517] Starting dynamic subtest: ccs0
[166.232964] Dynamic subtest ccs0: SUCCESS (0.040s)
[166.341775] Subtest after-wait: SUCCESS (0.384s)
[166.432433] [022/132] (852s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[166.709905] Starting subtest: cursor-rapid-movement-max-size
[166.712451] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[166.868587] [023/132] (852s left) gem_exec_balancer (indices)
[166.932089] Starting subtest: indices
[168.884227] Subtest indices: SUCCESS (1.951s)
[169.198823] [024/132] (850s left) syncobj_wait (wait-any-interrupted)
[169.250303] Starting subtest: wait-any-interrupted
[169.354532] Subtest wait-any-interrupted: SUCCESS (0.102s)
[169.445794] [025/132] (849s left) kms_lease (lease-again)
[169.540993] Starting subtest: lease-again
[169.542300] Starting dynamic subtest: pipe-A-eDP-1
[169.545087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[169.553898] Starting dynamic subtest: pipe-B-eDP-1
[169.554763] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[169.561065] Starting dynamic subtest: pipe-C-eDP-1
[169.561867] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[169.568072] Starting dynamic subtest: pipe-D-eDP-1
[169.568859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[169.569688] Subtest lease-again: SUCCESS (0.012s)
[169.671397] [026/132] (849s left) template (b)
[169.729172] Starting subtest: B
[169.730052] Subtest B: SUCCESS (0.000s)
[169.860345] [027/132] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[169.949141] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[169.950908] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[170.074552] [028/132] (849s left) gem_ctx_create (basic)
[170.133861] Starting subtest: basic
[170.134947] Subtest basic: SUCCESS (0.000s)
[170.333906] [029/132] (849s left) gem_reg_read (bad-register)
[170.385640] Starting subtest: bad-register
[170.386754] Subtest bad-register: SUCCESS (0.000s)
[170.508072] [030/132] (848s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[170.566766] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[170.676636] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[170.764735] [031/132] (848s left) syncobj_wait (invalid-signal-one-illegal-handle)
[170.823576] Starting subtest: invalid-signal-one-illegal-handle
[170.824739] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[170.957746] [032/132] (848s left) kms_plane (plane-panning-bottom-right)
[171.051247] Starting subtest: plane-panning-bottom-right
[171.052298] Starting dynamic subtest: pipe-A
[172.812508] Dynamic subtest pipe-A: SUCCESS (1.761s)
[172.819741] Starting dynamic subtest: pipe-B
[175.201387] Dynamic subtest pipe-B: SUCCESS (2.387s)
[175.202398] Subtest plane-panning-bottom-right: SUCCESS (4.151s)
[176.091815] [033/132] (843s left) kms_dirtyfb (default-dirtyfb-ioctl)
[176.188287] Starting subtest: default-dirtyfb-ioctl
[176.189258] Starting dynamic subtest: A-eDP-1
[177.762774] Dynamic subtest A-eDP-1: SUCCESS (1.574s)
[177.763838] Subtest default-dirtyfb-ioctl: SUCCESS (1.575s)
[178.628529] [034/132] (840s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[178.720530] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[185.345352] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.622s)
[185.488788] [035/132] (834s left) gen9_exec_parse (unaligned-access)
[185.547023] Subtest unaligned-access: SKIP (0.000s)
[185.604762] [036/132] (834s left) kms_atomic (plane-invalid-params-fence)
[185.695392] Starting subtest: plane-invalid-params-fence
[185.696325] Starting dynamic subtest: pipe-A-eDP-1
[186.054596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[186.055610] Subtest plane-invalid-params-fence: SUCCESS (0.360s)
[186.856687] [037/132] (832s left) gem_exec_schedule (out-order)
[186.933286] Starting subtest: out-order
[186.934211] Starting dynamic subtest: rcs0
[187.034907] Dynamic subtest rcs0: SUCCESS (0.102s)
[187.044351] Starting dynamic subtest: vcs0
[187.116034] Dynamic subtest vcs0: SUCCESS (0.080s)
[187.125655] Starting dynamic subtest: vcs1
[187.191903] Dynamic subtest vcs1: SUCCESS (0.076s)
[187.200297] Starting dynamic subtest: vecs0
[187.270298] Dynamic subtest vecs0: SUCCESS (0.078s)
[187.279466] Starting dynamic subtest: ccs0
[187.351610] Dynamic subtest ccs0: SUCCESS (0.081s)
[187.352770] Subtest out-order: SUCCESS (0.420s)
[189.025097] [038/132] (830s left) gem_ctx_shared (exec-shared-gtt)
[189.079880] Starting subtest: exec-shared-gtt
[189.080985] Starting dynamic subtest: rcs0
[189.089160] Dynamic subtest rcs0: SUCCESS (0.009s)
[189.097401] Starting dynamic subtest: bcs0
[189.098352] Dynamic subtest bcs0: SUCCESS (0.006s)
[189.105952] Starting dynamic subtest: vcs0
[189.106865] Dynamic subtest vcs0: SUCCESS (0.007s)
[189.113519] Starting dynamic subtest: vcs1
[189.114438] Dynamic subtest vcs1: SUCCESS (0.006s)
[189.121812] Starting dynamic subtest: vecs0
[189.122952] Dynamic subtest vecs0: SUCCESS (0.005s)
[189.129334] Starting dynamic subtest: ccs0
[189.130196] Dynamic subtest ccs0: SUCCESS (0.004s)
[189.131054] Subtest exec-shared-gtt: SUCCESS (0.040s)
[191.045764] [039/132] (828s left) kms_getfb (getfb2-handle-zero)
[191.132224] Starting subtest: getfb2-handle-zero
[191.133097] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[191.258511] [040/132] (828s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[191.338156] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[191.339506] Starting dynamic subtest: pipe-A-default-mode
[192.508305] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[192.510032] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.170s)
[192.678335] [041/132] (827s left) gem_eio (wait-10ms)
[192.914255] Starting subtest: wait-10ms
[193.270516] Subtest wait-10ms: SUCCESS (0.358s)
[193.442631] [042/132] (826s left) kms_addfb_basic (basic)
[193.495879] Starting subtest: basic
[193.496962] Subtest basic: SUCCESS (0.000s)
[193.660111] [043/132] (826s left) gem_close_race (basic-threads)
[193.713558] Starting subtest: basic-threads
[195.080976] Subtest basic-threads: SUCCESS (1.367s)
[195.278707] [044/132] (824s left) gen9_exec_parse (secure-batches)
[195.342601] Subtest secure-batches: SKIP (0.000s)
[195.406632] [045/132] (824s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[195.489780] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[199.800248] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.310s)
[200.976737] [046/132] (818s left) kms_psr (fbc-psr2-sprite-plane-move)
[201.071410] Starting subtest: fbc-psr2-sprite-plane-move
[201.072350] Starting dynamic subtest: eDP-1
[201.074074] Dynamic subtest eDP-1: SKIP (0.000s)
[201.075707] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[201.157407] [047/132] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[201.255645] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[201.257291] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[201.380151] [048/132] (818s left) api_intel_bb (full-batch)
[201.431920] Starting subtest: full-batch
[201.437903] Subtest full-batch: SUCCESS (0.006s)
[201.570454] [049/132] (818s left) gem_exec_create (basic)
[201.630806] Starting subtest: basic
[201.631839] Starting dynamic subtest: smem
[204.887938] Dynamic subtest smem: SUCCESS (3.254s)
[204.889108] Subtest basic: SUCCESS (3.256s)
[205.084503] [050/132] (814s left) kms_content_protection (suspend-resume)
[205.228904] Starting subtest: suspend-resume
[205.230846] Subtest suspend-resume: SKIP (0.000s)
[205.395176] [051/132] (814s left) kms_vblank (wait-forked)
[205.490369] Starting subtest: wait-forked
[205.491296] Starting dynamic subtest: pipe-A-eDP-1
[207.317099] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s)
[207.325912] Starting dynamic subtest: pipe-D-eDP-1
[209.858392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[209.859231] Subtest wait-forked: SUCCESS (4.369s)
[210.736926] [052/132] (809s left) gem_spin_batch (legacy-resubmit-new)
[210.803864] Starting subtest: legacy-resubmit-new
[210.804800] Starting dynamic subtest: default
[210.812817] Dynamic subtest default: SUCCESS (0.010s)
[210.820308] Starting dynamic subtest: render
[210.821119] Dynamic subtest render: SUCCESS (0.003s)
[210.828133] Starting dynamic subtest: bsd
[210.828907] Dynamic subtest bsd: SUCCESS (0.005s)
[210.835736] Starting dynamic subtest: bsd1
[210.836576] Dynamic subtest bsd1: SUCCESS (0.004s)
[210.843467] Starting dynamic subtest: bsd2
[210.844266] Dynamic subtest bsd2: SUCCESS (0.003s)
[210.851043] Starting dynamic subtest: blt
[210.851861] Dynamic subtest blt: SUCCESS (0.004s)
[210.858755] Starting dynamic subtest: vebox
[210.859609] Dynamic subtest vebox: SUCCESS (0.004s)
[210.860468] Subtest legacy-resubmit-new: SUCCESS (0.037s)
[211.987525] [053/132] (808s left) gem_eio (in-flight-contexts-10ms)
[212.237013] Starting subtest: in-flight-contexts-10ms
[225.894377] Subtest in-flight-contexts-10ms: SUCCESS (13.656s)
[226.096568] [054/132] (794s left) gem_exec_await (wide-all)
[226.337699] Starting subtest: wide-all
[249.810880] Subtest wide-all: SUCCESS (23.470s)
[250.014473] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[250.017758] [055/132] (770s left) kms_psr2_su (page_flip-xrgb8888)
[250.104453] Subtest page_flip-XRGB8888: SKIP (0.000s)
[250.173484] [056/132] (770s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[250.277460] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[250.278497] Starting dynamic subtest: pipe-A-eDP-1
[250.286718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[250.295424] Starting dynamic subtest: pipe-B-eDP-1
[250.303744] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[250.311949] Starting dynamic subtest: pipe-C-eDP-1
[250.319651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[250.326872] Starting dynamic subtest: pipe-D-eDP-1
[250.334622] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.335502] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[252.607307] [057/132] (767s left) kms_chamelium_frames (hdmi-crc-single)
[252.999050] Subtest hdmi-crc-single: SKIP (0.000s)
[253.787165] [058/132] (766s left) kms_hdmi_inject (inject-4k)
[254.140462] Starting subtest: inject-4k
[254.456736] Subtest inject-4k: SUCCESS (0.317s)
[255.009640] [059/132] (765s left) core_sysfs (read-all-entries)
[255.058321] Starting subtest: read-all-entries
[255.061067] Subtest read-all-entries: SUCCESS (0.003s)
[255.180334] [060/132] (765s left) kms_color (deep-color)
[255.274211] Starting subtest: deep-color
[256.333292] Starting dynamic subtest: pipe-A-eDP-1-gamma
[257.034058] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.701s)
[257.041933] Starting dynamic subtest: pipe-A-eDP-1-degamma
[258.422083] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.387s)
[258.429543] Starting dynamic subtest: pipe-A-eDP-1-ctm
[259.825454] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.402s)
[260.641173] Starting dynamic subtest: pipe-B-eDP-1-gamma
[261.380608] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.747s)
[261.388727] Starting dynamic subtest: pipe-B-eDP-1-degamma
[262.806513] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.424s)
[262.814303] Starting dynamic subtest: pipe-B-eDP-1-ctm
[264.245162] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.438s)
[265.040554] Starting dynamic subtest: pipe-C-eDP-1-gamma
[265.679951] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.647s)
[265.689689] Starting dynamic subtest: pipe-C-eDP-1-degamma
[267.086787] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.406s)
[267.094485] Starting dynamic subtest: pipe-C-eDP-1-ctm
[268.484123] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.397s)
[269.237404] Starting dynamic subtest: pipe-D-eDP-1-gamma
[269.877283] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.647s)
[269.884833] Starting dynamic subtest: pipe-D-eDP-1-degamma
[271.270725] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.392s)
[271.278736] Starting dynamic subtest: pipe-D-eDP-1-ctm
[272.698561] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.427s)
[272.699485] Subtest deep-color: SUCCESS (17.424s)
[273.594458] [061/132] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[273.690457] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[273.692178] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[273.821583] [062/132] (746s left) gem_exec_create (legacy)
[273.886716] Starting subtest: legacy
[273.887680] Starting dynamic subtest: smem
[275.972964] Dynamic subtest smem: SUCCESS (2.086s)
[275.975883] Subtest legacy: SUCCESS (2.088s)
[276.176650] [063/132] (744s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[276.276245] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[276.278425] Starting dynamic subtest: pipe-A-eDP-1
[276.287464] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[276.295363] Starting dynamic subtest: pipe-B-eDP-1
[276.304916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[276.312772] Starting dynamic subtest: pipe-C-eDP-1
[276.321628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[276.328946] Starting dynamic subtest: pipe-D-eDP-1
[276.337826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[276.339552] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[278.467871] [064/132] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[278.569703] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[278.571432] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.697138] [065/132] (741s left) gem_pwrite (basic-self)
[278.758848] Subtest basic-self: SKIP (0.000s)
[278.821559] [066/132] (741s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[278.904293] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[278.905136] Starting dynamic subtest: pipe-A-eDP-1
[278.913316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[278.922892] Starting dynamic subtest: pipe-B-eDP-1
[278.930952] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[278.938058] Starting dynamic subtest: pipe-C-eDP-1
[278.945982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[278.953150] Starting dynamic subtest: pipe-D-eDP-1
[278.961333] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[278.962833] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[281.240523] [067/132] (739s left) gem_userptr_blits (create-destroy-unsync)
[281.310078] Subtest create-destroy-unsync: SKIP (0.000s)
[281.464268] [068/132] (739s left) kms_plane_cursor (primary)
[281.548468] Starting subtest: primary
[281.550329] Starting dynamic subtest: pipe-A-eDP-1-size-64
[284.100273] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.551s)
[284.126871] Starting dynamic subtest: pipe-A-eDP-1-size-128
[286.668439] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[286.694399] Starting dynamic subtest: pipe-A-eDP-1-size-256
[289.235861] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[289.548323] Starting dynamic subtest: pipe-B-eDP-1-size-64
[292.814238] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.274s)
[292.840779] Starting dynamic subtest: pipe-B-eDP-1-size-128
[295.382200] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[295.407532] Starting dynamic subtest: pipe-B-eDP-1-size-256
[297.949825] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.550s)
[298.261404] Starting dynamic subtest: pipe-C-eDP-1-size-64
[301.127158] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.874s)
[301.154674] Starting dynamic subtest: pipe-C-eDP-1-size-128
[303.338399] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[303.365185] Starting dynamic subtest: pipe-C-eDP-1-size-256
[305.516841] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[305.828872] Starting dynamic subtest: pipe-D-eDP-1-size-64
[308.797830] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.976s)
[308.824563] Starting dynamic subtest: pipe-D-eDP-1-size-128
[310.962726] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.146s)
[310.990559] Starting dynamic subtest: pipe-D-eDP-1-size-256
[313.130320] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[313.438831] Subtest primary: SUCCESS (31.890s)
[314.249453] [069/132] (706s left) syncobj_wait (invalid-reset-bad-pad)
[314.315173] Starting subtest: invalid-reset-bad-pad
[314.316116] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[314.425380] [070/132] (706s left) kms_pm_lpsp (kms-lpsp)
[315.510963] Starting subtest: kms-lpsp
[315.511810] Starting dynamic subtest: pipe-A-eDP-1
[315.673538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.163s)
[315.957585] Subtest kms-lpsp: SUCCESS (0.447s)
[316.780140] [071/132] (703s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[321.846810] Starting subtest: psr2-overlay-plane-update-continuous-sf
[321.847719] Starting dynamic subtest: pipe-A-eDP-1
[323.584503] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.736s)
[323.593603] Starting dynamic subtest: pipe-B-eDP-1
[325.318695] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.732s)
[325.319641] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.472s)
[326.160915] [072/132] (694s left) kms_joiner (basic-force-ultra-joiner)
[326.249425] Starting subtest: basic-force-ultra-joiner
[326.251156] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[326.338325] [073/132] (694s left) syncobj_timeline (device-submit-unordered)
[326.388251] Starting subtest: device-submit-unordered
[326.389581] Subtest device-submit-unordered: SUCCESS (0.000s)
[326.504954] [074/132] (694s left) kms_psr (fbc-psr-primary-blt)
[326.590551] Starting subtest: fbc-psr-primary-blt
[326.591454] Starting dynamic subtest: eDP-1
[326.593156] Dynamic subtest eDP-1: SKIP (0.000s)
[326.594882] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[326.683558] [075/132] (694s left) i915_power (sanity)
[326.732207] Starting subtest: sanity
[330.776939] Subtest sanity: SUCCESS (4.039s)
[331.984747] [076/132] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[332.085985] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[332.087937] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[332.223884] [077/132] (688s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[332.284693] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[332.286586] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[332.484311] [078/132] (688s left) perf (enable-disable)
[332.627486] Starting subtest: enable-disable
[332.628495] Starting dynamic subtest: 0-rcs0
[334.902428] Dynamic subtest 0-rcs0: SUCCESS (2.273s)
[334.911140] Starting dynamic subtest: 1-vecs0
[339.384071] Dynamic subtest 1-vecs0: SUCCESS (4.481s)
[339.385338] Subtest enable-disable: SUCCESS (6.755s)
[339.426538] [079/132] (681s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[344.407271] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[344.410411] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[345.283589] [080/132] (675s left) i915_hangman (detector)
[345.355454] Starting subtest: detector
[345.356315] Starting dynamic subtest: rcs0
[355.895625] Dynamic subtest rcs0: SUCCESS (10.537s)
[355.906602] Starting dynamic subtest: bcs0
[366.902028] Dynamic subtest bcs0: SUCCESS (11.003s)
[366.913415] Starting dynamic subtest: vcs0
[377.846145] Dynamic subtest vcs0: SUCCESS (10.941s)
[377.865069] Starting dynamic subtest: vcs1
[389.879787] Dynamic subtest vcs1: SUCCESS (12.030s)
[389.890517] Starting dynamic subtest: vecs0
[400.820686] Dynamic subtest vecs0: SUCCESS (10.939s)
[400.832193] Starting dynamic subtest: ccs0
[410.871375] Dynamic subtest ccs0: SUCCESS (10.046s)
[410.872742] Subtest detector: SUCCESS (65.513s)
[410.972293] [081/132] (610s left) sysfs_preempt_timeout (invalid)
[411.035366] Starting subtest: invalid
[411.036422] Starting dynamic subtest: vecs0
[411.037446] Dynamic subtest vecs0: SUCCESS (0.000s)
[411.046813] Starting dynamic subtest: ccs0
[411.047706] Dynamic subtest ccs0: SUCCESS (0.000s)
[411.055431] Starting dynamic subtest: vcs0
[411.056308] Dynamic subtest vcs0: SUCCESS (0.000s)
[411.064118] Starting dynamic subtest: bcs0
[411.064952] Dynamic subtest bcs0: SUCCESS (0.000s)
[411.072372] Starting dynamic subtest: rcs0
[411.073276] Dynamic subtest rcs0: SUCCESS (0.000s)
[411.080674] Starting dynamic subtest: vcs1
[411.081557] Dynamic subtest vcs1: SUCCESS (0.000s)
[411.082427] Subtest invalid: SUCCESS (0.006s)
[411.173165] [082/132] (609s left) kms_addfb_basic (unused-modifier)
[411.233515] Starting subtest: unused-modifier
[411.234470] Subtest unused-modifier: SUCCESS (0.000s)
[411.406940] [083/132] (609s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[411.505772] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[418.194094] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.689s)
[418.328581] [084/132] (602s left) kms_feature_discovery (display)
[418.437467] Starting subtest: display
[418.438467] Subtest display: SUCCESS (0.000s)
[418.528365] [085/132] (602s left) kms_getfb (getfb-handle-closed)
[418.624473] Starting subtest: getfb-handle-closed
[418.625523] Subtest getfb-handle-closed: SUCCESS (0.000s)
[418.754556] [086/132] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[418.849438] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[418.851344] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.952724] [087/132] (602s left) gem_create (create-size-update)
[419.011015] Starting subtest: create-size-update
[419.012258] Subtest create-size-update: SUCCESS (0.000s)
[419.244450] [088/132] (602s left) gem_userptr_blits (set-cache-level)
[419.313586] Starting subtest: set-cache-level
[419.315450] Subtest set-cache-level: SKIP (0.000s)
[419.477391] [089/132] (601s left) kms_psr (psr2-cursor-blt)
[419.565699] Starting subtest: psr2-cursor-blt
[419.566779] Starting dynamic subtest: eDP-1
[421.305806] Dynamic subtest eDP-1: SUCCESS (1.741s)
[421.306768] Subtest psr2-cursor-blt: SUCCESS (1.742s)
[422.125393] [090/132] (599s left) fbdev (write)
[422.157840] Starting subtest: write
[422.521693] Subtest write: SUCCESS (0.361s)
[422.603396] [091/132] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[422.699688] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[422.701480] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[422.832484] [092/132] (598s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[422.884914] Starting subtest: invalid-bsd2-flag-on-vebox
[422.886052] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[423.029424] [093/132] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[423.132432] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[423.134284] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[423.269373] [094/132] (598s left) kms_cursor_crc (cursor-onscreen-128x128)
[423.505101] Starting subtest: cursor-onscreen-128x128
[423.507117] Starting dynamic subtest: pipe-A-eDP-1
[425.613097] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s)
[425.641042] Starting dynamic subtest: pipe-D-eDP-1
[428.389236] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.755s)
[428.390394] Subtest cursor-onscreen-128x128: SUCCESS (4.884s)
[429.199497] [095/132] (592s left) gem_exercise_blt (fast-copy)
[429.246212] Starting subtest: fast-copy
[429.247142] Starting dynamic subtest: linear-smem-smem
[429.269261] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[429.278559] Starting dynamic subtest: xmajor-smem-smem
[429.287521] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[429.295519] Starting dynamic subtest: tile4-smem-smem
[429.305137] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[429.312871] Starting dynamic subtest: tile64-smem-smem
[429.322450] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[429.323476] Subtest fast-copy: SUCCESS (0.078s)
[429.478385] [096/132] (592s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[429.582662] Starting subtest: yf-tiled-64bpp-rotate-180
[429.584391] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[429.717630] [097/132] (591s left) kms_flip (2x-flip-vs-suspend-interruptible)
[429.811891] Starting subtest: 2x-flip-vs-suspend-interruptible
[429.823761] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[429.917953] [098/132] (591s left) kms_flip (modeset-vs-vblank-race)
[430.024450] Starting subtest: modeset-vs-vblank-race
[430.026959] Starting dynamic subtest: A-eDP1
[434.708286] Dynamic subtest A-eDP1: SUCCESS (4.681s)
[434.720238] Starting dynamic subtest: B-eDP1
[439.440157] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[439.451307] Starting dynamic subtest: C-eDP1
[444.136655] Dynamic subtest C-eDP1: SUCCESS (4.694s)
[444.145316] Starting dynamic subtest: D-eDP1
[448.752344] Dynamic subtest D-eDP1: SUCCESS (4.614s)
[448.755494] Subtest modeset-vs-vblank-race: SUCCESS (18.729s)
[449.921475] [099/132] (571s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[449.993872] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[449.994950] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[450.128336] [100/132] (571s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[450.239703] Starting subtest: y-tiled-16bpp-rotate-90
[450.241330] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[450.357942] [101/132] (571s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[450.453746] Starting subtest: psr-modesetfrombusy
[456.572537] Subtest psr-modesetfrombusy: SUCCESS (6.118s)
[456.751650] [102/132] (565s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[456.815985] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[456.886777] [103/132] (564s left) gem_ctx_persistence (heartbeat-stop)
[456.934978] Starting subtest: heartbeat-stop
[456.936940] Subtest heartbeat-stop: SKIP (0.000s)
[457.067799] [104/132] (564s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[457.156380] Starting subtest: extended-pageflip-modeset-hang-oldfb
[457.157271] Starting dynamic subtest: pipe-A
[465.073579] Dynamic subtest pipe-A: SUCCESS (7.915s)
[465.084277] Starting dynamic subtest: pipe-D
[473.660922] Dynamic subtest pipe-D: SUCCESS (8.584s)
[473.661925] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.505s)
[474.538188] [105/132] (547s left) kms_flip (dpms-vs-vblank-race)
[474.623390] Starting subtest: dpms-vs-vblank-race
[474.625641] Starting dynamic subtest: A-eDP1
[479.623250] Dynamic subtest A-eDP1: SUCCESS (4.997s)
[479.631199] Starting dynamic subtest: B-eDP1
[484.251737] Dynamic subtest B-eDP1: SUCCESS (4.627s)
[484.261075] Starting dynamic subtest: C-eDP1
[488.862668] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[488.873986] Starting dynamic subtest: D-eDP1
[493.485817] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[493.487657] Subtest dpms-vs-vblank-race: SUCCESS (18.863s)
[494.410995] [106/132] (527s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[494.523515] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[494.525158] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[494.642890] [107/132] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[494.739851] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[494.741457] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[494.868137] [108/132] (527s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[494.963448] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[494.965030] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[495.067859] [109/132] (527s left) syncobj_timeline (wait-any-complex)
[495.125909] Starting subtest: wait-any-complex
[495.187512] Subtest wait-any-complex: SUCCESS (0.062s)
[495.290642] [110/132] (526s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[495.388568] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[495.389507] Starting dynamic subtest: pipe-A-eDP-1
[495.816899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[495.829358] Starting dynamic subtest: pipe-B-eDP-1
[495.837238] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[495.845372] Starting dynamic subtest: pipe-C-eDP-1
[495.853279] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[495.861261] Starting dynamic subtest: pipe-D-eDP-1
[495.868885] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[495.869789] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.444s)
[498.147823] [111/132] (524s left) api_intel_allocator (fork-simple-once)
[498.195772] Starting subtest: fork-simple-once
[498.206989] Subtest fork-simple-once: SUCCESS (0.013s)
[498.335766] [112/132] (523s left) i915_pm_rc6_residency (rc6-idle)
[498.394705] Starting subtest: rc6-idle
[498.421112] Starting dynamic subtest: gt0-rcs0
[522.632887] Dynamic subtest gt0-rcs0: SUCCESS (24.211s)
[522.641899] Starting dynamic subtest: gt0-bcs0
[547.070565] Dynamic subtest gt0-bcs0: SUCCESS (24.434s)
[547.081825] Starting dynamic subtest: gt0-ccs0
[571.512526] Dynamic subtest gt0-ccs0: SUCCESS (24.440s)
[571.521815] Starting dynamic subtest: gt1-vcs0
[577.686635] Dynamic subtest gt1-vcs0: SUCCESS (6.168s)
[577.697517] Starting dynamic subtest: gt1-vecs0
[583.858884] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[583.860260] Subtest rc6-idle: SUCCESS (85.462s)
[583.957063] [113/132] (438s left) kms_chamelium_color (ctm-max)
[584.059039] Subtest ctm-max: SKIP (0.000s)
[584.098522] [114/132] (438s left) syncobj_timeline (multi-wait-all-available-signaled)
[584.158941] Starting subtest: multi-wait-all-available-signaled
[584.159963] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[584.282588] [115/132] (438s left) gem_close (many-handles-one-vma)
[584.347473] Starting subtest: many-handles-one-vma
[584.372426] Subtest many-handles-one-vma: SUCCESS (0.025s)
[584.520373] [116/132] (437s left) kms_selftest (drm_plane_helper)
[584.553456] Starting subtest: drm_plane_helper
[584.597363] Starting dynamic subtest: drm_test_check_plane_state
[584.739714] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.142s)
[584.757468] Starting dynamic subtest: drm_test_check_invalid_plane_state
[584.878875] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.138s)
[584.879963] Subtest drm_plane_helper: SUCCESS (0.325s)
[585.084455] [117/132] (437s left) kms_vblank (ts-continuation-dpms-rpm)
[585.177388] Starting subtest: ts-continuation-dpms-rpm
[585.178322] Starting dynamic subtest: pipe-A-eDP-1
[587.711121] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.533s)
[587.721210] Starting dynamic subtest: pipe-D-eDP-1
[589.947106] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.233s)
[589.948090] Subtest ts-continuation-dpms-rpm: SUCCESS (4.770s)
[590.762050] [118/132] (431s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[590.871017] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[591.540819] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[591.744405] [119/132] (430s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[591.863368] Starting subtest: verify-pxp-execution-after-suspend-resume
[603.434243] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (11.529s)
[612.563873] [120/132] (418s left) gem_exec_whisper (basic-contexts-priority-all)
[612.640422] Starting subtest: basic-contexts-priority-all
[636.947961] Subtest basic-contexts-priority-all: SUCCESS (24.303s)
[637.149574] [121/132] (394s left) kms_flip (bo-too-big-interruptible)
[637.253690] Starting subtest: bo-too-big-interruptible
[637.256246] Starting dynamic subtest: A-eDP1
[638.591445] Dynamic subtest A-eDP1: SUCCESS (1.335s)
[638.602432] Starting dynamic subtest: B-eDP1
[639.815074] Dynamic subtest B-eDP1: SUCCESS (1.223s)
[639.827303] Starting dynamic subtest: C-eDP1
[641.049716] Dynamic subtest C-eDP1: SUCCESS (1.233s)
[641.061076] Starting dynamic subtest: D-eDP1
[642.382204] Dynamic subtest D-eDP1: SUCCESS (1.332s)
[642.384714] Subtest bo-too-big-interruptible: SUCCESS (5.130s)
[643.606195] [122/132] (387s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[643.693754] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[643.695619] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[643.843805] [123/132] (387s left) kms_addfb_basic (invalid-get-prop-any)
[643.890762] Starting subtest: invalid-get-prop-any
[643.892070] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[644.044105] [124/132] (387s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[644.105375] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[644.170369] [125/132] (387s left) kms_chamelium_hpd (vga-hpd-fast)
[644.546153] Subtest vga-hpd-fast: SKIP (0.000s)
[645.405159] [126/132] (386s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[645.494739] Starting subtest: async-flip-with-page-flip-events-linear
[645.877042] Starting dynamic subtest: pipe-A-eDP-1
[648.608073] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.729s)
[648.975288] Starting dynamic subtest: pipe-B-eDP-1
[651.737047] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[652.104856] Starting dynamic subtest: pipe-C-eDP-1
[654.865993] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[655.259338] Starting dynamic subtest: pipe-D-eDP-1
[658.005560] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.755s)
[658.006457] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.510s)
[659.204361] [127/132] (372s left) gem_exec_fence (invalid-timeline-fence-array)
[659.831869] Starting subtest: invalid-timeline-fence-array
[659.835622] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[661.021023] [128/132] (370s left) kms_atomic_interruptible (universal-setplane-cursor)
[661.121310] Starting subtest: universal-setplane-cursor
[661.122124] Starting dynamic subtest: pipe-A-eDP-1
[668.516599] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.394s)
[668.517699] Subtest universal-setplane-cursor: SUCCESS (7.395s)
[669.380633] [129/132] (362s left) prime_vgem (basic-fence-read)
[669.468102] Starting subtest: basic-fence-read
[669.475132] Subtest basic-fence-read: SKIP (0.006s)
[669.603177] [130/132] (362s left) gem_eio (in-flight-suspend)
[669.823442] Starting subtest: in-flight-suspend
[713.896079] Subtest in-flight-suspend: SUCCESS (14.524s)
[721.099510] [131/132] (317s left) gem_exec_reloc (basic-wc-noreloc)
[721.150646] Subtest basic-wc-noreloc: SKIP (0.000s)
[721.235260] [132/132] (317s left) kms_properties (get_properties-sanity-non-atomic)
[721.332157] Starting subtest: get_properties-sanity-non-atomic
[721.333100] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[721.422743] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_exec_create
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: prime_busy
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: template
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_create
results: parsing output: 28/ for test: gem_reg_read
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: kms_dirtyfb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: kms_atomic
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: kms_getfb
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_close_race
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: gem_exec_create
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_spin_batch
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: gem_exec_await
results: parsing output: 54/ for test: kms_psr2_su
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: kms_hdmi_inject
results: parsing output: 58/ for test: core_sysfs
results: parsing output: 59/ for test: kms_color
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_create
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_pwrite
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_plane_cursor
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_pm_lpsp
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_joiner
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: i915_power
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: i915_hangman
results: parsing output: 80/ for test: sysfs_preempt_timeout
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_feature_discovery
results: parsing output: 84/ for test: kms_getfb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: fbdev
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_exercise_blt
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: api_intel_allocator
results: parsing output: 111/ for test: i915_pm_rc6_residency
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_close
results: parsing output: 115/ for test: kms_selftest
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_fenced_exec_thrash
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_atomic_interruptible
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_properties
Done.