[62.733241] Initializing watchdogs
[62.733292]   /dev/watchdog0
[62.747548] [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]
[62.751836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.754128] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.757562] [001/133] (960s left) gem_ctx_persistence (engines-cleanup)
[62.856181] Starting subtest: engines-cleanup
[62.858452] Starting dynamic subtest: rcs0
[62.926150] Dynamic subtest rcs0: SUCCESS (0.071s)
[62.936676] Starting dynamic subtest: bcs0
[62.967578] Dynamic subtest bcs0: SUCCESS (0.040s)
[62.975703] Starting dynamic subtest: vcs0
[63.002722] Dynamic subtest vcs0: SUCCESS (0.037s)
[63.014181] Starting dynamic subtest: vcs1
[63.043770] Dynamic subtest vcs1: SUCCESS (0.040s)
[63.054162] Starting dynamic subtest: vecs0
[63.066017] Dynamic subtest vecs0: SUCCESS (0.022s)
[63.072511] Starting dynamic subtest: ccs0
[63.125735] Dynamic subtest ccs0: SUCCESS (0.059s)
[63.128335] Subtest engines-cleanup: SUCCESS (0.273s)
[63.213196] [002/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[63.320243] Starting subtest: x-tiled-8bpp-rotate-270
[63.355671] Subtest x-tiled-8bpp-rotate-270: SKIP (0.035s)
[63.458317] [003/133] (959s left) kms_universal_plane (cursor-fb-leak)
[63.561149] Starting subtest: cursor-fb-leak
[63.562738] Starting dynamic subtest: pipe-A-eDP-1
[63.903054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.343s)
[63.912875] Starting dynamic subtest: pipe-B-eDP-1
[65.319474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[65.328055] Starting dynamic subtest: pipe-C-eDP-1
[66.648385] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.328s)
[66.658113] Starting dynamic subtest: pipe-D-eDP-1
[67.990677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[67.992995] Subtest cursor-fb-leak: SUCCESS (4.436s)
[69.140631] [004/133] (954s left) gem_ctx_param (invalid-size-set)
[69.206421] Starting subtest: invalid-size-set
[69.208907] Subtest invalid-size-set: SUCCESS (0.002s)
[69.325986] [005/133] (954s left) kms_flip (flip-vs-suspend)
[69.420460] Starting subtest: flip-vs-suspend
[69.422827] Starting dynamic subtest: A-eDP1
[119.257023] Dynamic subtest A-eDP1: SUCCESS (4.709s)
[119.266042] Starting dynamic subtest: B-eDP1
[168.257860] Dynamic subtest B-eDP1: SUCCESS (4.527s)
[168.271119] Starting dynamic subtest: C-eDP1
[217.248392] Dynamic subtest C-eDP1: SUCCESS (4.557s)
[217.257270] Starting dynamic subtest: D-eDP1
[266.259980] Dynamic subtest D-eDP1: SUCCESS (4.535s)
[266.262495] Subtest flip-vs-suspend: SUCCESS (18.334s)
[267.426647] [006/133] (756s left) core_debugfs (read-all-entries)
[267.488914] Starting subtest: read-all-entries
[267.582006] Subtest read-all-entries: SUCCESS (0.095s)
[267.644913] [007/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[267.732054] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[267.736055] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[267.824496] [008/133] (755s left) gem_exec_fence (expired-history)
[268.274327] Starting subtest: expired-history
[275.182187] Subtest expired-history: SUCCESS (6.926s)
[275.838556] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[275.842261] [009/133] (747s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[275.951505] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[276.906986] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.957s)
[277.035080] [010/133] (746s left) gen9_exec_parse (batch-without-end)
[277.096774] Subtest batch-without-end: SKIP (0.000s)
[277.168938] [011/133] (746s left) gem_sync (basic-all)
[277.240462] Starting subtest: basic-all
[279.469169] Subtest basic-all: SUCCESS (2.238s)
[279.649185] [012/133] (744s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[279.703789] Starting subtest: x-tiled-to-vebox-yf-tiled
[279.708279] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[279.890545] [013/133] (743s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[280.003270] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[280.007432] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[280.111323] [014/133] (743s left) perf (invalid-oa-format-id)
[280.250466] Starting subtest: invalid-oa-format-id
[280.261512] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[280.304656] [015/133] (743s left) gem_softpin (evict-prime)
[280.368093] Starting subtest: evict-prime
[280.370423] Starting dynamic subtest: rcs0
[281.527659] Dynamic subtest rcs0: SUCCESS (1.161s)
[281.538932] Starting dynamic subtest: bcs0
[282.660832] Dynamic subtest bcs0: SUCCESS (1.133s)
[282.671736] Starting dynamic subtest: vcs0
[284.464636] Dynamic subtest vcs0: SUCCESS (1.802s)
[284.476226] Starting dynamic subtest: vcs1
[286.441659] Dynamic subtest vcs1: SUCCESS (1.977s)
[286.453828] Starting dynamic subtest: vecs0
[288.495831] Dynamic subtest vecs0: SUCCESS (2.054s)
[288.507573] Starting dynamic subtest: ccs0
[289.621096] Dynamic subtest ccs0: SUCCESS (1.126s)
[289.631275] Starting dynamic subtest: all
[291.443680] Dynamic subtest all: SUCCESS (1.822s)
[291.446648] Subtest evict-prime: SUCCESS (11.086s)
[291.524504] [016/133] (732s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[291.627531] Starting subtest: pixel-format-linear-modifier-source-clamping
[291.654842] Starting dynamic subtest: pipe-A-plane-0
[295.252291] Dynamic subtest pipe-A-plane-0: SUCCESS (3.600s)
[295.263057] Starting dynamic subtest: pipe-A-plane-3
[296.939881] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[298.073145] Starting dynamic subtest: pipe-B-plane-0
[301.882330] Dynamic subtest pipe-B-plane-0: SUCCESS (3.833s)
[301.890548] Starting dynamic subtest: pipe-B-plane-3
[303.554598] Dynamic subtest pipe-B-plane-3: SUCCESS (1.677s)
[303.876868] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.278s)
[304.724737] [017/133] (719s left) kms_pm_rpm (basic-rte)
[304.766678] Starting subtest: basic-rte
[308.143919] Subtest basic-rte: SUCCESS (3.384s)
[309.677092] [018/133] (714s left) kms_psr (psr2-cursor-mmap-gtt)
[309.768709] Starting subtest: psr2-cursor-mmap-gtt
[309.770867] Starting dynamic subtest: eDP-1
[311.422883] Dynamic subtest eDP-1: SUCCESS (1.657s)
[311.425063] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.658s)
[312.221738] [019/133] (711s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[312.321232] Starting subtest: psr-rgb565-draw-mmap-cpu
[319.070077] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.758s)
[319.193723] [020/133] (704s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[319.249137] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[319.353086] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[319.431979] [021/133] (704s left) kms_vblank (ts-continuation-idle-hang)
[319.528936] Starting subtest: ts-continuation-idle-hang
[319.530865] Starting dynamic subtest: pipe-A-eDP-1
[347.248629] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.721s)
[347.262471] Starting dynamic subtest: pipe-D-eDP-1
[372.283223] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.035s)
[372.285103] Subtest ts-continuation-idle-hang: SUCCESS (52.762s)
[373.101133] [022/133] (650s left) gem_eio (wait-1us)
[373.298522] Starting subtest: wait-1us
[373.576094] Subtest wait-1us: SUCCESS (0.278s)
[373.716375] [023/133] (650s left) kms_mmap_write_crc (main)
[373.821064] Starting subtest: main
[373.823440] Starting dynamic subtest: pipe-A-eDP-1
[377.234612] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.411s)
[377.237028] Subtest main: SUCCESS (3.412s)
[378.035351] [024/133] (646s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[378.156577] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[382.551000] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.398s)
[383.744235] [025/133] (640s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[383.814998] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[383.879926] [026/133] (640s left) kms_atomic (plane-primary-legacy)
[383.976015] Starting subtest: plane-primary-legacy
[383.978377] Starting dynamic subtest: pipe-A-eDP-1
[384.430531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[384.432582] Subtest plane-primary-legacy: SUCCESS (0.455s)
[385.261985] [027/133] (639s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[385.354863] Starting subtest: addfb25-y-tiled-legacy
[385.357106] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[385.445247] [028/133] (638s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[385.532881] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[385.535172] Starting dynamic subtest: pipe-A-eDP-1
[385.557681] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.568815] Starting dynamic subtest: pipe-B-eDP-1
[385.590037] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.598860] Starting dynamic subtest: pipe-C-eDP-1
[385.620649] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.629393] Starting dynamic subtest: pipe-D-eDP-1
[385.651239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.655663] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[387.851512] [029/133] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[387.948644] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[387.952636] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[388.048333] [030/133] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[388.134217] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[388.138458] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[388.242442] [031/133] (636s left) kms_psr (psr-sprite-plane-onoff)
[388.331876] Starting subtest: psr-sprite-plane-onoff
[388.334147] Starting dynamic subtest: eDP-1
[390.072058] Dynamic subtest eDP-1: SUCCESS (1.741s)
[390.074302] Subtest psr-sprite-plane-onoff: SUCCESS (1.742s)
[390.901112] [032/133] (633s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[391.305499] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[392.110620] [033/133] (632s left) gem_exec_schedule (preempt-user)
[392.180483] Starting subtest: preempt-user
[392.182420] Starting dynamic subtest: rcs0
[392.197272] Dynamic subtest rcs0: SUCCESS (0.024s)
[392.207864] Starting dynamic subtest: bcs0
[392.216542] Dynamic subtest bcs0: SUCCESS (0.019s)
[392.225394] Starting dynamic subtest: vcs0
[392.235934] Dynamic subtest vcs0: SUCCESS (0.019s)
[392.244869] Starting dynamic subtest: vcs1
[392.256296] Dynamic subtest vcs1: SUCCESS (0.019s)
[392.265128] Starting dynamic subtest: vecs0
[392.277910] Dynamic subtest vecs0: SUCCESS (0.021s)
[392.286839] Starting dynamic subtest: ccs0
[392.301259] Dynamic subtest ccs0: SUCCESS (0.022s)
[392.303524] Subtest preempt-user: SUCCESS (0.129s)
[393.604979] [034/133] (631s left) i915_hangman (engine-engine-hang)
[393.680579] Starting subtest: engine-engine-hang
[393.682744] Starting dynamic subtest: rcs0
[395.468739] Dynamic subtest rcs0: SUCCESS (1.787s)
[395.480732] Starting dynamic subtest: bcs0
[397.453263] Dynamic subtest bcs0: SUCCESS (1.980s)
[397.468861] Starting dynamic subtest: vcs0
[399.436107] Dynamic subtest vcs0: SUCCESS (1.979s)
[399.448897] Starting dynamic subtest: vcs1
[401.483853] Dynamic subtest vcs1: SUCCESS (2.044s)
[401.496100] Starting dynamic subtest: vecs0
[403.469400] Dynamic subtest vecs0: SUCCESS (1.982s)
[403.481583] Starting dynamic subtest: ccs0
[405.451155] Dynamic subtest ccs0: SUCCESS (1.979s)
[405.454295] Subtest engine-engine-hang: SUCCESS (11.767s)
[405.540582] [035/133] (619s left) i915_pm_rps (waitboost)
[405.614119] Starting subtest: waitboost
[411.743647] Subtest waitboost: SUCCESS (6.130s)
[411.866606] [036/133] (612s left) gem_mmap_offset (oob-read)
[411.916895] Starting subtest: oob-read
[411.918980] Subtest oob-read: SUCCESS (0.000s)
[412.020630] [037/133] (612s left) gem_ccs (block-copy-compressed)
[412.071153] Starting subtest: block-copy-compressed
[412.075850] Subtest block-copy-compressed: SKIP (0.000s)
[412.174870] [038/133] (612s left) gem_softpin (overlap)
[412.230502] Starting subtest: overlap
[413.150151] Subtest overlap: SUCCESS (0.918s)
[413.261123] [039/133] (611s left) perf_pmu (idle-no-semaphores)
[413.300296] Starting subtest: idle-no-semaphores
[413.302808] Starting dynamic subtest: rcs0
[413.868156] Dynamic subtest rcs0: SUCCESS (0.568s)
[413.879395] Starting dynamic subtest: bcs0
[414.386585] Dynamic subtest bcs0: SUCCESS (0.515s)
[414.397820] Starting dynamic subtest: vcs0
[414.909847] Dynamic subtest vcs0: SUCCESS (0.520s)
[414.921877] Starting dynamic subtest: vcs1
[415.434710] Dynamic subtest vcs1: SUCCESS (0.521s)
[415.445618] Starting dynamic subtest: vecs0
[415.948532] Dynamic subtest vecs0: SUCCESS (0.511s)
[415.959496] Starting dynamic subtest: ccs0
[416.469212] Dynamic subtest ccs0: SUCCESS (0.517s)
[416.471905] Subtest idle-no-semaphores: SUCCESS (3.172s)
[416.580888] [040/133] (608s left) kms_feature_discovery (display-1x)
[416.682504] Starting subtest: display-1x
[416.684860] Subtest display-1x: SUCCESS (0.000s)
[416.755468] [041/133] (608s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[416.930628] Starting subtest: cursor-rapid-movement-64x64
[416.935931] Starting dynamic subtest: pipe-A-eDP-1
[417.475535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[417.505557] Starting dynamic subtest: pipe-D-eDP-1
[418.655621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[418.658310] Subtest cursor-rapid-movement-64x64: SUCCESS (1.723s)
[419.508785] [042/133] (605s left) i915_pm_rpm (system-suspend-execbuf)
[421.637037] Starting subtest: system-suspend-execbuf
[480.206035] Subtest system-suspend-execbuf: SUCCESS (43.110s)
[480.589804] [043/133] (544s left) gem_mmap_gtt (cpuset-medium-copy)
[480.686493] Subtest cpuset-medium-copy: SKIP (0.000s)
[480.767807] [044/133] (544s left) gem_pwrite_snooped
[480.934016] [045/133] (544s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[481.028826] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[481.032892] Starting dynamic subtest: pipe-A
[481.095815] Dynamic subtest pipe-A: SUCCESS (0.069s)
[481.108409] Starting dynamic subtest: pipe-B
[482.283764] Dynamic subtest pipe-B: SUCCESS (1.190s)
[482.295644] Starting dynamic subtest: pipe-C
[483.397694] Dynamic subtest pipe-C: SUCCESS (1.113s)
[483.408165] Starting dynamic subtest: pipe-D
[484.526188] Dynamic subtest pipe-D: SUCCESS (1.129s)
[484.528032] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.505s)
[485.701630] [046/133] (539s left) kms_psr2_su (page_flip-xrgb8888)
[485.810025] Subtest page_flip-XRGB8888: SKIP (0.000s)
[485.889447] [047/133] (539s left) kms_flip (basic-flip-vs-dpms)
[485.998765] Starting subtest: basic-flip-vs-dpms
[486.003199] Starting dynamic subtest: A-eDP1
[488.594018] Dynamic subtest A-eDP1: SUCCESS (2.590s)
[488.608501] Starting dynamic subtest: B-eDP1
[490.761823] Dynamic subtest B-eDP1: SUCCESS (2.169s)
[490.784713] Starting dynamic subtest: C-eDP1
[492.921843] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[492.937915] Starting dynamic subtest: D-eDP1
[495.004930] Dynamic subtest D-eDP1: SUCCESS (2.080s)
[495.010152] Subtest basic-flip-vs-dpms: SUCCESS (9.015s)
[495.821723] [048/133] (529s left) gem_exec_balancer (invalid-balancer)
[495.894346] Starting subtest: invalid-balancer
[496.813270] Subtest invalid-balancer: SUCCESS (0.917s)
[497.120616] [049/133] (528s left) kms_setmode (basic-clone-single-crtc)
[497.192397] Starting subtest: basic-clone-single-crtc
[497.205335] Subtest basic-clone-single-crtc: SKIP (0.000s)
[497.322289] [050/133] (528s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[497.430765] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[497.440319] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[497.552502] [051/133] (527s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[497.646226] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[497.670059] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.020s)
[497.770527] [052/133] (527s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[497.824138] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[497.829445] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[497.942448] [053/133] (527s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[498.044978] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[498.050289] Starting dynamic subtest: pipe-A-eDP-1
[498.099206] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[498.110127] Starting dynamic subtest: pipe-B-eDP-1
[498.146595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[498.158290] Starting dynamic subtest: pipe-C-eDP-1
[498.195989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[498.207776] Starting dynamic subtest: pipe-D-eDP-1
[498.246700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[498.255222] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[500.350810] [054/133] (525s left) kms_content_protection (uevent)
[500.503779] Starting subtest: uevent
[500.512234] Subtest uevent: SKIP (0.000s)
[500.667543] [055/133] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[500.778437] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[508.159756] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.381s)
[508.283079] [056/133] (517s left) kms_plane (plane-position-hole-dpms)
[508.414356] Starting subtest: plane-position-hole-dpms
[508.919263] Starting dynamic subtest: pipe-A-plane-1
[511.283086] Dynamic subtest pipe-A-plane-1: SUCCESS (2.366s)
[511.294080] Starting dynamic subtest: pipe-A-plane-2
[513.732405] Dynamic subtest pipe-A-plane-2: SUCCESS (2.448s)
[513.745563] Starting dynamic subtest: pipe-A-plane-3
[516.116562] Dynamic subtest pipe-A-plane-3: SUCCESS (2.386s)
[516.128237] Starting dynamic subtest: pipe-A-plane-4
[518.568674] Dynamic subtest pipe-A-plane-4: SUCCESS (2.450s)
[518.578878] Starting dynamic subtest: pipe-A-plane-5
[518.597528] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s)
[519.736338] Starting dynamic subtest: pipe-B-plane-1
[522.182497] Dynamic subtest pipe-B-plane-1: SUCCESS (2.456s)
[522.193133] Starting dynamic subtest: pipe-B-plane-2
[524.577148] Dynamic subtest pipe-B-plane-2: SUCCESS (2.394s)
[524.587774] Starting dynamic subtest: pipe-B-plane-3
[526.936883] Dynamic subtest pipe-B-plane-3: SUCCESS (2.360s)
[526.947788] Starting dynamic subtest: pipe-B-plane-4
[529.322460] Dynamic subtest pipe-B-plane-4: SUCCESS (2.384s)
[529.333468] Starting dynamic subtest: pipe-B-plane-5
[529.349965] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[529.352293] Subtest plane-position-hole-dpms: SUCCESS (20.946s)
[530.187292] [057/133] (495s left) gem_mmap_gtt (big-copy)
[530.348136] Subtest big-copy: SKIP (0.000s)
[530.419876] [058/133] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[530.547347] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[530.551549] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[530.669170] [059/133] (495s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[530.775061] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[530.778367] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.886934] [060/133] (495s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[530.977531] Starting subtest: crc-primary-suspend-y-tiled-ccs
[530.979507] Starting dynamic subtest: pipe-A-eDP-1
[530.987054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.997203] Starting dynamic subtest: pipe-B-eDP-1
[531.004925] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[531.015779] Starting dynamic subtest: pipe-C-eDP-1
[531.023186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[531.032143] Starting dynamic subtest: pipe-D-eDP-1
[531.039190] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[531.043094] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[533.158948] [061/133] (492s left) kms_chamelium_audio (dp-audio-edid)
[533.561483] Subtest dp-audio-edid: SKIP (0.000s)
[534.362265] [062/133] (491s left) perf_pmu (interrupts)
[534.416257] Starting subtest: interrupts
[535.520177] Subtest interrupts: SUCCESS (1.102s)
[535.637459] [063/133] (490s left) syncobj_wait (single-wait-all-for-submit-signaled)
[535.718823] Starting subtest: single-wait-all-for-submit-signaled
[535.720718] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[535.839457] [064/133] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[535.961385] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[535.965403] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[536.072977] [065/133] (490s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[536.181871] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[536.185478] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[536.258925] [066/133] (490s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[536.373038] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[536.376424] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[536.469697] [067/133] (489s left) gem_exec_schedule (fairslice)
[536.540226] Starting subtest: fairslice
[536.541890] Starting dynamic subtest: rcs0
[538.565206] Dynamic subtest rcs0: SUCCESS (2.026s)
[538.577812] Starting dynamic subtest: bcs0
[540.587828] Dynamic subtest bcs0: SUCCESS (2.019s)
[540.597639] Starting dynamic subtest: vcs0
[542.612346] Dynamic subtest vcs0: SUCCESS (2.023s)
[542.622957] Starting dynamic subtest: vcs1
[544.636410] Dynamic subtest vcs1: SUCCESS (2.023s)
[544.648196] Starting dynamic subtest: vecs0
[546.664045] Dynamic subtest vecs0: SUCCESS (2.021s)
[546.673532] Starting dynamic subtest: ccs0
[548.684790] Dynamic subtest ccs0: SUCCESS (2.018s)
[548.687246] Subtest fairslice: SUCCESS (12.138s)
[548.995863] [068/133] (477s left) gem_userptr_blits (vma-merge)
[549.113097] Starting subtest: vma-merge
[549.162859] Subtest vma-merge: SUCCESS (0.052s)
[549.307192] [069/133] (477s left) gem_workarounds (suspend-resume-fd)
[549.385694] Starting subtest: suspend-resume-fd
[565.248319] Subtest suspend-resume-fd: SUCCESS (1.241s)
[565.387112] [070/133] (461s left) kms_flip (absolute-wf_vblank-interruptible)
[565.491582] Starting subtest: absolute-wf_vblank-interruptible
[565.493827] Starting dynamic subtest: A-eDP1
[574.115098] Dynamic subtest A-eDP1: SUCCESS (8.685s)
[574.127779] Starting dynamic subtest: B-eDP1
[582.824785] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[582.837816] Starting dynamic subtest: C-eDP1
[591.534084] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[591.544188] Starting dynamic subtest: D-eDP1
[600.256981] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[600.259264] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.868s)
[601.483778] [071/133] (425s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[601.605232] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[601.609290] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[601.698705] [072/133] (424s left) kms_flip (2x-plain-flip)
[601.785218] Starting subtest: 2x-plain-flip
[601.792216] Subtest 2x-plain-flip: SKIP (0.010s)
[601.886771] [073/133] (424s left) gem_workarounds (reset)
[601.953986] Starting subtest: reset
[602.125083] Subtest reset: SUCCESS (0.171s)
[602.247426] [074/133] (424s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[602.350775] Starting subtest: fbcpsr-rgb565-draw-pwrite
[609.373179] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.023s)
[609.498712] [075/133] (417s left) prime_mmap (test_reprime)
[609.564505] Starting subtest: test_reprime
[609.566825] Starting dynamic subtest: test_reprime-smem
[609.593818] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[609.596223] Subtest test_reprime: SUCCESS (0.032s)
[609.684214] [076/133] (417s left) gem_exec_reloc (basic-gtt-cpu)
[609.738421] Subtest basic-gtt-cpu: SKIP (0.000s)
[609.816250] [077/133] (416s left) sw_sync (sync_busy_fork_unixsocket)
[609.858437] Starting subtest: sync_busy_fork_unixsocket
[609.865847] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[609.931056] [078/133] (416s left) gem_exec_whisper (basic-sync-all)
[609.991113] Starting subtest: basic-sync-all
[617.736745] Subtest basic-sync-all: SUCCESS (7.743s)
[617.924081] [079/133] (408s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[618.031624] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[624.931422] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.903s)
[625.064135] [080/133] (401s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[625.613653] Starting subtest: syncobj-backward-timeline-chain-engines
[625.738468] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.125s)
[626.732607] [081/133] (400s left) kms_setmode (invalid-clone-single-crtc)
[626.794906] Starting subtest: invalid-clone-single-crtc
[626.801736] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[626.906097] [082/133] (400s left) api_intel_allocator (two-level-inception-interruptible)
[626.963453] Starting subtest: two-level-inception-interruptible
[632.366266] Subtest two-level-inception-interruptible: SUCCESS (5.405s)
[632.493059] [083/133] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[632.613000] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[632.617110] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[632.717502] [084/133] (394s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[632.825880] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[632.830087] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[632.897307] [085/133] (394s left) gem_pxp (create-protected-buffer)
[633.019473] Starting subtest: create-protected-buffer
[633.021765] Subtest create-protected-buffer: SUCCESS (0.000s)
[633.128789] [086/133] (394s left) kms_big_fb (x-tiled-addfb-size-overflow)
[633.226179] Starting subtest: x-tiled-addfb-size-overflow
[633.228421] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[633.336696] [087/133] (393s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[633.429561] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[633.433272] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[633.501854] [088/133] (393s left) kms_force_connector_basic (force-edid)
[633.578715] Starting subtest: force-edid
[633.949789] Subtest force-edid: SUCCESS (0.371s)
[634.089798] [089/133] (393s left) gem_userptr_blits (readonly-unsync)
[634.157167] Subtest readonly-unsync: SKIP (0.000s)
[634.284871] [090/133] (393s left) kms_color (ctm-0-50)
[634.392631] Starting subtest: ctm-0-50
[634.394407] Starting dynamic subtest: pipe-A-eDP-1
[637.898514] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[637.909498] Starting dynamic subtest: pipe-B-eDP-1
[642.109254] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.209s)
[642.119966] Starting dynamic subtest: pipe-C-eDP-1
[646.151428] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.042s)
[646.161168] Starting dynamic subtest: pipe-D-eDP-1
[650.137594] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[650.139969] Subtest ctm-0-50: SUCCESS (15.752s)
[650.944894] [091/133] (376s left) gem_ctx_persistence (legacy-engines-cleanup)
[650.998396] Starting subtest: legacy-engines-cleanup
[651.000644] Starting dynamic subtest: render
[651.061615] Dynamic subtest render: SUCCESS (0.063s)
[651.076147] Starting dynamic subtest: bsd1
[651.105383] Dynamic subtest bsd1: SUCCESS (0.041s)
[651.118526] Starting dynamic subtest: bsd2
[651.123158] Dynamic subtest bsd2: SUCCESS (0.015s)
[651.132285] Starting dynamic subtest: blt
[651.163294] Dynamic subtest blt: SUCCESS (0.039s)
[651.172592] Starting dynamic subtest: vebox
[651.236465] Dynamic subtest vebox: SUCCESS (0.072s)
[651.238969] Subtest legacy-engines-cleanup: SUCCESS (0.240s)
[651.328789] [092/133] (376s left) gem_exec_reloc (basic-write-gtt-noreloc)
[651.394064] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[651.468279] [093/133] (375s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[651.524056] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[651.528483] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[651.719802] [094/133] (375s left) i915_drm_fdinfo (virtual-busy-all)
[651.757872] Starting subtest: virtual-busy-all
[651.762144] Subtest virtual-busy-all: SKIP (0.000s)
[651.832722] [095/133] (375s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[651.895630] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[652.001981] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[652.083788] [096/133] (375s left) gem_eio (create-ext)
[652.346056] Starting subtest: create-ext
[652.690011] Subtest create-ext: SUCCESS (0.345s)
[652.800460] [097/133] (374s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[652.895695] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[652.900154] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[653.002574] [098/133] (374s left) kms_cursor_crc (cursor-alpha-transparent)
[653.115366] Starting subtest: cursor-alpha-transparent
[653.119226] Starting dynamic subtest: pipe-A-eDP-1
[653.738576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[653.750310] Starting dynamic subtest: pipe-D-eDP-1
[654.981906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[654.984549] Subtest cursor-alpha-transparent: SUCCESS (1.867s)
[655.847765] [099/133] (371s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[655.955005] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[662.634125] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.685s)
[662.783546] [100/133] (364s left) kms_vrr (seamless-rr-switch-drrs)
[662.886003] Starting subtest: seamless-rr-switch-drrs
[662.892545] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[662.962126] [101/133] (364s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[663.344749] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[664.113565] [102/133] (363s left) kms_lease (master-vs-lease)
[664.209081] Starting subtest: master-vs-lease
[664.211445] Subtest master-vs-lease: SUCCESS (0.002s)
[664.310658] [103/133] (363s left) kms_getfb (getfb-addfb-different-handles)
[664.403890] Starting subtest: getfb-addfb-different-handles
[664.406164] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[664.502939] [104/133] (363s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[664.596307] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[664.600592] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[664.715535] [105/133] (363s left) kms_joiner (invalid-modeset-force-big-joiner)
[664.812744] Starting subtest: invalid-modeset-force-big-joiner
[664.816928] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[664.880513] [106/133] (363s left) gem_exec_store (pages)
[664.947334] Starting subtest: pages
[664.949542] Starting dynamic subtest: rcs0
[665.041544] Dynamic subtest rcs0: SUCCESS (0.096s)
[665.052516] Starting dynamic subtest: bcs0
[665.104654] Dynamic subtest bcs0: SUCCESS (0.063s)
[665.116209] Starting dynamic subtest: vcs0
[665.172369] Dynamic subtest vcs0: SUCCESS (0.065s)
[665.183660] Starting dynamic subtest: vcs1
[665.235721] Dynamic subtest vcs1: SUCCESS (0.062s)
[665.245037] Starting dynamic subtest: vecs0
[665.312189] Dynamic subtest vecs0: SUCCESS (0.075s)
[665.324176] Starting dynamic subtest: ccs0
[665.396453] Dynamic subtest ccs0: SUCCESS (0.083s)
[665.398694] Subtest pages: SUCCESS (0.452s)
[665.582792] [107/133] (362s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[665.667211] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[665.671256] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[665.740248] [108/133] (362s left) kms_psr (fbc-psr-sprite-plane-move)
[665.832951] Starting subtest: fbc-psr-sprite-plane-move
[665.835177] Starting dynamic subtest: eDP-1
[665.839113] Dynamic subtest eDP-1: SKIP (0.000s)
[665.843106] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[665.913373] [109/133] (362s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[666.011448] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[666.956859] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.945s)
[667.092070] [110/133] (361s left) syncobj_wait (wait-zero-handles)
[667.153673] Starting subtest: wait-zero-handles
[667.155848] Subtest wait-zero-handles: SUCCESS (0.000s)
[667.250356] [111/133] (360s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[667.361401] Starting subtest: cursor-vs-flip-toggle
[698.460672] Subtest cursor-vs-flip-toggle: SUCCESS (31.093s)
[699.337993] [112/133] (328s left) gem_ctx_engines (execute-one)
[699.407396] Starting subtest: execute-one
[702.230344] Subtest execute-one: SUCCESS (2.826s)
[702.429017] [113/133] (325s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[702.531540] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[709.761638] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.234s)
[709.890799] [114/133] (318s left) dmabuf_sync_file (export-before-signal)
[709.937791] Starting subtest: export-before-signal
[709.940367] Subtest export-before-signal: SUCCESS (0.001s)
[709.996643] [115/133] (318s left) kms_cursor_edge_walk (256x256-top-bottom)
[710.096999] Starting subtest: 256x256-top-bottom
[710.099246] Starting dynamic subtest: pipe-A-eDP-1
[713.566773] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[713.577525] Starting dynamic subtest: pipe-D-eDP-1
[716.755655] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.187s)
[716.757881] Subtest 256x256-top-bottom: SUCCESS (6.660s)
[717.645325] [116/133] (310s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[717.749855] Starting subtest: pr-plane-move-sf-dmg-area
[717.754236] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[717.832557] [117/133] (310s left) syncobj_timeline (single-wait-for-submit-signaled)
[717.889669] Starting subtest: single-wait-for-submit-signaled
[717.892009] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[717.995906] [118/133] (310s left) gem_workarounds (basic-read-context)
[718.068644] Starting subtest: basic-read-context
[718.079860] Subtest basic-read-context: SUCCESS (0.011s)
[718.193496] [119/133] (310s left) kms_psr (pr-cursor-mmap-cpu)
[718.290191] Starting subtest: pr-cursor-mmap-cpu
[718.294368] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[718.366224] [120/133] (310s left) kms_psr (fbc-psr2-basic)
[718.455603] Starting subtest: fbc-psr2-basic
[718.457911] Starting dynamic subtest: eDP-1
[718.462145] Dynamic subtest eDP-1: SKIP (0.000s)
[718.466509] Subtest fbc-psr2-basic: SKIP (0.001s)
[718.531390] [121/133] (310s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[718.626401] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[718.628404] Starting dynamic subtest: pipe-A-eDP-1
[719.064301] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[719.075013] Starting dynamic subtest: pipe-B-eDP-1
[720.547771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s)
[720.561314] Starting dynamic subtest: pipe-C-eDP-1
[721.919628] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[721.931727] Starting dynamic subtest: pipe-D-eDP-1
[723.272748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[723.274640] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.621s)
[724.442128] [122/133] (304s left) gem_ctx_param (non-root-set)
[724.493734] Starting subtest: non-root-set
[724.512016] Subtest non-root-set: SUCCESS (0.018s)
[724.599406] [123/133] (304s left) gem_pread (display)
[724.652400] Subtest display: SKIP (0.000s)
[724.709574] [124/133] (304s left) gem_exec_schedule (preempt-other-chain)
[724.784764] Starting subtest: preempt-other-chain
[724.786618] Starting dynamic subtest: rcs0
[724.864102] Dynamic subtest rcs0: SUCCESS (0.085s)
[724.875642] Starting dynamic subtest: bcs0
[724.951735] Dynamic subtest bcs0: SUCCESS (0.086s)
[724.966974] Starting dynamic subtest: vcs0
[725.032708] Dynamic subtest vcs0: SUCCESS (0.080s)
[725.042900] Starting dynamic subtest: vcs1
[725.116598] Dynamic subtest vcs1: SUCCESS (0.083s)
[725.130901] Starting dynamic subtest: vecs0
[725.192794] Dynamic subtest vecs0: SUCCESS (0.075s)
[725.206329] Starting dynamic subtest: ccs0
[725.276857] Dynamic subtest ccs0: SUCCESS (0.083s)
[725.279607] Subtest preempt-other-chain: SUCCESS (0.498s)
[726.688385] [125/133] (302s left) prime_busy (hang)
[726.755130] Starting subtest: hang
[726.757567] Starting dynamic subtest: rcs0
[753.189518] Dynamic subtest rcs0: SUCCESS (26.436s)
[753.201215] Starting dynamic subtest: bcs0
[760.346351] Dynamic subtest bcs0: SUCCESS (7.156s)
[760.358243] Starting dynamic subtest: vcs0
[767.323808] Dynamic subtest vcs0: SUCCESS (6.979s)
[767.333149] Starting dynamic subtest: vcs1
[774.307095] Dynamic subtest vcs1: SUCCESS (6.983s)
[774.323141] Starting dynamic subtest: vecs0
[781.334820] Dynamic subtest vecs0: SUCCESS (7.028s)
[781.346410] Starting dynamic subtest: ccs0
[795.172043] Dynamic subtest ccs0: SUCCESS (13.840s)
[795.174356] Subtest hang: SUCCESS (68.431s)
[795.304551] [126/133] (233s left) kms_pm_rpm (system-suspend-modeset)
[796.835549] Starting subtest: system-suspend-modeset
[819.922320] Subtest system-suspend-modeset: SUCCESS (7.740s)
[820.301890] [127/133] (208s left) kms_properties (invalid-properties-legacy)
[820.410069] Starting subtest: invalid-properties-legacy
[820.509804] Subtest invalid-properties-legacy: SUCCESS (0.101s)
[820.585454] [128/133] (208s left) gem_fence_thrash (bo-write-verify-y)
[820.627748] Starting subtest: bo-write-verify-y
[820.648507] Subtest bo-write-verify-y: SKIP (0.019s)
[820.711104] [129/133] (208s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[820.777485] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[820.779889] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[820.882400] [130/133] (208s left) kms_cursor_legacy (single-bo)
[821.003240] Starting subtest: single-bo
[821.005386] Starting dynamic subtest: pipe-A
[826.393809] Dynamic subtest pipe-A: SUCCESS (5.380s)
[826.406424] Starting dynamic subtest: pipe-B
[831.779447] Dynamic subtest pipe-B: SUCCESS (5.379s)
[831.791443] Starting dynamic subtest: pipe-C
[837.163459] Dynamic subtest pipe-C: SUCCESS (5.379s)
[837.175658] Starting dynamic subtest: pipe-D
[842.547484] Dynamic subtest pipe-D: SUCCESS (5.379s)
[842.559792] Starting dynamic subtest: all-pipes
[847.936521] Dynamic subtest all-pipes: SUCCESS (5.386s)
[847.938982] Subtest single-bo: SUCCESS (26.917s)
[848.083497] [131/133] (181s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[848.145569] Starting subtest: invalid-bsd1-flag-on-blt
[848.148012] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[848.262466] [132/133] (180s left) gem_close_race (basic-threads)
[848.332885] Starting subtest: basic-threads
[849.741161] Subtest basic-threads: SUCCESS (1.410s)
[849.939490] [133/133] (179s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[850.048439] Starting subtest: y-tiled-32bpp-rotate-0
[850.052465] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[850.130956] 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.