[50.166688] Initializing watchdogs
[50.166751]   /dev/watchdog0
[50.182526] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[50.188450] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.191465] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.193276] [001/133] (960s left) gem_ctx_persistence (engines-cleanup)
[50.235508] Starting subtest: engines-cleanup
[50.236365] Starting dynamic subtest: rcs0
[50.276680] Dynamic subtest rcs0: SUCCESS (0.041s)
[50.289209] Starting dynamic subtest: bcs0
[50.318522] Dynamic subtest bcs0: SUCCESS (0.041s)
[50.330438] Starting dynamic subtest: vcs0
[50.359563] Dynamic subtest vcs0: SUCCESS (0.040s)
[50.371452] Starting dynamic subtest: vcs1
[50.397532] Dynamic subtest vcs1: SUCCESS (0.037s)
[50.408938] Starting dynamic subtest: vecs0
[50.443551] Dynamic subtest vecs0: SUCCESS (0.045s)
[50.444832] Subtest engines-cleanup: SUCCESS (0.208s)
[50.509347] [002/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[50.607485] Starting subtest: x-tiled-8bpp-rotate-270
[50.697463] Subtest x-tiled-8bpp-rotate-270: SKIP (0.089s)
[50.813792] [003/133] (959s left) kms_universal_plane (cursor-fb-leak)
[50.899644] Starting subtest: cursor-fb-leak
[50.900343] Starting dynamic subtest: pipe-A-HDMI-A-1
[51.112493] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.212s)
[51.124799] Starting dynamic subtest: pipe-B-HDMI-A-1
[51.409410] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.294s)
[51.421096] Starting dynamic subtest: pipe-C-HDMI-A-1
[51.689180] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.277s)
[51.696176] Starting dynamic subtest: pipe-D-HDMI-A-1
[51.951528] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.261s)
[51.952277] Subtest cursor-fb-leak: SUCCESS (1.053s)
[52.117768] [004/133] (958s left) gem_ctx_param (invalid-size-set)
[52.151393] Starting subtest: invalid-size-set
[52.152124] Subtest invalid-size-set: SUCCESS (0.000s)
[52.209353] [005/133] (958s left) kms_flip (flip-vs-suspend)
[52.299324] Starting subtest: flip-vs-suspend
[52.301131] Starting dynamic subtest: A-HDMI-A1
[100.843999] Dynamic subtest A-HDMI-A1: SUCCESS (3.743s)
[100.850310] Starting dynamic subtest: B-HDMI-A1
[148.835934] Dynamic subtest B-HDMI-A1: SUCCESS (3.674s)
[148.844792] Starting dynamic subtest: C-HDMI-A1
[196.818171] Dynamic subtest C-HDMI-A1: SUCCESS (3.648s)
[196.824487] Starting dynamic subtest: D-HDMI-A1
[244.909317] Dynamic subtest D-HDMI-A1: SUCCESS (3.768s)
[244.911615] Subtest flip-vs-suspend: SUCCESS (14.841s)
[253.488066] [006/133] (765s left) core_debugfs (read-all-entries)
[253.531135] Starting subtest: read-all-entries
[253.569957] Subtest read-all-entries: SUCCESS (0.039s)
[253.671104] [007/133] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[253.763244] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[253.764650] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[253.847835] [008/133] (765s left) gem_exec_fence (expired-history)
[254.199776] Starting subtest: expired-history
[259.933093] Subtest expired-history: SUCCESS (5.729s)
[260.321416] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[260.325973] [009/133] (758s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[260.431531] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[260.432908] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[260.528723] [010/133] (758s left) gen9_exec_parse (batch-without-end)
[260.565907] Subtest batch-without-end: SKIP (0.000s)
[260.603135] [011/133] (758s left) gem_sync (basic-all)
[260.644961] Starting subtest: basic-all
[262.670489] Subtest basic-all: SUCCESS (2.026s)
[262.851000] [012/133] (756s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[262.888854] Starting subtest: x-tiled-to-vebox-yf-tiled
[262.889572] Starting dynamic subtest: smem
[262.957092] Dynamic subtest smem: SUCCESS (0.068s)
[262.957831] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[263.135784] [013/133] (756s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[263.231396] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[263.573262] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.342s)
[263.706192] [014/133] (755s left) perf (invalid-oa-format-id)
[263.789443] Starting subtest: invalid-oa-format-id
[263.798314] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[263.841689] [015/133] (755s left) gem_softpin (evict-prime)
[263.877712] Starting subtest: evict-prime
[263.878430] Starting dynamic subtest: rcs0
[264.994055] Dynamic subtest rcs0: SUCCESS (1.116s)
[265.011674] Starting dynamic subtest: bcs0
[266.114172] Dynamic subtest bcs0: SUCCESS (1.119s)
[266.129810] Starting dynamic subtest: vcs0
[267.235225] Dynamic subtest vcs0: SUCCESS (1.120s)
[267.254370] Starting dynamic subtest: vcs1
[268.354092] Dynamic subtest vcs1: SUCCESS (1.118s)
[268.373587] Starting dynamic subtest: vecs0
[269.472076] Dynamic subtest vecs0: SUCCESS (1.117s)
[269.487779] Starting dynamic subtest: all
[270.596844] Dynamic subtest all: SUCCESS (1.124s)
[270.597810] Subtest evict-prime: SUCCESS (6.720s)
[270.682681] [016/133] (748s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[270.768922] Starting subtest: pixel-format-linear-modifier-source-clamping
[270.789865] Starting dynamic subtest: pipe-A-plane-0
[273.273433] Dynamic subtest pipe-A-plane-0: SUCCESS (2.484s)
[273.286470] Starting dynamic subtest: pipe-A-plane-3
[275.490023] Dynamic subtest pipe-A-plane-3: SUCCESS (2.216s)
[275.503350] Starting dynamic subtest: pipe-A-plane-5
[276.698462] Dynamic subtest pipe-A-plane-5: SUCCESS (1.208s)
[276.847572] Starting dynamic subtest: pipe-B-plane-0
[279.299777] Dynamic subtest pipe-B-plane-0: SUCCESS (2.459s)
[279.314907] Starting dynamic subtest: pipe-B-plane-3
[281.533899] Dynamic subtest pipe-B-plane-3: SUCCESS (2.232s)
[281.545230] Starting dynamic subtest: pipe-B-plane-5
[282.743831] Dynamic subtest pipe-B-plane-5: SUCCESS (1.208s)
[282.816941] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.047s)
[282.959983] [017/133] (736s left) kms_pm_rpm (basic-rte)
[283.001253] Starting subtest: basic-rte
[285.649801] Subtest basic-rte: SUCCESS (2.647s)
[286.924206] [018/133] (732s left) kms_psr (psr2-cursor-mmap-gtt)
[287.012279] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[287.066058] [019/133] (732s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[287.156163] Starting subtest: psr-rgb565-draw-mmap-cpu
[287.157526] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[287.276731] [020/133] (732s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[287.309961] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[287.412060] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[287.487652] [021/133] (732s left) kms_vblank (ts-continuation-idle-hang)
[287.571205] Starting subtest: ts-continuation-idle-hang
[287.572841] Starting dynamic subtest: pipe-A-HDMI-A-1
[301.313851] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.736s)
[301.323599] Starting dynamic subtest: pipe-D-HDMI-A-1
[315.631580] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.312s)
[315.632384] Subtest ts-continuation-idle-hang: SUCCESS (28.055s)
[315.781456] [022/133] (703s left) gem_eio (wait-1us)
[315.828483] Starting subtest: wait-1us
[315.977082] Subtest wait-1us: SUCCESS (0.149s)
[316.099987] [023/133] (703s left) kms_mmap_write_crc (main)
[316.186893] Starting subtest: main
[316.188523] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.760431] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.572s)
[317.761219] Subtest main: SUCCESS (1.574s)
[317.917023] [024/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[318.011094] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[319.312886] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.301s)
[319.434225] [025/133] (700s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[319.468315] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[319.509396] [026/133] (700s left) kms_atomic (plane-primary-legacy)
[319.595235] Starting subtest: plane-primary-legacy
[319.596909] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.796976] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.200s)
[319.797776] Subtest plane-primary-legacy: SUCCESS (0.202s)
[319.952341] [027/133] (699s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[320.040681] Starting subtest: addfb25-y-tiled-legacy
[320.041539] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[320.134811] [028/133] (699s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[320.219227] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[320.219910] Starting dynamic subtest: pipe-A-HDMI-A-1
[320.226710] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[320.234182] Starting dynamic subtest: pipe-B-HDMI-A-1
[320.240903] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[320.247999] Starting dynamic subtest: pipe-C-HDMI-A-1
[320.254725] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[320.261673] Starting dynamic subtest: pipe-D-HDMI-A-1
[320.268405] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[320.269733] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[320.471111] [029/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[320.563272] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[320.564661] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[320.652203] [030/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[320.742509] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[320.743956] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[320.828549] [031/133] (699s left) kms_psr (psr-sprite-plane-onoff)
[320.913949] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[320.955515] [032/133] (699s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[321.092395] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[321.180703] [033/133] (698s left) gem_exec_schedule (preempt-user)
[321.227187] Starting subtest: preempt-user
[321.227867] Starting dynamic subtest: rcs0
[321.247087] Dynamic subtest rcs0: SUCCESS (0.020s)
[321.256863] Starting dynamic subtest: bcs0
[321.265592] Dynamic subtest bcs0: SUCCESS (0.018s)
[321.275181] Starting dynamic subtest: vcs0
[321.285035] Dynamic subtest vcs0: SUCCESS (0.018s)
[321.294754] Starting dynamic subtest: vcs1
[321.304589] Dynamic subtest vcs1: SUCCESS (0.018s)
[321.313059] Starting dynamic subtest: vecs0
[321.323589] Dynamic subtest vecs0: SUCCESS (0.018s)
[321.324395] Subtest preempt-user: SUCCESS (0.098s)
[321.646722] [034/133] (698s left) i915_hangman (engine-engine-hang)
[321.689366] Starting subtest: engine-engine-hang
[321.690107] Starting dynamic subtest: rcs0
[322.268407] Dynamic subtest rcs0: SUCCESS (0.579s)
[322.278842] Starting dynamic subtest: bcs0
[322.843411] Dynamic subtest bcs0: SUCCESS (0.573s)
[322.855915] Starting dynamic subtest: vcs0
[323.422212] Dynamic subtest vcs0: SUCCESS (0.576s)
[323.434439] Starting dynamic subtest: vcs1
[323.992104] Dynamic subtest vcs1: SUCCESS (0.568s)
[324.002669] Starting dynamic subtest: vecs0
[324.565600] Dynamic subtest vecs0: SUCCESS (0.572s)
[324.566739] Subtest engine-engine-hang: SUCCESS (2.877s)
[324.682674] [035/133] (695s left) i915_pm_rps (waitboost)
[324.727351] Starting subtest: waitboost
[328.288135] Subtest waitboost: SUCCESS (3.530s)
[328.377964] [036/133] (691s left) gem_mmap_offset (oob-read)
[328.410989] Starting subtest: oob-read
[328.411692] Subtest oob-read: SUCCESS (0.001s)
[328.499211] [037/133] (691s left) gem_ccs (block-copy-compressed)
[328.536370] Starting subtest: block-copy-compressed
[328.537768] Subtest block-copy-compressed: SKIP (0.000s)
[328.593085] [038/133] (691s left) gem_softpin (overlap)
[328.632117] Starting subtest: overlap
[329.562914] Subtest overlap: SUCCESS (0.923s)
[329.672379] [039/133] (690s left) perf_pmu (idle-no-semaphores)
[329.706380] Starting subtest: idle-no-semaphores
[329.707115] Starting dynamic subtest: rcs0
[330.241394] Dynamic subtest rcs0: SUCCESS (0.526s)
[330.252103] Starting dynamic subtest: bcs0
[330.758371] Dynamic subtest bcs0: SUCCESS (0.515s)
[330.769082] Starting dynamic subtest: vcs0
[331.274152] Dynamic subtest vcs0: SUCCESS (0.514s)
[331.285122] Starting dynamic subtest: vcs1
[331.798540] Dynamic subtest vcs1: SUCCESS (0.522s)
[331.809271] Starting dynamic subtest: vecs0
[332.314430] Dynamic subtest vecs0: SUCCESS (0.514s)
[332.315241] Subtest idle-no-semaphores: SUCCESS (2.600s)
[332.375784] [040/133] (687s left) kms_feature_discovery (display-1x)
[332.462530] Starting subtest: display-1x
[332.463262] Subtest display-1x: SUCCESS (0.000s)
[332.517084] [041/133] (687s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[332.604230] Starting subtest: cursor-rapid-movement-64x64
[332.609006] Starting dynamic subtest: pipe-A-HDMI-A-1
[332.856473] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.248s)
[332.894539] Starting dynamic subtest: pipe-D-HDMI-A-1
[333.094249] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.207s)
[333.094932] Subtest cursor-rapid-movement-64x64: SUCCESS (0.490s)
[333.259368] [042/133] (687s left) i915_pm_rpm (system-suspend-execbuf)
[334.656496] Starting subtest: system-suspend-execbuf
[376.612711] Subtest system-suspend-execbuf: SUCCESS (27.239s)
[376.840394] [043/133] (643s left) gem_mmap_gtt (cpuset-medium-copy)
[376.877028] Starting subtest: cpuset-medium-copy
[383.318480] Subtest cpuset-medium-copy: SUCCESS (6.440s)
[383.386185] [044/133] (637s left) gem_pwrite_snooped
[383.582718] [045/133] (636s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[383.673379] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[383.674391] Starting dynamic subtest: pipe-A
[383.812018] Dynamic subtest pipe-A: SUCCESS (0.139s)
[383.821156] Starting dynamic subtest: pipe-B
[383.947299] Dynamic subtest pipe-B: SUCCESS (0.134s)
[383.956792] Starting dynamic subtest: pipe-C
[384.089623] Dynamic subtest pipe-C: SUCCESS (0.141s)
[384.098802] Starting dynamic subtest: pipe-D
[384.223501] Dynamic subtest pipe-D: SUCCESS (0.132s)
[384.224289] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.551s)
[384.410325] [046/133] (636s left) kms_psr2_su (page_flip-xrgb8888)
[384.445449] Subtest page_flip-XRGB8888: SKIP (0.000s)
[384.488314] [047/133] (636s left) kms_flip (basic-flip-vs-dpms)
[384.573051] Starting subtest: basic-flip-vs-dpms
[384.575670] Starting dynamic subtest: A-HDMI-A1
[385.340727] Dynamic subtest A-HDMI-A1: SUCCESS (0.765s)
[385.352571] Starting dynamic subtest: B-HDMI-A1
[385.971744] Dynamic subtest B-HDMI-A1: SUCCESS (0.628s)
[385.980472] Starting dynamic subtest: C-HDMI-A1
[386.678699] Dynamic subtest C-HDMI-A1: SUCCESS (0.706s)
[386.688107] Starting dynamic subtest: D-HDMI-A1
[387.391191] Dynamic subtest D-HDMI-A1: SUCCESS (0.710s)
[387.392929] Subtest basic-flip-vs-dpms: SUCCESS (2.819s)
[387.516289] [048/133] (633s left) gem_exec_balancer (invalid-balancer)
[387.569530] Starting subtest: invalid-balancer
[388.881351] Subtest invalid-balancer: SUCCESS (1.303s)
[389.059412] [049/133] (631s left) kms_setmode (basic-clone-single-crtc)
[389.093214] Starting subtest: basic-clone-single-crtc
[389.095349] Subtest basic-clone-single-crtc: SKIP (0.000s)
[389.164791] [050/133] (631s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[389.262176] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[389.263538] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[389.365862] [051/133] (631s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[389.454337] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[389.463827] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.009s)
[389.523313] [052/133] (631s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[389.567182] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[389.569027] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[389.634680] [053/133] (631s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[389.719423] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[389.721280] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.728245] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[389.736583] Starting dynamic subtest: pipe-B-HDMI-A-1
[389.743478] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[389.751597] Starting dynamic subtest: pipe-C-HDMI-A-1
[389.758307] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[389.766227] Starting dynamic subtest: pipe-D-HDMI-A-1
[389.772856] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[389.774187] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[389.970470] [054/133] (630s left) kms_content_protection (uevent)
[390.060867] Starting subtest: uevent
[390.065878] Subtest uevent: SKIP (0.003s)
[390.150666] [055/133] (630s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[390.239288] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[390.240693] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[390.339110] [056/133] (630s left) kms_plane (plane-position-hole-dpms)
[390.424527] Starting subtest: plane-position-hole-dpms
[390.637302] Starting dynamic subtest: pipe-A-plane-1
[390.983204] Dynamic subtest pipe-A-plane-1: SUCCESS (0.347s)
[390.992648] Starting dynamic subtest: pipe-A-plane-2
[391.340041] Dynamic subtest pipe-A-plane-2: SUCCESS (0.355s)
[391.351665] Starting dynamic subtest: pipe-A-plane-3
[391.674372] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[391.682601] Starting dynamic subtest: pipe-A-plane-4
[392.033548] Dynamic subtest pipe-A-plane-4: SUCCESS (0.358s)
[392.042822] Starting dynamic subtest: pipe-A-plane-5
[392.379127] Dynamic subtest pipe-A-plane-5: SUCCESS (0.329s)
[392.389445] Starting dynamic subtest: pipe-A-plane-6
[392.708321] Dynamic subtest pipe-A-plane-6: SUCCESS (0.343s)
[392.717870] Starting dynamic subtest: pipe-A-plane-7
[392.719228] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[392.902755] Starting dynamic subtest: pipe-B-plane-1
[393.231763] Dynamic subtest pipe-B-plane-1: SUCCESS (0.336s)
[393.240086] Starting dynamic subtest: pipe-B-plane-2
[393.534659] Dynamic subtest pipe-B-plane-2: SUCCESS (0.302s)
[393.543916] Starting dynamic subtest: pipe-B-plane-3
[393.897006] Dynamic subtest pipe-B-plane-3: SUCCESS (0.362s)
[393.909168] Starting dynamic subtest: pipe-B-plane-4
[394.204098] Dynamic subtest pipe-B-plane-4: SUCCESS (0.305s)
[394.213318] Starting dynamic subtest: pipe-B-plane-5
[394.563539] Dynamic subtest pipe-B-plane-5: SUCCESS (0.357s)
[394.574734] Starting dynamic subtest: pipe-B-plane-6
[394.885992] Dynamic subtest pipe-B-plane-6: SUCCESS (0.322s)
[394.895462] Starting dynamic subtest: pipe-B-plane-7
[394.896863] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[394.897606] Subtest plane-position-hole-dpms: SUCCESS (4.464s)
[395.055384] [057/133] (625s left) gem_mmap_gtt (big-copy)
[395.093294] Starting subtest: big-copy
[401.224052] Subtest big-copy: SUCCESS (6.131s)
[401.290696] [058/133] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[401.434721] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[401.436159] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[401.525696] [059/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[401.613476] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[402.815700] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.202s)
[402.948117] [060/133] (618s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[403.036400] Starting subtest: crc-primary-suspend-y-tiled-ccs
[403.038263] Starting dynamic subtest: pipe-A-HDMI-A-1
[403.040943] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[403.049195] Starting dynamic subtest: pipe-B-HDMI-A-1
[403.051925] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[403.060035] Starting dynamic subtest: pipe-C-HDMI-A-1
[403.062828] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[403.070819] Starting dynamic subtest: pipe-D-HDMI-A-1
[403.073528] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[403.074895] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.008s)
[403.279990] [061/133] (617s left) kms_chamelium_audio (dp-audio-edid)
[403.420421] Subtest dp-audio-edid: SKIP (0.000s)
[403.523870] [062/133] (617s left) perf_pmu (interrupts)
[403.566261] Starting subtest: interrupts
[404.642970] Subtest interrupts: SUCCESS (1.068s)
[404.737863] [063/133] (616s left) syncobj_wait (single-wait-all-for-submit-signaled)
[404.781042] Starting subtest: single-wait-all-for-submit-signaled
[404.781774] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[404.839765] [064/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[404.931144] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[404.932522] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[405.022003] [065/133] (616s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[405.108836] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[405.109592] Starting dynamic subtest: pipe-A-valid-mode
[406.162927] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.053s)
[406.163738] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.055s)
[406.318359] [066/133] (615s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[406.417244] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[406.418706] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[406.511579] [067/133] (614s left) gem_exec_schedule (fairslice)
[406.555643] Starting subtest: fairslice
[406.556333] Starting dynamic subtest: rcs0
[408.575882] Dynamic subtest rcs0: SUCCESS (2.011s)
[408.586296] Starting dynamic subtest: bcs0
[410.588402] Dynamic subtest bcs0: SUCCESS (2.011s)
[410.599008] Starting dynamic subtest: vcs0
[412.600343] Dynamic subtest vcs0: SUCCESS (2.011s)
[412.610989] Starting dynamic subtest: vcs1
[414.611625] Dynamic subtest vcs1: SUCCESS (2.010s)
[414.622035] Starting dynamic subtest: vecs0
[416.622901] Dynamic subtest vecs0: SUCCESS (2.010s)
[416.623769] Subtest fairslice: SUCCESS (10.060s)
[416.918245] [068/133] (604s left) gem_userptr_blits (vma-merge)
[416.969545] Starting subtest: vma-merge
[417.021265] Subtest vma-merge: SUCCESS (0.052s)
[417.116253] [069/133] (604s left) gem_workarounds (suspend-resume-fd)
[417.165378] Starting subtest: suspend-resume-fd
[433.825829] Subtest suspend-resume-fd: SUCCESS (1.200s)
[442.960342] [070/133] (587s left) kms_flip (absolute-wf_vblank-interruptible)
[443.056711] Starting subtest: absolute-wf_vblank-interruptible
[443.058663] Starting dynamic subtest: A-HDMI-A1
[450.760600] Dynamic subtest A-HDMI-A1: SUCCESS (7.675s)
[450.768866] Starting dynamic subtest: B-HDMI-A1
[458.378348] Dynamic subtest B-HDMI-A1: SUCCESS (7.627s)
[458.386986] Starting dynamic subtest: C-HDMI-A1
[466.012318] Dynamic subtest C-HDMI-A1: SUCCESS (7.629s)
[466.021751] Starting dynamic subtest: D-HDMI-A1
[473.650863] Dynamic subtest D-HDMI-A1: SUCCESS (7.635s)
[473.653109] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.580s)
[473.799281] [071/133] (556s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[473.893651] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[473.895076] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[473.985748] [072/133] (556s left) kms_flip (2x-plain-flip)
[474.070604] Starting subtest: 2x-plain-flip
[474.079758] Subtest 2x-plain-flip: SKIP (0.009s)
[474.157577] [073/133] (556s left) gem_workarounds (reset)
[474.202540] Starting subtest: reset
[474.211624] Subtest reset: SUCCESS (0.009s)
[474.322616] [074/133] (556s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[474.412693] Starting subtest: fbcpsr-rgb565-draw-pwrite
[474.414045] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[474.503199] [075/133] (556s left) prime_mmap (test_reprime)
[474.536804] Starting subtest: test_reprime
[474.537559] Starting dynamic subtest: test_reprime-smem
[474.539707] Dynamic subtest test_reprime-smem: SUCCESS (0.002s)
[474.540472] Subtest test_reprime: SUCCESS (0.003s)
[474.628959] [076/133] (556s left) gem_exec_reloc (basic-gtt-cpu)
[474.666217] Starting subtest: basic-gtt-cpu
[474.673393] Subtest basic-gtt-cpu: SUCCESS (0.007s)
[474.787669] [077/133] (556s left) sw_sync (sync_busy_fork_unixsocket)
[474.819597] Starting subtest: sync_busy_fork_unixsocket
[474.828485] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[474.876036] [078/133] (555s left) gem_exec_whisper (basic-sync-all)
[474.917869] Starting subtest: basic-sync-all
[476.405715] Subtest basic-sync-all: SUCCESS (1.487s)
[476.585094] [079/133] (554s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[476.677767] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[476.679155] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[476.769580] [080/133] (554s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[477.216879] Starting subtest: syncobj-backward-timeline-chain-engines
[477.276084] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.068s)
[477.502403] [081/133] (553s left) kms_setmode (invalid-clone-single-crtc)
[477.537893] Starting subtest: invalid-clone-single-crtc
[477.540080] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[477.593828] [082/133] (553s left) api_intel_allocator (two-level-inception-interruptible)
[477.626721] Starting subtest: two-level-inception-interruptible
[483.046208] Subtest two-level-inception-interruptible: SUCCESS (5.420s)
[483.167823] [083/133] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[483.265103] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[483.266564] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[483.360661] [084/133] (547s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[483.448864] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[483.490300] [085/133] (547s left) gem_pxp (create-protected-buffer)
[483.592797] Starting subtest: create-protected-buffer
[483.593713] Subtest create-protected-buffer: SUCCESS (0.000s)
[483.697138] [086/133] (547s left) kms_big_fb (x-tiled-addfb-size-overflow)
[483.792243] Starting subtest: x-tiled-addfb-size-overflow
[483.792976] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[483.880595] [087/133] (547s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[483.965932] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[483.967272] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[484.026891] [088/133] (547s left) kms_force_connector_basic (force-edid)
[484.151817] Starting subtest: force-edid
[484.301010] Subtest force-edid: SUCCESS (0.148s)
[484.451409] [089/133] (546s left) gem_userptr_blits (readonly-unsync)
[484.490879] Subtest readonly-unsync: SKIP (0.000s)
[484.598305] [090/133] (546s left) kms_color (ctm-0-50)
[484.684972] Starting subtest: ctm-0-50
[484.685677] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.500582] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.815s)
[485.509030] Starting dynamic subtest: pipe-B-HDMI-A-1
[486.280546] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.778s)
[486.288947] Starting dynamic subtest: pipe-C-HDMI-A-1
[487.063187] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.782s)
[487.073109] Starting dynamic subtest: pipe-D-HDMI-A-1
[487.847722] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.782s)
[487.848773] Subtest ctm-0-50: SUCCESS (3.163s)
[488.008282] [091/133] (543s left) gem_ctx_persistence (legacy-engines-cleanup)
[488.050499] Starting subtest: legacy-engines-cleanup
[488.051221] Starting dynamic subtest: render
[488.095453] Dynamic subtest render: SUCCESS (0.044s)
[488.114089] Starting dynamic subtest: bsd1
[488.142387] Dynamic subtest bsd1: SUCCESS (0.044s)
[488.161089] Starting dynamic subtest: bsd2
[488.189460] Dynamic subtest bsd2: SUCCESS (0.044s)
[488.207324] Starting dynamic subtest: blt
[488.238261] Dynamic subtest blt: SUCCESS (0.046s)
[488.256273] Starting dynamic subtest: vebox
[488.278457] Dynamic subtest vebox: SUCCESS (0.038s)
[488.279461] Subtest legacy-engines-cleanup: SUCCESS (0.229s)
[488.366241] [092/133] (543s left) gem_exec_reloc (basic-write-gtt-noreloc)
[488.403987] Starting subtest: basic-write-gtt-noreloc
[488.406260] Subtest basic-write-gtt-noreloc: SUCCESS (0.002s)
[488.529683] [093/133] (542s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[488.568617] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[488.569361] Starting dynamic subtest: smem
[488.677108] Dynamic subtest smem: SUCCESS (0.107s)
[488.677892] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.109s)
[488.861833] [094/133] (542s left) i915_drm_fdinfo (virtual-busy-all)
[488.897926] Starting subtest: virtual-busy-all
[489.416197] Subtest virtual-busy-all: SUCCESS (0.518s)
[489.487191] [095/133] (542s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[489.522093] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[489.626381] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[489.695336] [096/133] (541s left) gem_eio (create-ext)
[489.741303] Starting subtest: create-ext
[489.770720] Subtest create-ext: SUCCESS (0.029s)
[489.888107] [097/133] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[489.980631] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[489.981977] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[490.082082] [098/133] (541s left) kms_cursor_crc (cursor-alpha-transparent)
[490.168038] Starting subtest: cursor-alpha-transparent
[490.169037] Starting dynamic subtest: pipe-A-HDMI-A-1
[490.453082] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.284s)
[490.464335] Starting dynamic subtest: pipe-D-HDMI-A-1
[490.699769] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.242s)
[490.700555] Subtest cursor-alpha-transparent: SUCCESS (0.532s)
[490.841178] [099/133] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[490.931639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[490.933048] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[491.022352] [100/133] (540s left) kms_vrr (seamless-rr-switch-drrs)
[491.108944] Starting subtest: seamless-rr-switch-drrs
[491.111078] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[491.163234] [101/133] (540s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[491.303348] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[491.393068] [102/133] (540s left) kms_lease (master-vs-lease)
[491.480838] Starting subtest: master-vs-lease
[491.482789] Subtest master-vs-lease: SUCCESS (0.001s)
[491.544348] [103/133] (540s left) kms_getfb (getfb-addfb-different-handles)
[491.629950] Starting subtest: getfb-addfb-different-handles
[491.630723] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[491.737948] [104/133] (540s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[491.829796] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[491.831260] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[491.919166] [105/133] (540s left) kms_joiner (invalid-modeset-force-big-joiner)
[492.005335] Starting subtest: invalid-modeset-force-big-joiner
[492.006766] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[492.060137] [106/133] (539s left) gem_exec_store (pages)
[492.103066] Starting subtest: pages
[492.103790] Starting dynamic subtest: rcs0
[492.186102] Dynamic subtest rcs0: SUCCESS (0.082s)
[492.204490] Starting dynamic subtest: bcs0
[492.243869] Dynamic subtest bcs0: SUCCESS (0.056s)
[492.253856] Starting dynamic subtest: vcs0
[492.307932] Dynamic subtest vcs0: SUCCESS (0.063s)
[492.324161] Starting dynamic subtest: vcs1
[492.359355] Dynamic subtest vcs1: SUCCESS (0.049s)
[492.371175] Starting dynamic subtest: vecs0
[492.415566] Dynamic subtest vecs0: SUCCESS (0.054s)
[492.416336] Subtest pages: SUCCESS (0.313s)
[492.605841] [107/133] (539s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[492.691881] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[492.693327] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[492.753567] [108/133] (539s left) kms_psr (fbc-psr-sprite-plane-move)
[492.841575] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[492.881069] [109/133] (539s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[492.976356] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[492.977767] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[493.079168] [110/133] (539s left) syncobj_wait (wait-zero-handles)
[493.112856] Starting subtest: wait-zero-handles
[493.113659] Subtest wait-zero-handles: SUCCESS (0.000s)
[493.181682] [111/133] (539s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[493.269068] Starting subtest: cursor-vs-flip-toggle
[525.498649] Subtest cursor-vs-flip-toggle: SUCCESS (32.226s)
[525.630705] [112/133] (506s left) gem_ctx_engines (execute-one)
[525.678167] Starting subtest: execute-one
[526.931454] Subtest execute-one: SUCCESS (1.244s)
[527.103461] [113/133] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[527.194695] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[527.196111] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[527.289445] [114/133] (505s left) dmabuf_sync_file (export-before-signal)
[527.327732] Starting subtest: export-before-signal
[527.328491] Subtest export-before-signal: SUCCESS (0.001s)
[527.381559] [115/133] (504s left) kms_cursor_edge_walk (256x256-top-bottom)
[527.467856] Starting subtest: 256x256-top-bottom
[527.468587] Starting dynamic subtest: pipe-A-HDMI-A-1
[529.207013] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.738s)
[529.216871] Starting dynamic subtest: pipe-D-HDMI-A-1
[530.883997] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.673s)
[530.884814] Subtest 256x256-top-bottom: SUCCESS (3.416s)
[530.999212] [116/133] (501s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[531.092010] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[531.135089] [117/133] (501s left) syncobj_timeline (single-wait-for-submit-signaled)
[531.169075] Starting subtest: single-wait-for-submit-signaled
[531.169844] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[531.231440] [118/133] (501s left) gem_workarounds (basic-read-context)
[531.277502] Starting subtest: basic-read-context
[531.285823] Subtest basic-read-context: SUCCESS (0.008s)
[531.390215] [119/133] (501s left) kms_psr (pr-cursor-mmap-cpu)
[531.477565] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[531.525841] [120/133] (501s left) kms_psr (fbc-psr2-basic)
[531.611542] Subtest fbc-psr2-basic: SKIP (0.000s)
[531.659408] [121/133] (500s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[531.745812] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[531.747675] Starting dynamic subtest: pipe-A-HDMI-A-1
[531.764376] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[531.772857] Starting dynamic subtest: pipe-B-HDMI-A-1
[531.789759] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[531.798226] Starting dynamic subtest: pipe-C-HDMI-A-1
[531.815356] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[531.826478] Starting dynamic subtest: pipe-D-HDMI-A-1
[531.843895] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[531.845228] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s)
[531.984112] [122/133] (500s left) gem_ctx_param (non-root-set)
[532.018878] Starting subtest: non-root-set
[532.032628] Subtest non-root-set: SUCCESS (0.014s)
[532.115746] [123/133] (500s left) gem_pread (display)
[532.149545] Starting subtest: display
[532.978180] Subtest display: SUCCESS (0.819s)
[533.055676] [124/133] (499s left) gem_exec_schedule (preempt-other-chain)
[533.101184] Starting subtest: preempt-other-chain
[533.101988] Starting dynamic subtest: rcs0
[533.137584] Dynamic subtest rcs0: SUCCESS (0.037s)
[533.147878] Starting dynamic subtest: bcs0
[533.177384] Dynamic subtest bcs0: SUCCESS (0.038s)
[533.187820] Starting dynamic subtest: vcs0
[533.219835] Dynamic subtest vcs0: SUCCESS (0.041s)
[533.230301] Starting dynamic subtest: vcs1
[533.259277] Dynamic subtest vcs1: SUCCESS (0.038s)
[533.270039] Starting dynamic subtest: vecs0
[533.298675] Dynamic subtest vecs0: SUCCESS (0.038s)
[533.299489] Subtest preempt-other-chain: SUCCESS (0.200s)
[533.595598] [125/133] (499s left) prime_busy (hang)
[533.631830] Starting subtest: hang
[533.632528] Starting dynamic subtest: rcs0
[547.525809] Dynamic subtest rcs0: SUCCESS (13.858s)
[547.534031] Starting dynamic subtest: bcs0
[554.540048] Dynamic subtest bcs0: SUCCESS (7.039s)
[554.548579] Starting dynamic subtest: vcs0
[561.540896] Dynamic subtest vcs0: SUCCESS (6.975s)
[561.549131] Starting dynamic subtest: vcs1
[568.519278] Dynamic subtest vcs1: SUCCESS (6.975s)
[568.527055] Starting dynamic subtest: vecs0
[575.557650] Dynamic subtest vecs0: SUCCESS (7.039s)
[575.558525] Subtest hang: SUCCESS (41.893s)
[575.628964] [126/133] (457s left) kms_pm_rpm (system-suspend-modeset)
[577.023405] Starting subtest: system-suspend-modeset
[597.050038] Subtest system-suspend-modeset: SUCCESS (4.690s)
[603.298215] [127/133] (435s left) kms_properties (invalid-properties-legacy)
[603.393783] Starting subtest: invalid-properties-legacy
[603.606439] Subtest invalid-properties-legacy: SUCCESS (0.204s)
[603.668754] [128/133] (435s left) gem_fence_thrash (bo-write-verify-y)
[603.700915] Starting subtest: bo-write-verify-y
[604.847482] Subtest bo-write-verify-y: SUCCESS (1.137s)
[604.934334] [129/133] (433s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[604.968366] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[604.969107] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[605.026569] [130/133] (433s left) kms_cursor_legacy (single-bo)
[605.114572] Starting subtest: single-bo
[605.115321] Starting dynamic subtest: pipe-A
[610.531737] Dynamic subtest pipe-A: SUCCESS (5.379s)
[610.539658] Starting dynamic subtest: pipe-B
[615.914179] Dynamic subtest pipe-B: SUCCESS (5.378s)
[615.922070] Starting dynamic subtest: pipe-C
[621.295761] Dynamic subtest pipe-C: SUCCESS (5.378s)
[621.303750] Starting dynamic subtest: pipe-D
[626.677031] Dynamic subtest pipe-D: SUCCESS (5.378s)
[626.685259] Starting dynamic subtest: all-pipes
[632.056745] Dynamic subtest all-pipes: SUCCESS (5.379s)
[632.057690] Subtest single-bo: SUCCESS (26.898s)
[632.093010] [131/133] (406s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[632.130246] Starting subtest: invalid-bsd1-flag-on-blt
[632.131008] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[632.225283] [132/133] (406s left) gem_close_race (basic-threads)
[632.267865] Starting subtest: basic-threads
[633.422508] Subtest basic-threads: SUCCESS (1.155s)
[633.621147] [133/133] (405s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[633.716492] Starting subtest: y-tiled-32bpp-rotate-0
[634.930247] Subtest y-tiled-32bpp-rotate-0: SUCCESS (1.214s)
[635.050343] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_universal_plane
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: core_debugfs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: gem_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_mmap_write_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pipe_b_c_ivb
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: i915_pm_rps
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_pwrite_snooped
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_psr2_su
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_setmode
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_chamelium_audio
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_workarounds
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_setmode
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_force_connector_basic
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_getfb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_joiner
results: parsing output: 105/ for test: gem_exec_store
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: kms_cursor_edge_walk
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_workarounds
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: gem_pread
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: prime_busy
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: gem_fence_thrash
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: gem_close_race
results: parsing output: 132/ for test: kms_big_fb
Done.