[58.349371] Initializing watchdogs
[58.349421]   /dev/watchdog0
[58.363895] [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.368383] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.370629] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.374041] [001/133] (960s left) kms_psr (psr-cursor-blt)
[58.493785] Starting subtest: psr-cursor-blt
[58.496075] Starting dynamic subtest: eDP-1
[60.244695] Dynamic subtest eDP-1: SUCCESS (1.743s)
[60.246951] Subtest psr-cursor-blt: SUCCESS (1.744s)
[61.099773] [002/133] (957s left) i915_hangman (error-state-basic)
[61.169914] Starting subtest: error-state-basic
[61.240089] Subtest error-state-basic: SUCCESS (0.070s)
[61.317974] [003/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[61.410584] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[61.414980] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[61.505972] [004/133] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[61.588130] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[61.590518] Starting dynamic subtest: pipe-A-eDP-1
[61.648604] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[61.656161] Starting dynamic subtest: pipe-B-eDP-1
[61.714825] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[61.724176] Starting dynamic subtest: pipe-C-eDP-1
[61.783381] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[61.792298] Starting dynamic subtest: pipe-D-eDP-1
[61.849777] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[61.853959] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[63.881658] [005/133] (955s left) syncobj_timeline (invalid-transfer-non-existent-point)
[63.939777] Starting subtest: invalid-transfer-non-existent-point
[63.942083] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[64.058712] [006/133] (955s left) gem_exec_reloc (basic-cpu-read-noreloc)
[64.129580] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[64.200627] [007/133] (954s left) i915_drm_fdinfo (all-busy-check-all)
[64.241217] Starting subtest: all-busy-check-all
[64.245627] Subtest all-busy-check-all: SKIP (0.003s)
[64.333666] [008/133] (954s left) gem_ctx_param (set-priority-range)
[64.432578] Starting subtest: set-priority-range
[64.448142] Subtest set-priority-range: SUCCESS (0.018s)
[64.549933] [009/133] (954s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[64.615646] Starting subtest: multi-wait-all-for-submit-submitted
[64.722677] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[64.795492] [010/133] (954s left) gem_exec_flush (basic-uc-prw-default)
[64.857344] Starting subtest: basic-uc-prw-default
[70.323187] Subtest basic-uc-prw-default: SUCCESS (5.461s)
[70.504377] [011/133] (948s left) gem_lmem_swapping (verify-random-ccs)
[70.547966] Subtest verify-random-ccs: SKIP (0.000s)
[70.591819] [012/133] (948s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[70.639971] Starting subtest: single-wait-all-for-submit-available-submitted
[70.642420] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[70.749320] [013/133] (948s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[70.807121] Starting subtest: multi-wait-for-submit-unsubmitted
[70.916061] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[71.004637] [014/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[71.104164] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[71.108361] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[71.193171] [015/133] (948s left) syncobj_wait (single-wait-for-submit-signaled)
[71.257138] Starting subtest: single-wait-for-submit-signaled
[71.259087] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[71.354543] [016/133] (948s left) perf_pmu (semaphore-busy)
[71.395932] Starting subtest: semaphore-busy
[71.397948] Starting dynamic subtest: rcs0
[73.035715] Dynamic subtest rcs0: SUCCESS (1.637s)
[73.045978] Starting dynamic subtest: bcs0
[74.671077] Dynamic subtest bcs0: SUCCESS (1.633s)
[74.681052] Starting dynamic subtest: vcs0
[78.417042] Dynamic subtest vcs0: SUCCESS (3.743s)
[78.428223] Starting dynamic subtest: vcs1
[84.432613] Dynamic subtest vcs1: SUCCESS (6.013s)
[84.443641] Starting dynamic subtest: vecs0
[90.386824] Dynamic subtest vecs0: SUCCESS (5.952s)
[90.397713] Starting dynamic subtest: ccs0
[93.525197] Dynamic subtest ccs0: SUCCESS (3.137s)
[93.527891] Subtest semaphore-busy: SUCCESS (22.121s)
[93.637649] [017/133] (925s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[93.742963] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[93.745455] Starting dynamic subtest: pipe-A-default-mode
[96.406581] Dynamic subtest pipe-A-default-mode: SUCCESS (2.663s)
[96.409081] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.664s)
[97.272873] [018/133] (922s left) gen9_exec_parse (bb-secure)
[97.335895] Subtest bb-secure: SKIP (0.000s)
[97.402218] [019/133] (922s left) kms_flip (plain-flip-fb-recreate)
[97.499035] Starting subtest: plain-flip-fb-recreate
[97.501362] Starting dynamic subtest: A-eDP1
[106.375092] Dynamic subtest A-eDP1: SUCCESS (8.876s)
[106.385577] Starting dynamic subtest: B-eDP1
[115.208217] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[115.218856] Starting dynamic subtest: C-eDP1
[124.023716] Dynamic subtest C-eDP1: SUCCESS (8.814s)
[124.032569] Starting dynamic subtest: D-eDP1
[132.853900] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[132.858283] Subtest plain-flip-fb-recreate: SUCCESS (35.362s)
[134.048670] [020/133] (885s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[134.156992] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[134.168229] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[134.259865] [021/133] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[134.371821] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[137.940707] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.573s)
[139.146434] [022/133] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[139.244368] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[139.248853] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[139.341684] [023/133] (880s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[139.389758] Starting subtest: etime-single-wait-for-submit-unsubmitted
[139.499261] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[139.572666] [024/133] (880s left) kms_lease (implicit-plane-lease)
[139.664055] Starting subtest: implicit-plane-lease
[139.668879] Subtest implicit-plane-lease: SUCCESS (0.003s)
[139.779157] [025/133] (880s left) kms_pm_rpm (pc8-residency)
[142.109717] Starting subtest: pc8-residency
[142.114770] Subtest pc8-residency: SKIP (0.000s)
[142.511565] [026/133] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[142.609795] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[149.355900] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.750s)
[149.492206] [027/133] (870s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[149.555248] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[149.559731] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[149.750697] [028/133] (870s left) perf_pmu (busy-idle-no-semaphores)
[149.788456] Starting subtest: busy-idle-no-semaphores
[149.790678] Starting dynamic subtest: rcs0
[150.448498] Dynamic subtest rcs0: SUCCESS (0.660s)
[150.459665] Starting dynamic subtest: bcs0
[151.099770] Dynamic subtest bcs0: SUCCESS (0.649s)
[151.113046] Starting dynamic subtest: vcs0
[151.750755] Dynamic subtest vcs0: SUCCESS (0.650s)
[151.762503] Starting dynamic subtest: vcs1
[153.539405] Dynamic subtest vcs1: SUCCESS (1.787s)
[153.551381] Starting dynamic subtest: vecs0
[155.520247] Dynamic subtest vecs0: SUCCESS (1.979s)
[155.531709] Starting dynamic subtest: ccs0
[157.505230] Dynamic subtest ccs0: SUCCESS (1.983s)
[157.508017] Subtest busy-idle-no-semaphores: SUCCESS (7.716s)
[157.618956] [029/133] (862s left) kms_vblank (ts-continuation-dpms-suspend)
[157.716877] Starting subtest: ts-continuation-dpms-suspend
[157.718795] Starting dynamic subtest: pipe-A-eDP-1
[174.706802] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.964s)
[174.723328] Starting dynamic subtest: pipe-D-eDP-1
[192.728310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[192.730669] Subtest ts-continuation-dpms-suspend: SUCCESS (4.464s)
[193.555414] [030/133] (826s left) syncobj_timeline (wait-any-snapshot)
[193.620739] Starting subtest: wait-any-snapshot
[193.703384] Subtest wait-any-snapshot: SUCCESS (0.080s)
[193.779039] [031/133] (826s left) gem_exec_schedule (preempt-other)
[193.847354] Starting subtest: preempt-other
[193.849683] Starting dynamic subtest: rcs0
[193.922998] Dynamic subtest rcs0: SUCCESS (0.080s)
[193.933083] Starting dynamic subtest: bcs0
[193.991221] Dynamic subtest bcs0: SUCCESS (0.067s)
[194.003971] Starting dynamic subtest: vcs0
[194.075045] Dynamic subtest vcs0: SUCCESS (0.083s)
[194.088591] Starting dynamic subtest: vcs1
[194.142700] Dynamic subtest vcs1: SUCCESS (0.066s)
[194.155588] Starting dynamic subtest: vecs0
[194.208636] Dynamic subtest vecs0: SUCCESS (0.064s)
[194.222188] Starting dynamic subtest: ccs0
[194.272993] Dynamic subtest ccs0: SUCCESS (0.064s)
[194.275487] Subtest preempt-other: SUCCESS (0.427s)
[195.474579] [032/133] (824s left) kms_chamelium_audio (dp-audio)
[195.859950] Subtest dp-audio: SKIP (0.000s)
[196.692793] [033/133] (823s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[196.794392] Starting subtest: primary-y-tiled-reflect-x-90
[196.798929] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[196.866838] [034/133] (823s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[196.981440] Starting subtest: y-tiled-16bpp-rotate-270
[196.985500] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[197.067462] [035/133] (823s left) kms_psr (psr-sprite-mmap-cpu)
[197.173927] Starting subtest: psr-sprite-mmap-cpu
[197.176235] Starting dynamic subtest: eDP-1
[198.957299] Dynamic subtest eDP-1: SUCCESS (1.766s)
[198.959691] Subtest psr-sprite-mmap-cpu: SUCCESS (1.767s)
[199.801939] [036/133] (820s left) kms_content_protection (uevent-hdcp14)
[199.946428] Starting subtest: uevent-hdcp14
[199.951426] Subtest uevent-hdcp14: SKIP (0.000s)
[200.071394] [037/133] (820s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[200.194188] Starting subtest: cursorA-vs-flipB-toggle
[200.198568] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[200.351805] [038/133] (820s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[200.404918] Starting subtest: x-tiled-to-vebox-y-tiled
[200.409316] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[200.588245] [039/133] (819s left) kms_big_fb (x-tiled-addfb-size-overflow)
[200.707231] Starting subtest: x-tiled-addfb-size-overflow
[200.709596] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[200.814552] [040/133] (819s left) i915_query (hwconfig_table)
[200.872163] Starting subtest: hwconfig_table
[201.162908] Subtest hwconfig_table: SUCCESS (0.001s)
[201.200883] [041/133] (819s left) gem_ctx_param (basic-default)
[201.270036] Starting subtest: basic-default
[201.272511] Subtest basic-default: SUCCESS (0.000s)
[201.356565] [042/133] (819s left) kms_setmode (basic)
[201.408821] Starting subtest: basic
[201.730977] Starting dynamic subtest: pipe-A-eDP-1
[205.356436] Dynamic subtest pipe-A-eDP-1: FAIL (3.481s)
[205.587875] Starting dynamic subtest: pipe-B-eDP-1
[209.165150] Dynamic subtest pipe-B-eDP-1: FAIL (3.463s)
[209.357583] Subtest basic: FAIL (7.916s)
[210.221255] [043/133] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[210.327531] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[210.331857] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.433381] [044/133] (810s left) gem_exec_schedule (u-submit-late-slice)
[210.497004] Starting subtest: u-submit-late-slice
[210.499434] Starting dynamic subtest: rcs0
[210.524411] Dynamic subtest rcs0: SUCCESS (0.034s)
[210.537562] Starting dynamic subtest: bcs0
[210.555062] Dynamic subtest bcs0: SUCCESS (0.030s)
[210.565278] Starting dynamic subtest: vcs0
[210.588867] Dynamic subtest vcs0: SUCCESS (0.033s)
[210.598531] Starting dynamic subtest: vcs1
[210.620431] Dynamic subtest vcs1: SUCCESS (0.031s)
[210.629892] Starting dynamic subtest: vecs0
[210.658685] Dynamic subtest vecs0: SUCCESS (0.036s)
[210.668928] Starting dynamic subtest: ccs0
[210.689614] Dynamic subtest ccs0: SUCCESS (0.031s)
[210.691898] Subtest u-submit-late-slice: SUCCESS (0.200s)
[212.517642] [045/133] (808s left) kms_cursor_crc (cursor-alpha-opaque)
[212.609315] Starting subtest: cursor-alpha-opaque
[212.611245] Starting dynamic subtest: pipe-A-eDP-1
[213.229691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[213.239660] Starting dynamic subtest: pipe-D-eDP-1
[214.504518] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[214.506481] Subtest cursor-alpha-opaque: SUCCESS (1.893s)
[215.317515] [046/133] (805s left) i915_pm_rps (fence-order)
[215.388350] Starting subtest: fence-order
[218.365188] Subtest fence-order: SUCCESS (2.970s)
[218.493679] [047/133] (802s left) perf (gen12-group-exclusive-stream-ctx-handle)
[218.626214] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[218.652873] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[218.690771] [048/133] (802s left) gem_lmem_evict (dontneed-evict-race)
[218.734934] Subtest dontneed-evict-race: SKIP (0.000s)
[218.781027] [049/133] (802s left) syncobj_wait (reset-during-wait-for-submit)
[220.388260] Starting subtest: reset-during-wait-for-submit
[220.488806] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[220.592825] [050/133] (800s left) kms_chamelium_frames (dp-crc-single)
[221.005474] Subtest dp-crc-single: SKIP (0.000s)
[221.824082] [051/133] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[221.924424] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[221.928743] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[222.020325] [052/133] (798s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[222.131343] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[222.135282] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[222.236063] [053/133] (798s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[222.324170] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[222.326492] Starting dynamic subtest: pipe-A
[222.350650] Dynamic subtest pipe-A: SKIP (0.021s)
[222.361606] Starting dynamic subtest: pipe-B
[222.380919] Dynamic subtest pipe-B: SKIP (0.032s)
[222.390800] Starting dynamic subtest: pipe-C
[222.412775] Dynamic subtest pipe-C: SKIP (0.031s)
[222.422220] Starting dynamic subtest: pipe-D
[222.443380] Dynamic subtest pipe-D: SKIP (0.031s)
[222.447372] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s)
[222.555051] [054/133] (798s left) gem_render_copy_redux (flink-interruptible)
[222.610202] Starting subtest: flink-interruptible
[223.367212] Subtest flink-interruptible: SUCCESS (0.758s)
[223.471434] [055/133] (797s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[223.554141] Starting subtest: async-flip-with-page-flip-events-tiled
[223.936806] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[226.718436] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[226.730194] Starting dynamic subtest: pipe-A-eDP-1-4
[228.888957] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.171s)
[228.900164] Starting dynamic subtest: pipe-A-eDP-1-4
[230.896784] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[230.906867] Starting dynamic subtest: pipe-A-eDP-1-x
[233.075186] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[233.466256] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[236.246240] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[236.256071] Starting dynamic subtest: pipe-B-eDP-1-4
[238.420876] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[238.433498] Starting dynamic subtest: pipe-B-eDP-1-4
[240.430324] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[240.440302] Starting dynamic subtest: pipe-B-eDP-1-x
[242.620417] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[242.991797] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[245.782181] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[245.795180] Starting dynamic subtest: pipe-C-eDP-1-4
[247.955633] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[247.967739] Starting dynamic subtest: pipe-C-eDP-1-4
[249.965994] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[249.978079] Starting dynamic subtest: pipe-C-eDP-1-x
[252.145418] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[252.509029] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[255.319200] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.816s)
[255.331723] Starting dynamic subtest: pipe-D-eDP-1-4
[257.493569] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[257.505797] Starting dynamic subtest: pipe-D-eDP-1-4
[259.504189] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[259.515486] Starting dynamic subtest: pipe-D-eDP-1-x
[261.682273] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[261.684446] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.133s)
[262.905958] [056/133] (758s left) gem_exec_balancer (bonded-false-hang)
[263.179668] Starting subtest: bonded-false-hang
[263.184255] Subtest bonded-false-hang: SKIP (0.000s)
[263.284670] [057/133] (757s left) gen3_render_mixed_blits
[263.397672] [058/133] (757s left) gem_watchdog (default-physical)
[263.467793] Starting subtest: default-physical
[265.226037] Subtest default-physical: SUCCESS (1.767s)
[265.324324] [059/133] (755s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[265.436161] Starting subtest: crc-primary-basic-y-tiled-ccs
[265.438456] Starting dynamic subtest: pipe-A-eDP-1
[265.461375] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.472231] Starting dynamic subtest: pipe-B-eDP-1
[265.492823] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.502165] Starting dynamic subtest: pipe-C-eDP-1
[265.522838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.532439] Starting dynamic subtest: pipe-D-eDP-1
[265.554024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.558573] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[267.702834] [060/133] (753s left) kms_flip (2x-flip-vs-modeset)
[267.809244] Starting subtest: 2x-flip-vs-modeset
[267.818352] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[267.900219] [061/133] (753s left) kms_flip (2x-blocking-absolute-wf_vblank)
[267.991973] Starting subtest: 2x-blocking-absolute-wf_vblank
[268.001405] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[268.092564] [062/133] (753s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[268.204706] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[272.704565] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.503s)
[273.895739] [063/133] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[273.993799] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[273.998364] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[274.091302] [064/133] (747s left) api_intel_bb (destroy-bb)
[274.156020] Starting subtest: destroy-bb
[274.166730] Subtest destroy-bb: SUCCESS (0.009s)
[274.279628] [065/133] (747s left) core_hotunplug (unbind-rebind)
[274.361920] Starting subtest: unbind-rebind
[280.325713] Subtest unbind-rebind: SUCCESS (5.965s)
[280.364768] [066/133] (741s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[281.424623] Starting subtest: fbc-psr2-sprite-plane-onoff
[281.427165] Starting dynamic subtest: eDP-1
[281.431655] Dynamic subtest eDP-1: SKIP (0.000s)
[281.435882] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[281.508052] [067/133] (740s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[281.616179] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[281.620569] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[281.735397] [068/133] (739s left) kms_psr (pr-no-drrs)
[281.836104] Starting subtest: pr-no-drrs
[281.840355] Subtest pr-no-drrs: SKIP (0.000s)
[281.907199] [069/133] (739s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[281.999966] Starting subtest: plane-primary-overlay-mutable-zpos
[285.469800] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.468s)
[286.653957] [070/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[286.750755] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[286.754861] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[286.854389] [071/133] (734s left) gem_userptr_blits (invalid-null-pointer)
[286.929294] Starting subtest: invalid-null-pointer
[286.931652] Subtest invalid-null-pointer: SUCCESS (0.001s)
[287.084115] [072/133] (734s left) kms_psr (fbc-psr2-cursor-blt)
[287.183061] Starting subtest: fbc-psr2-cursor-blt
[287.185363] Starting dynamic subtest: eDP-1
[287.189623] Dynamic subtest eDP-1: SKIP (0.000s)
[287.193879] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[287.258852] [073/133] (734s left) kms_cursor_crc (cursor-random-128x128)
[287.459180] Starting subtest: cursor-random-128x128
[287.464354] Starting dynamic subtest: pipe-A-eDP-1
[290.816705] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.346s)
[290.839780] Starting dynamic subtest: pipe-D-eDP-1
[294.852275] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.022s)
[294.854599] Subtest cursor-random-128x128: SUCCESS (7.395s)
[295.718567] [074/133] (726s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[295.823258] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[302.765864] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.945s)
[302.899853] [075/133] (719s left) kms_color_pipeline (plane-ctm3x4)
[302.995543] Starting subtest: plane-ctm3x4
[303.130211] Starting dynamic subtest: pipe-A-plane-0
[303.286978] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[303.297882] Starting dynamic subtest: pipe-A-plane-1
[303.418580] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[303.429046] Starting dynamic subtest: pipe-A-plane-2
[303.552507] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[304.732738] Starting dynamic subtest: pipe-B-plane-0
[304.867638] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[304.879264] Starting dynamic subtest: pipe-B-plane-1
[304.989544] Dynamic subtest pipe-B-plane-1: SUCCESS (0.121s)
[305.000086] Starting dynamic subtest: pipe-B-plane-2
[305.144729] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[306.358468] Starting dynamic subtest: pipe-C-plane-0
[306.482719] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[306.493791] Starting dynamic subtest: pipe-C-plane-1
[306.593646] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[306.607499] Starting dynamic subtest: pipe-C-plane-2
[306.704565] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s)
[307.892398] Starting dynamic subtest: pipe-D-plane-0
[307.994576] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[308.005446] Starting dynamic subtest: pipe-D-plane-1
[308.105683] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[308.116573] Starting dynamic subtest: pipe-D-plane-2
[308.216579] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[308.507513] Subtest plane-ctm3x4: SUCCESS (5.513s)
[309.363264] [076/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[309.461280] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[309.465512] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[309.572469] [077/133] (712s left) gem_busy (busy)
[309.635404] Starting subtest: busy
[309.637716] Starting dynamic subtest: all-engines
[309.686263] Dynamic subtest all-engines: SUCCESS (0.051s)
[309.696953] Starting dynamic subtest: rcs0
[311.369833] Dynamic subtest rcs0: SUCCESS (1.682s)
[311.381044] Starting dynamic subtest: bcs0
[311.410019] Dynamic subtest bcs0: SUCCESS (0.039s)
[311.420014] Starting dynamic subtest: vcs0
[311.449529] Dynamic subtest vcs0: SUCCESS (0.038s)
[311.459433] Starting dynamic subtest: vcs1
[313.415079] Dynamic subtest vcs1: SUCCESS (1.962s)
[313.426894] Starting dynamic subtest: vecs0
[315.399886] Dynamic subtest vecs0: SUCCESS (1.983s)
[315.411911] Starting dynamic subtest: ccs0
[317.381693] Dynamic subtest ccs0: SUCCESS (1.981s)
[317.384102] Subtest busy: SUCCESS (7.746s)
[317.744703] [078/133] (704s left) gem_pwrite (basic-exhaustion)
[317.802605] Subtest basic-exhaustion: SKIP (0.000s)
[317.865659] [079/133] (704s left) api_intel_allocator (two-level-inception)
[317.928687] Starting subtest: two-level-inception
[323.327631] Subtest two-level-inception: SUCCESS (5.399s)
[323.449816] [080/133] (698s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[323.540482] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[323.542869] Starting dynamic subtest: pipe-A
[323.561528] Dynamic subtest pipe-A: SKIP (0.016s)
[323.573111] Starting dynamic subtest: pipe-B
[323.591641] Dynamic subtest pipe-B: SKIP (0.030s)
[323.602817] Starting dynamic subtest: pipe-C
[323.623313] Dynamic subtest pipe-C: SKIP (0.031s)
[323.634097] Starting dynamic subtest: pipe-D
[323.652279] Dynamic subtest pipe-D: SKIP (0.030s)
[323.655991] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.110s)
[323.751933] [081/133] (698s left) kms_dp_linktrain_fallback (dsc-fallback)
[323.842205] Starting subtest: dsc-fallback
[323.848900] Subtest dsc-fallback: SKIP (0.000s)
[323.919305] [082/133] (698s left) gem_exec_reloc (basic-concurrent0)
[323.980920] Subtest basic-concurrent0: SKIP (0.000s)
[324.065909] [083/133] (698s left) kms_cursor_crc (cursor-suspend)
[324.195422] Starting subtest: cursor-suspend
[324.197740] Starting dynamic subtest: pipe-A-eDP-1
[356.640717] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.789s)
[356.652022] Starting dynamic subtest: pipe-D-eDP-1
[390.635393] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.786s)
[390.638253] Subtest cursor-suspend: SUCCESS (11.580s)
[391.475783] [084/133] (630s left) gem_mmap_gtt (big-copy)
[391.539193] Subtest big-copy: SKIP (0.000s)
[391.599711] [085/133] (630s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[391.647873] Starting subtest: multi-wait-for-submit-submitted-signaled
[391.650354] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[391.758561] [086/133] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[391.853085] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[391.858168] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[391.959510] [087/133] (630s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[392.551331] Starting subtest: syncobj-timeline-multiple-ext-nodes
[392.554326] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[394.274276] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[394.278173] [088/133] (628s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[394.382513] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[394.388179] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[394.458118] [089/133] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[394.557820] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[394.563114] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[394.657105] [090/133] (627s left) kms_sequence (queue-idle)
[394.757161] Starting subtest: queue-idle
[394.760034] Starting dynamic subtest: pipe-A-eDP-1
[396.570101] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.797s)
[396.585208] Starting dynamic subtest: pipe-B-eDP-1
[399.030213] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.438s)
[399.043325] Starting dynamic subtest: pipe-C-eDP-1
[401.546892] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.502s)
[401.558577] Starting dynamic subtest: pipe-D-eDP-1
[403.971980] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.416s)
[403.974894] Subtest queue-idle: SUCCESS (9.159s)
[404.798100] [091/133] (617s left) kms_plane_lowres (tiling-none)
[404.891470] Starting subtest: tiling-none
[404.894149] Starting dynamic subtest: pipe-A-eDP-1
[404.899600] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.192290] Starting dynamic subtest: pipe-B-eDP-1
[405.198010] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.213002] Starting dynamic subtest: pipe-C-eDP-1
[405.218867] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[405.230474] Starting dynamic subtest: pipe-D-eDP-1
[405.236146] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[405.241550] Subtest tiling-none: SKIP (0.297s)
[406.031351] [092/133] (616s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[406.096794] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[406.161006] [093/133] (616s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[406.252727] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[410.525449] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.267s)
[411.653667] [094/133] (611s left) syncobj_wait (invalid-signal-one-illegal-handle)
[411.715040] Starting subtest: invalid-signal-one-illegal-handle
[411.717971] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[411.818703] [095/133] (611s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[411.911882] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[411.914324] Starting dynamic subtest: pipe-A-eDP-1
[411.972330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[412.266781] Starting dynamic subtest: pipe-B-eDP-1
[413.036443] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[413.323112] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.411s)
[414.201811] [096/133] (608s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[414.270629] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[414.378747] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[414.459234] [097/133] (608s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[414.562290] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[415.769059] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.516s)
[415.811064] [098/133] (607s left) kms_feature_discovery (display)
[415.900326] Starting subtest: display
[415.902777] Subtest display: SUCCESS (0.000s)
[415.974825] [099/133] (607s left) gem_ctx_persistence (legacy-engines-mixed-process)
[416.031727] Starting subtest: legacy-engines-mixed-process
[416.034097] Starting dynamic subtest: render
[417.170912] Dynamic subtest render: SUCCESS (1.137s)
[417.185300] Starting dynamic subtest: bsd1
[419.158647] Dynamic subtest bsd1: SUCCESS (1.985s)
[419.170560] Starting dynamic subtest: bsd2
[421.217489] Dynamic subtest bsd2: SUCCESS (2.052s)
[421.230124] Starting dynamic subtest: blt
[423.241494] Dynamic subtest blt: SUCCESS (2.028s)
[423.252346] Starting dynamic subtest: vebox
[425.230822] Dynamic subtest vebox: SUCCESS (1.989s)
[425.233349] Subtest legacy-engines-mixed-process: SUCCESS (9.197s)
[425.316947] [100/133] (597s left) gem_mmap_offset (mmap-unmap)
[425.382432] Starting subtest: mmap-unmap
[425.384999] Starting dynamic subtest: smem0
[448.744060] Dynamic subtest smem0: SUCCESS (23.362s)
[448.747046] Subtest mmap-unmap: SUCCESS (23.363s)
[448.856583] [101/133] (574s left) gem_spin_batch (resubmit-new)
[448.919062] Starting subtest: resubmit-new
[448.922049] Starting dynamic subtest: rcs0
[448.934361] Dynamic subtest rcs0: SUCCESS (0.015s)
[448.947115] Starting dynamic subtest: bcs0
[448.950105] Dynamic subtest bcs0: SUCCESS (0.010s)
[448.960868] Starting dynamic subtest: vcs0
[448.963179] Dynamic subtest vcs0: SUCCESS (0.009s)
[448.973661] Starting dynamic subtest: vcs1
[448.975663] Dynamic subtest vcs1: SUCCESS (0.011s)
[448.986712] Starting dynamic subtest: vecs0
[448.989220] Dynamic subtest vecs0: SUCCESS (0.011s)
[449.002162] Starting dynamic subtest: ccs0
[449.004786] Dynamic subtest ccs0: SUCCESS (0.011s)
[449.007043] Subtest resubmit-new: SUCCESS (0.073s)
[450.232833] [102/133] (572s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[450.326066] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[450.328749] Starting dynamic subtest: pipe-A-eDP-1
[450.353196] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[450.367561] Starting dynamic subtest: pipe-B-eDP-1
[450.394119] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[450.406141] Starting dynamic subtest: pipe-C-eDP-1
[450.433083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[450.443910] Starting dynamic subtest: pipe-D-eDP-1
[450.470321] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[450.475145] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[452.577566] [103/133] (570s left) gem_ctx_isolation (preservation)
[452.663328] Starting subtest: preservation
[452.666227] Starting dynamic subtest: rcs0
[452.785723] Dynamic subtest rcs0: SUCCESS (0.125s)
[452.799135] Starting dynamic subtest: bcs0
[452.940303] Dynamic subtest bcs0: SUCCESS (0.155s)
[452.953176] Starting dynamic subtest: vcs0
[453.120046] Dynamic subtest vcs0: SUCCESS (0.178s)
[453.133328] Starting dynamic subtest: vcs1
[454.328656] Dynamic subtest vcs1: SUCCESS (1.207s)
[454.342382] Starting dynamic subtest: vecs0
[456.322555] Dynamic subtest vecs0: SUCCESS (1.992s)
[456.335912] Starting dynamic subtest: ccs0
[458.319707] Dynamic subtest ccs0: SUCCESS (1.995s)
[458.322870] Subtest preservation: SUCCESS (5.658s)
[458.590600] [104/133] (564s left) kms_prop_blob (blob-prop-lifetime)
[458.643641] Starting subtest: blob-prop-lifetime
[458.646302] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[458.791376] [105/133] (564s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[458.887433] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[458.892034] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[458.983422] [106/133] (564s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[459.081006] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[459.086293] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[459.178622] [107/133] (564s left) kms_pm_backlight (basic-brightness)
[459.278242] Starting subtest: basic-brightness
[459.342700] Starting dynamic subtest: eDP-1
[459.646487] Dynamic subtest eDP-1: SUCCESS (0.306s)
[459.649282] Subtest basic-brightness: SUCCESS (0.367s)
[460.516761] [108/133] (563s left) syncobj_basic (bad-destroy)
[460.573134] Starting subtest: bad-destroy
[460.575919] Subtest bad-destroy: SUCCESS (0.000s)
[460.678191] [109/133] (562s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[460.779126] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[460.784617] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[460.876987] [110/133] (562s left) syncobj_basic (create-signaled)
[460.946297] Starting subtest: create-signaled
[460.948769] Subtest create-signaled: SUCCESS (0.000s)
[461.062070] [111/133] (562s left) gem_exec_fence (concurrent)
[461.238002] Starting subtest: concurrent
[461.243639] Subtest concurrent: SKIP (0.000s)
[463.249437] [112/133] (560s left) gem_exec_schedule (semaphore-power)
[463.440126] Subtest semaphore-power: SKIP (0.000s)
[463.623786] [113/133] (560s left) kms_pipe_crc_basic (read-crc)
[463.725878] Starting subtest: read-crc
[463.728225] Starting dynamic subtest: pipe-A-eDP-1
[464.429201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[464.441977] Starting dynamic subtest: pipe-B-eDP-1
[465.784881] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s)
[465.796883] Starting dynamic subtest: pipe-C-eDP-1
[467.094158] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[467.105949] Starting dynamic subtest: pipe-D-eDP-1
[468.434312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[468.437221] Subtest read-crc: SUCCESS (4.708s)
[469.266604] [114/133] (554s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[469.366955] Starting subtest: 4-tiled-8bpp-rotate-0
[470.637693] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.271s)
[470.776616] [115/133] (553s left) sw_sync (sync_expired_merge)
[470.810571] Starting subtest: sync_expired_merge
[471.885232] Subtest sync_expired_merge: SUCCESS (1.074s)
[471.959197] [116/133] (551s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[472.056070] Starting subtest: plane-all-modeset-transition-fencing
[472.061339] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[472.144857] [117/133] (551s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[472.241876] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[472.244119] Starting dynamic subtest: pipe-A-eDP-1
[478.123579] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.885s)
[478.138768] Starting dynamic subtest: pipe-B-eDP-1
[484.762062] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s)
[484.765194] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.521s)
[485.635574] [118/133] (538s left) kms_invalid_mode (overflow-vrefresh)
[485.734150] Starting subtest: overflow-vrefresh
[485.736858] Starting dynamic subtest: pipe-A-eDP-1
[486.014248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[486.026053] Starting dynamic subtest: pipe-B-eDP-1
[486.028318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[486.039117] Starting dynamic subtest: pipe-C-eDP-1
[486.042118] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[486.053438] Starting dynamic subtest: pipe-D-eDP-1
[486.056330] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[486.059300] Subtest overflow-vrefresh: SUCCESS (0.289s)
[486.867639] [119/133] (537s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[486.961163] Starting subtest: x-tiled-64bpp-rotate-90
[486.981582] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[487.092407] [120/133] (536s left) gem_exec_reloc (basic-write-gtt-active)
[487.161009] Subtest basic-write-gtt-active: SKIP (0.000s)
[487.243028] [121/133] (536s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[487.339925] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[487.342348] Starting dynamic subtest: pipe-A-eDP-1
[487.434102] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[487.445547] Starting dynamic subtest: pipe-B-eDP-1
[488.558071] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[488.563310] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.223s)
[489.742619] [122/133] (534s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[489.841035] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[496.379070] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.542s)
[496.501248] [123/133] (527s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[496.875089] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[497.677280] [124/133] (526s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[497.780277] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[497.783093] Starting dynamic subtest: pipe-A-eDP-1
[497.809008] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[497.820334] Starting dynamic subtest: pipe-B-eDP-1
[497.846533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[497.858987] Starting dynamic subtest: pipe-C-eDP-1
[497.884466] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[497.895147] Starting dynamic subtest: pipe-D-eDP-1
[497.920530] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[497.925132] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[500.060139] [125/133] (524s left) kms_rmfb (rmfb-ioctl)
[500.150072] Starting subtest: rmfb-ioctl
[500.152579] Starting dynamic subtest: pipe-A-eDP-1
[500.255011] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[500.268231] Starting dynamic subtest: pipe-B-eDP-1
[501.424283] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[501.437588] Starting dynamic subtest: pipe-C-eDP-1
[502.550600] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[502.562059] Starting dynamic subtest: pipe-D-eDP-1
[503.690960] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[503.693745] Subtest rmfb-ioctl: SUCCESS (3.544s)
[504.921808] [126/133] (519s left) perf (non-sampling-read-error)
[505.054735] Starting subtest: non-sampling-read-error
[505.066095] Subtest non-sampling-read-error: SUCCESS (0.009s)
[505.108854] [127/133] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[505.209695] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[512.189137] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.982s)
[512.291386] [128/133] (512s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[512.421669] Starting subtest: flip-vs-cursor-crc-atomic
[513.082050] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.659s)
[513.954616] [129/133] (510s left) kms_frontbuffer_tracking (fbc-tiling-4)
[514.060026] Starting subtest: fbc-tiling-4
[518.256306] Subtest fbc-tiling-4: SUCCESS (4.202s)
[519.451528] [130/133] (505s left) gem_ctx_shared (q-promotion)
[519.520417] Starting subtest: Q-promotion
[519.523133] Starting dynamic subtest: rcs0
[519.629908] Dynamic subtest rcs0: SUCCESS (0.111s)
[519.646656] Starting dynamic subtest: vcs0
[519.723313] Dynamic subtest vcs0: SUCCESS (0.093s)
[519.741665] Starting dynamic subtest: vcs1
[519.809944] Dynamic subtest vcs1: SUCCESS (0.084s)
[519.828823] Starting dynamic subtest: vecs0
[519.889176] Dynamic subtest vecs0: SUCCESS (0.080s)
[519.907533] Starting dynamic subtest: ccs0
[519.984510] Dynamic subtest ccs0: SUCCESS (0.095s)
[519.987216] Subtest Q-promotion: SUCCESS (0.468s)
[521.316247] [131/133] (503s left) gem_exec_params (invalid-ring)
[521.373755] Starting subtest: invalid-ring
[521.376308] Subtest invalid-ring: SUCCESS (0.000s)
[521.473785] [132/133] (503s left) gem_create (create-clear)
[521.533903] Starting subtest: create-clear
[521.536862] Starting dynamic subtest: smem0
[554.234534] Dynamic subtest smem0: SUCCESS (32.695s)
[554.236677] Subtest create-clear: SUCCESS (32.696s)
[554.442722] [133/133] (470s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[554.544184] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[554.569339] Starting dynamic subtest: pipe-A-plane-0
[555.225235] Dynamic subtest pipe-A-plane-0: SUCCESS (0.656s)
[555.236634] Starting dynamic subtest: pipe-A-plane-3
[555.692958] Dynamic subtest pipe-A-plane-3: SUCCESS (0.466s)
[556.834861] Starting dynamic subtest: pipe-B-plane-0
[557.560489] Dynamic subtest pipe-B-plane-0: SUCCESS (0.733s)
[557.578337] Starting dynamic subtest: pipe-B-plane-3
[558.026821] Dynamic subtest pipe-B-plane-3: SUCCESS (0.465s)
[558.343782] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.799s)
[559.211624] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: i915_hangman
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_exec_flush
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_lease
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_chamelium_audio
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: i915_pm_rps
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_lmem_evict
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gem_render_copy_redux
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: gen3_render_mixed_blits
results: parsing output: 57/ for test: gem_watchdog
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: core_hotunplug
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_atomic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_busy
results: parsing output: 77/ for test: gem_pwrite
results: parsing output: 78/ for test: api_intel_allocator
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_dp_linktrain_fallback
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_sequence
results: parsing output: 90/ for test: kms_plane_lowres
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_atomic_transition
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_feature_discovery
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: gem_mmap_offset
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: kms_prop_blob
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_pm_backlight
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_basic
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_pipe_crc_basic
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_invalid_mode
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_rmfb
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: gem_create
results: parsing output: 132/ for test: kms_plane
Done.