[64.558346] Initializing watchdogs
[64.558416]   /dev/watchdog0
[64.583504] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[64.593798] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.597803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.600148] [001/133] (960s left) gem_softpin (evict-active-interruptible)
[64.684696] Starting subtest: evict-active-interruptible
[64.703215] Subtest evict-active-interruptible: SUCCESS (0.019s)
[64.889484] [002/133] (960s left) perf_pmu (busy-accuracy-2)
[64.951981] Starting subtest: busy-accuracy-2
[64.952948] Starting dynamic subtest: rcs0
[68.013387] Dynamic subtest rcs0: SUCCESS (3.060s)
[68.023157] Starting dynamic subtest: bcs0
[71.083382] Dynamic subtest bcs0: SUCCESS (3.070s)
[71.092167] Starting dynamic subtest: vcs0
[74.153555] Dynamic subtest vcs0: SUCCESS (3.070s)
[74.161995] Starting dynamic subtest: vcs1
[77.220193] Dynamic subtest vcs1: SUCCESS (3.066s)
[77.228779] Starting dynamic subtest: vecs0
[80.285451] Dynamic subtest vecs0: SUCCESS (3.065s)
[80.294413] Starting dynamic subtest: vecs1
[83.350618] Dynamic subtest vecs1: SUCCESS (3.065s)
[83.359800] Starting dynamic subtest: ccs0
[86.413130] Dynamic subtest ccs0: SUCCESS (3.063s)
[86.413995] Subtest busy-accuracy-2: SUCCESS (21.462s)
[86.611922] [003/133] (938s left) gem_sync (basic-all)
[86.698368] Starting subtest: basic-all
[88.787662] Subtest basic-all: SUCCESS (2.089s)
[89.011574] [004/133] (936s left) gem_exec_fence (invalid-timeline-fence-array)
[89.678413] Starting subtest: invalid-timeline-fence-array
[89.684950] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[89.965858] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[89.968528] [005/133] (935s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[90.046292] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[90.150785] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[90.246982] [006/133] (935s left) kms_hdr (bpc-switch-suspend)
[91.774489] Starting subtest: bpc-switch-suspend
[91.777161] Subtest bpc-switch-suspend: SKIP (0.001s)
[91.864718] [007/133] (933s left) gem_eio (in-flight-1us)
[92.151077] Starting subtest: in-flight-1us
[97.094638] Subtest in-flight-1us: SUCCESS (4.944s)
[98.667101] [008/133] (926s left) gem_render_copy (linear-to-vebox-y-tiled)
[98.777430] Starting subtest: linear-to-vebox-y-tiled
[98.779513] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[99.060635] [009/133] (926s left) prime_vgem (basic-write)
[99.166188] Starting subtest: basic-write
[99.172260] Subtest basic-write: SKIP (0.006s)
[99.299382] [010/133] (926s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[100.814609] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[100.816274] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[100.950375] [011/133] (924s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[102.490466] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[109.398787] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (6.909s)
[109.555576] [012/133] (916s left) gem_eio (reset-stress)
[109.851544] Starting subtest: reset-stress
[109.852456] Starting dynamic subtest: render
[116.436438] Dynamic subtest render: SUCCESS (6.584s)
[116.446184] Starting dynamic subtest: bsd1
[123.055610] Dynamic subtest bsd1: SUCCESS (6.619s)
[123.065459] Starting dynamic subtest: bsd2
[129.641168] Dynamic subtest bsd2: SUCCESS (6.585s)
[129.650978] Starting dynamic subtest: blt
[136.237370] Dynamic subtest blt: SUCCESS (6.596s)
[136.247121] Starting dynamic subtest: vebox
[142.883676] Dynamic subtest vebox: SUCCESS (6.646s)
[142.884602] Subtest reset-stress: SUCCESS (33.032s)
[144.554589] [013/133] (881s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[146.067349] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[146.069095] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[146.178200] [014/133] (879s left) kms_cursor_crc (cursor-size-hints)
[147.794476] Starting subtest: cursor-size-hints
[147.796423] Starting dynamic subtest: pipe-A-HDMI-A-3
[148.348565] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.553s)
[148.359261] Starting dynamic subtest: pipe-D-HDMI-A-3
[148.757464] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.407s)
[148.758413] Subtest cursor-size-hints: SUCCESS (0.963s)
[149.237366] [015/133] (876s left) syncobj_timeline (wait-all-complex)
[149.314953] Starting subtest: wait-all-complex
[149.533040] Subtest wait-all-complex: SUCCESS (0.217s)
[149.625239] [016/133] (876s left) perf_pmu (busy-idle-no-semaphores)
[149.694753] Starting subtest: busy-idle-no-semaphores
[149.695610] Starting dynamic subtest: rcs0
[150.378109] Dynamic subtest rcs0: SUCCESS (0.682s)
[150.391382] Starting dynamic subtest: bcs0
[151.032203] Dynamic subtest bcs0: SUCCESS (0.653s)
[151.046255] Starting dynamic subtest: vcs0
[151.688083] Dynamic subtest vcs0: SUCCESS (0.655s)
[151.702239] Starting dynamic subtest: vcs1
[152.341957] Dynamic subtest vcs1: SUCCESS (0.653s)
[152.355270] Starting dynamic subtest: vecs0
[152.997127] Dynamic subtest vecs0: SUCCESS (0.654s)
[153.008355] Starting dynamic subtest: vecs1
[153.653978] Dynamic subtest vecs1: SUCCESS (0.655s)
[153.667584] Starting dynamic subtest: ccs0
[154.310966] Dynamic subtest ccs0: SUCCESS (0.656s)
[154.312884] Subtest busy-idle-no-semaphores: SUCCESS (4.616s)
[154.496084] [017/133] (871s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[156.011643] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[156.013394] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[156.226222] [018/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[157.749956] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[157.751708] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[157.871519] [019/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[159.412407] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[159.414144] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[159.543438] [020/133] (866s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[161.081258] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[161.082190] Starting dynamic subtest: pipe-A-HDMI-A-3
[161.085442] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[161.095111] Starting dynamic subtest: pipe-B-HDMI-A-3
[161.098882] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[161.108161] Starting dynamic subtest: pipe-C-HDMI-A-3
[161.111674] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[161.120720] Starting dynamic subtest: pipe-D-HDMI-A-3
[161.124161] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[161.125898] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[161.344881] [021/133] (865s left) perf_pmu (semaphore-wait-idle)
[161.415277] Starting subtest: semaphore-wait-idle
[161.416217] Starting dynamic subtest: rcs0
[161.956114] Dynamic subtest rcs0: SUCCESS (0.539s)
[161.967517] Starting dynamic subtest: bcs0
[162.468653] Dynamic subtest bcs0: SUCCESS (0.511s)
[162.480446] Starting dynamic subtest: vcs0
[162.981762] Dynamic subtest vcs0: SUCCESS (0.512s)
[162.993534] Starting dynamic subtest: vcs1
[163.494623] Dynamic subtest vcs1: SUCCESS (0.512s)
[163.506470] Starting dynamic subtest: vecs0
[164.007597] Dynamic subtest vecs0: SUCCESS (0.512s)
[164.019523] Starting dynamic subtest: vecs1
[164.520919] Dynamic subtest vecs1: SUCCESS (0.512s)
[164.532556] Starting dynamic subtest: ccs0
[165.033941] Dynamic subtest ccs0: SUCCESS (0.512s)
[165.035982] Subtest semaphore-wait-idle: SUCCESS (3.618s)
[165.205485] [022/133] (861s left) kms_lease (lease-unleased-connector)
[166.715066] Starting subtest: lease-unleased-connector
[166.715948] Starting dynamic subtest: pipe-A-HDMI-A-3
[166.771888] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.056s)
[166.781397] Starting dynamic subtest: pipe-B-HDMI-A-3
[166.828117] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.055s)
[166.838973] Starting dynamic subtest: pipe-C-HDMI-A-3
[166.884976] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.055s)
[166.894371] Starting dynamic subtest: pipe-D-HDMI-A-3
[166.941026] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.055s)
[166.941985] Subtest lease-unleased-connector: SUCCESS (0.227s)
[167.043621] [023/133] (859s left) gem_exec_parallel (basic)
[167.132298] Starting subtest: basic
[167.133171] Starting dynamic subtest: rcs0
[168.712198] Dynamic subtest rcs0: SUCCESS (1.580s)
[168.722065] Starting dynamic subtest: bcs0
[170.170350] Dynamic subtest bcs0: SUCCESS (1.458s)
[170.181507] Starting dynamic subtest: vcs0
[171.645380] Dynamic subtest vcs0: SUCCESS (1.475s)
[171.655787] Starting dynamic subtest: vcs1
[173.147522] Dynamic subtest vcs1: SUCCESS (1.502s)
[173.159060] Starting dynamic subtest: vecs0
[174.624673] Dynamic subtest vecs0: SUCCESS (1.477s)
[174.635945] Starting dynamic subtest: vecs1
[176.107601] Dynamic subtest vecs1: SUCCESS (1.483s)
[176.119365] Starting dynamic subtest: ccs0
[177.562259] Dynamic subtest ccs0: SUCCESS (1.454s)
[177.563392] Subtest basic: SUCCESS (10.430s)
[177.857021] [024/133] (848s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[179.370977] Starting subtest: cursorB-vs-flipA-atomic
[179.373993] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[179.488851] [025/133] (847s left) kms_properties (colorop-properties-legacy)
[181.024381] Starting subtest: colorop-properties-legacy
[181.025279] Starting dynamic subtest: pipe-A-HDMI-A-3
[181.147484] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.123s)
[181.157961] Starting dynamic subtest: pipe-B-HDMI-A-3
[181.268303] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.120s)
[181.278970] Starting dynamic subtest: pipe-C-HDMI-A-3
[181.368946] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.099s)
[181.378609] Starting dynamic subtest: pipe-D-HDMI-A-3
[181.465962] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.096s)
[181.468250] Subtest colorop-properties-legacy: SUCCESS (0.442s)
[181.655146] [026/133] (845s left) gen7_exec_parse (basic-offset)
[181.737057] Subtest basic-offset: SKIP (0.000s)
[181.804679] [027/133] (844s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[183.314047] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[183.314938] Starting dynamic subtest: pipe-A-HDMI-A-3
[183.323503] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[183.333463] Starting dynamic subtest: pipe-B-HDMI-A-3
[183.341734] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[183.351322] Starting dynamic subtest: pipe-C-HDMI-A-3
[183.359406] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[183.369392] Starting dynamic subtest: pipe-D-HDMI-A-3
[183.380148] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[183.382009] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[183.678904] [028/133] (843s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[185.196566] Starting subtest: fbc-rgb101010-draw-render
[188.129869] Subtest fbc-rgb101010-draw-render: SUCCESS (2.933s)
[188.310178] [029/133] (838s left) gem_exec_schedule (smoketest-all)
[188.399969] Starting subtest: smoketest-all
[220.711975] Subtest smoketest-all: SUCCESS (32.303s)
[221.129614] [030/133] (805s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[222.638273] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[222.639252] Starting dynamic subtest: pipe-A-HDMI-A-3
[222.647700] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[222.657506] Starting dynamic subtest: pipe-B-HDMI-A-3
[222.665944] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[222.675503] Starting dynamic subtest: pipe-C-HDMI-A-3
[222.683979] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[222.693674] Starting dynamic subtest: pipe-D-HDMI-A-3
[222.702647] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[222.704490] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[222.900106] [031/133] (804s left) i915_fb_tiling (basic-x-tiling)
[222.979147] Subtest basic-x-tiling: SKIP (0.000s)
[223.069331] [032/133] (804s left) gem_userptr_blits (access-control)
[223.167059] Starting subtest: access-control
[223.169374] Subtest access-control: SKIP (0.000s)
[223.339524] [033/133] (803s left) gem_mmap_gtt (cpuset-basic-small-copy)
[223.420999] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[223.488934] [034/133] (803s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[225.002257] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[225.003883] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[225.179364] [035/133] (802s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[226.714173] Starting subtest: psr-shrfb-scaledprimary
[226.715976] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[226.849896] [036/133] (800s left) gem_exec_whisper (basic-forked)
[226.963985] Starting subtest: basic-forked
[233.799210] Subtest basic-forked: SUCCESS (6.834s)
[234.090507] [037/133] (793s left) kms_addfb_basic (unused-pitches)
[234.164349] Starting subtest: unused-pitches
[234.165279] Subtest unused-pitches: SUCCESS (0.000s)
[235.738877] [038/133] (791s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[237.292288] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[238.028445] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.736s)
[238.330504] [039/133] (789s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[239.847654] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[239.904251] [040/133] (787s left) kms_chamelium_color (gamma)
[241.416776] Subtest gamma: SKIP (0.000s)
[241.472820] [041/133] (786s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[241.568178] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[241.708459] [042/133] (786s left) api_intel_allocator (alloc-simple)
[241.785087] Starting subtest: alloc-simple
[241.811715] Subtest alloc-simple: SUCCESS (0.027s)
[241.940904] [043/133] (785s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[243.459602] Starting subtest: psr-1p-pri-indfb-multidraw
[243.461279] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[243.609463] [044/133] (784s left) kms_selftest (drm_dp_mst_helper)
[243.689252] Starting subtest: drm_dp_mst_helper
[243.734789] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[243.822263] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.087s)
[243.850676] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[243.922996] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.099s)
[243.944692] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[244.034379] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.109s)
[244.036292] Subtest drm_dp_mst_helper: SUCCESS (0.343s)
[244.222531] [045/133] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[245.735980] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[248.863068] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.127s)
[249.062447] [046/133] (779s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[250.577835] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[250.591780] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[250.793741] [047/133] (777s left) gem_exec_schedule (in-order)
[250.891144] Starting subtest: in-order
[250.892148] Starting dynamic subtest: rcs0
[251.172471] Dynamic subtest rcs0: SUCCESS (0.281s)
[251.182640] Starting dynamic subtest: bcs0
[251.376338] Dynamic subtest bcs0: SUCCESS (0.204s)
[251.386488] Starting dynamic subtest: vcs0
[251.590451] Dynamic subtest vcs0: SUCCESS (0.214s)
[251.600620] Starting dynamic subtest: vcs1
[251.806107] Dynamic subtest vcs1: SUCCESS (0.215s)
[251.816379] Starting dynamic subtest: vecs0
[252.021538] Dynamic subtest vecs0: SUCCESS (0.215s)
[252.031855] Starting dynamic subtest: vecs1
[252.236167] Dynamic subtest vecs1: SUCCESS (0.214s)
[252.246410] Starting dynamic subtest: ccs0
[252.447668] Dynamic subtest ccs0: SUCCESS (0.211s)
[252.448829] Subtest in-order: SUCCESS (1.556s)
[252.930598] [048/133] (775s left) gem_softpin (overlap)
[253.023416] Starting subtest: overlap
[256.039178] Subtest overlap: SUCCESS (3.015s)
[256.224044] [049/133] (772s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[257.750441] Starting subtest: y-tiled-16bpp-rotate-180
[257.752235] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[257.876961] [050/133] (770s left) perf_pmu (frequency)
[257.969280] Starting subtest: frequency
[257.972352] Starting dynamic subtest: gt0
[260.268031] Dynamic subtest gt0: FAIL (2.213s)
[260.302970] Starting dynamic subtest: idle-gt0
[260.695064] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[260.696968] Subtest frequency: FAIL (2.727s)
[260.878755] [051/133] (767s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[262.390161] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[262.391091] Starting dynamic subtest: pipe-A-valid-mode
[263.899329] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.508s)
[263.900229] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.509s)
[264.072655] [052/133] (764s left) gem_ctx_isolation (dirty-create)
[264.161185] Starting subtest: dirty-create
[264.162163] Starting dynamic subtest: rcs0
[264.769544] Dynamic subtest rcs0: SUCCESS (0.608s)
[264.780130] Starting dynamic subtest: bcs0
[265.437828] Dynamic subtest bcs0: SUCCESS (0.668s)
[265.447991] Starting dynamic subtest: vcs0
[266.096945] Dynamic subtest vcs0: SUCCESS (0.659s)
[266.107471] Starting dynamic subtest: vcs1
[266.750611] Dynamic subtest vcs1: SUCCESS (0.653s)
[266.761037] Starting dynamic subtest: vecs0
[267.414437] Dynamic subtest vecs0: SUCCESS (0.663s)
[267.425361] Starting dynamic subtest: vecs1
[268.047557] Dynamic subtest vecs1: SUCCESS (0.633s)
[268.057783] Starting dynamic subtest: ccs0
[268.697749] Dynamic subtest ccs0: SUCCESS (0.650s)
[268.698710] Subtest dirty-create: SUCCESS (4.537s)
[269.016032] [053/133] (759s left) kms_invalid_mode (overflow-vrefresh)
[270.529047] Starting subtest: overflow-vrefresh
[270.529972] Starting dynamic subtest: pipe-A-HDMI-A-3
[270.582512] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.053s)
[270.593131] Starting dynamic subtest: pipe-B-HDMI-A-3
[270.594215] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[270.603931] Starting dynamic subtest: pipe-C-HDMI-A-3
[270.604847] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[270.615016] Starting dynamic subtest: pipe-D-HDMI-A-3
[270.615957] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[270.616890] Subtest overflow-vrefresh: SUCCESS (0.060s)
[270.765506] [054/133] (757s left) kms_vblank (wait-busy-hang)
[272.287449] Starting subtest: wait-busy-hang
[272.288364] Starting dynamic subtest: pipe-A-HDMI-A-3
[298.528337] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.238s)
[298.540189] Starting dynamic subtest: pipe-D-HDMI-A-3
[323.532441] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.999s)
[323.533389] Subtest wait-busy-hang: SUCCESS (51.242s)
[323.720717] [055/133] (704s left) gem_exec_schedule (submit-golden-slice)
[323.813434] Starting subtest: submit-golden-slice
[323.814435] Starting dynamic subtest: rcs0
[323.890786] Dynamic subtest rcs0: SUCCESS (0.077s)
[323.901415] Starting dynamic subtest: bcs0
[323.938483] Dynamic subtest bcs0: SUCCESS (0.047s)
[323.949031] Starting dynamic subtest: vcs0
[323.990558] Dynamic subtest vcs0: SUCCESS (0.052s)
[324.001106] Starting dynamic subtest: vcs1
[324.042115] Dynamic subtest vcs1: SUCCESS (0.051s)
[324.052954] Starting dynamic subtest: vecs0
[324.096080] Dynamic subtest vecs0: SUCCESS (0.054s)
[324.106987] Starting dynamic subtest: vecs1
[324.145931] Dynamic subtest vecs1: SUCCESS (0.049s)
[324.156708] Starting dynamic subtest: ccs0
[324.195859] Dynamic subtest ccs0: SUCCESS (0.049s)
[324.196749] Subtest submit-golden-slice: SUCCESS (0.383s)
[324.656788] [056/133] (704s left) gem_mmap_wc (bad-offset)
[324.737916] Subtest bad-offset: SKIP (0.000s)
[324.818782] [057/133] (704s left) sysfs_heartbeat_interval (idempotent)
[324.902570] Starting subtest: idempotent
[324.903475] Starting dynamic subtest: vecs0
[324.904376] Dynamic subtest vecs0: SUCCESS (0.001s)
[324.915164] Starting dynamic subtest: ccs0
[324.916366] Dynamic subtest ccs0: SUCCESS (0.001s)
[324.927156] Starting dynamic subtest: vcs0
[324.928372] Dynamic subtest vcs0: SUCCESS (0.001s)
[324.938577] Starting dynamic subtest: bcs0
[324.939784] Dynamic subtest bcs0: SUCCESS (0.001s)
[324.950204] Starting dynamic subtest: vecs1
[324.951432] Dynamic subtest vecs1: SUCCESS (0.001s)
[324.962530] Starting dynamic subtest: rcs0
[324.963635] Dynamic subtest rcs0: SUCCESS (0.001s)
[324.973479] Starting dynamic subtest: vcs1
[324.974622] Dynamic subtest vcs1: SUCCESS (0.001s)
[324.975749] Subtest idempotent: SUCCESS (0.010s)
[325.021713] [058/133] (703s left) gem_compute (compute-square)
[325.097076] Starting subtest: compute-square
[325.140238] Subtest compute-square: SUCCESS (0.043s)
[325.316730] [059/133] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[326.832121] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[326.833975] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[326.954767] [060/133] (702s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[327.056392] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[327.057457] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[327.200433] [061/133] (701s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[328.711174] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[328.712129] Starting dynamic subtest: pipe-A-HDMI-A-3
[328.720788] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[328.731450] Starting dynamic subtest: pipe-B-HDMI-A-3
[328.740008] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[328.750371] Starting dynamic subtest: pipe-C-HDMI-A-3
[328.758855] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[328.769152] Starting dynamic subtest: pipe-D-HDMI-A-3
[328.778904] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[328.780672] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[328.979958] [062/133] (700s left) kms_prime (basic-modeset-hybrid)
[330.496259] Subtest basic-modeset-hybrid: SKIP (0.000s)
[330.744817] [063/133] (698s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[330.832291] Starting subtest: y-tiled-ccs-to-x-tiled
[330.834376] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[331.053591] [064/133] (698s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[331.139631] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[331.141543] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[331.348527] [065/133] (698s left) kms_flip (basic-flip-vs-wf_vblank)
[332.862420] Starting subtest: basic-flip-vs-wf_vblank
[332.866818] Starting dynamic subtest: A-HDMI-A3
[334.076070] Dynamic subtest A-HDMI-A3: SUCCESS (1.209s)
[334.087935] Starting dynamic subtest: B-HDMI-A3
[335.044163] Dynamic subtest B-HDMI-A3: SUCCESS (0.967s)
[335.055256] Starting dynamic subtest: C-HDMI-A3
[336.010956] Dynamic subtest C-HDMI-A3: SUCCESS (0.966s)
[336.021740] Starting dynamic subtest: D-HDMI-A3
[337.145636] Dynamic subtest D-HDMI-A3: SUCCESS (1.134s)
[337.146550] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.285s)
[337.352709] [066/133] (692s left) vgem_basic (second-client)
[337.403658] Starting subtest: second-client
[337.437901] Subtest second-client: SUCCESS (0.033s)
[337.555617] [067/133] (692s left) gem_ctx_persistence (userptr)
[337.643289] Starting subtest: userptr
[337.862606] Subtest userptr: SUCCESS (0.219s)
[338.019861] [068/133] (691s left) syncobj_timeline (multi-wait-available-submitted)
[338.100029] Starting subtest: multi-wait-available-submitted
[338.100987] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[338.269910] [069/133] (691s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[339.780515] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[339.781420] Starting dynamic subtest: pipe-A
[339.869546] Dynamic subtest pipe-A: SUCCESS (0.090s)
[339.882694] Starting dynamic subtest: pipe-B
[340.013377] Dynamic subtest pipe-B: SUCCESS (0.143s)
[340.028323] Starting dynamic subtest: pipe-C
[340.156286] Dynamic subtest pipe-C: SUCCESS (0.142s)
[340.167275] Starting dynamic subtest: pipe-D
[340.279918] Dynamic subtest pipe-D: SUCCESS (0.123s)
[340.280851] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.501s)
[340.502206] [070/133] (689s left) kms_plane (pixel-format-linear-modifier)
[342.017607] Starting subtest: pixel-format-linear-modifier
[342.053235] Starting dynamic subtest: pipe-A-plane-0
[348.019536] Dynamic subtest pipe-A-plane-0: SUCCESS (5.966s)
[348.029712] Starting dynamic subtest: pipe-A-plane-3
[350.803227] Dynamic subtest pipe-A-plane-3: SUCCESS (2.783s)
[350.814210] Starting dynamic subtest: pipe-A-plane-5
[351.020019] Dynamic subtest pipe-A-plane-5: SUCCESS (0.216s)
[351.201153] Starting dynamic subtest: pipe-B-plane-0
[357.125333] Dynamic subtest pipe-B-plane-0: SUCCESS (5.933s)
[357.136809] Starting dynamic subtest: pipe-B-plane-3
[360.058821] Dynamic subtest pipe-B-plane-3: SUCCESS (2.932s)
[360.087226] Starting dynamic subtest: pipe-B-plane-5
[360.325631] Dynamic subtest pipe-B-plane-5: SUCCESS (0.265s)
[360.416375] Subtest pixel-format-linear-modifier: SUCCESS (18.399s)
[360.633711] [071/133] (669s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[362.152211] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[362.219881] [072/133] (667s left) kms_flip (wf_vblank-ts-check)
[363.732228] Starting subtest: wf_vblank-ts-check
[363.737659] Starting dynamic subtest: A-HDMI-A3
[371.780341] Dynamic subtest A-HDMI-A3: SUCCESS (8.042s)
[371.793337] Starting dynamic subtest: B-HDMI-A3
[379.748502] Dynamic subtest B-HDMI-A3: SUCCESS (7.967s)
[379.759400] Starting dynamic subtest: C-HDMI-A3
[387.717384] Dynamic subtest C-HDMI-A3: SUCCESS (7.968s)
[387.728274] Starting dynamic subtest: D-HDMI-A3
[395.684282] Dynamic subtest D-HDMI-A3: SUCCESS (7.966s)
[395.685217] Subtest wf_vblank-ts-check: SUCCESS (31.952s)
[395.892855] [073/133] (634s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[397.452371] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[397.559335] [074/133] (632s left) gem_fence_thrash (bo-write-verify-none)
[397.616721] Starting subtest: bo-write-verify-none
[397.646069] Subtest bo-write-verify-none: SKIP (0.028s)
[397.719163] [075/133] (632s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[399.242390] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[400.523991] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.281s)
[400.727742] [076/133] (629s left) kms_cursor_crc (cursor-offscreen-512x512)
[402.530281] Starting subtest: cursor-offscreen-512x512
[402.532147] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[402.783646] [077/133] (627s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[404.311371] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[404.313174] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[404.448490] [078/133] (625s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[405.990682] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[405.991553] Starting dynamic subtest: pipe-A
[406.589378] Dynamic subtest pipe-A: SUCCESS (0.599s)
[406.604897] Starting dynamic subtest: pipe-B
[407.164872] Dynamic subtest pipe-B: SUCCESS (0.574s)
[407.188838] Starting dynamic subtest: pipe-C
[407.740673] Dynamic subtest pipe-C: SUCCESS (0.574s)
[407.764226] Starting dynamic subtest: pipe-D
[408.315338] Dynamic subtest pipe-D: SUCCESS (0.573s)
[408.316522] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.326s)
[408.526474] [079/133] (621s left) i915_drm_fdinfo (memory-info-resident)
[408.598264] Starting subtest: memory-info-resident
[408.599177] Starting dynamic subtest: lmem0
[412.441435] Dynamic subtest lmem0: SUCCESS (3.843s)
[412.455347] Starting dynamic subtest: smem0
[416.958870] Dynamic subtest smem0: SUCCESS (4.492s)
[416.975055] Subtest memory-info-resident: SUCCESS (8.340s)
[417.086728] [080/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[418.639894] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[418.641509] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[418.790969] [081/133] (611s left) kms_psr (psr-sprite-blt)
[420.331325] Subtest psr-sprite-blt: SKIP (0.000s)
[420.384359] [082/133] (610s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[421.898069] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[422.132454] Starting dynamic subtest: pipe-A-HDMI-A-3-4
[424.375979] Dynamic subtest pipe-A-HDMI-A-3-4: SUCCESS (2.244s)
[424.386662] Starting dynamic subtest: pipe-A-HDMI-A-3-x
[426.557976] Dynamic subtest pipe-A-HDMI-A-3-x: SUCCESS (2.181s)
[426.729382] Starting dynamic subtest: pipe-B-HDMI-A-3-4
[428.926421] Dynamic subtest pipe-B-HDMI-A-3-4: SUCCESS (2.207s)
[428.937386] Starting dynamic subtest: pipe-B-HDMI-A-3-x
[431.092224] Dynamic subtest pipe-B-HDMI-A-3-x: SUCCESS (2.165s)
[431.239397] Starting dynamic subtest: pipe-C-HDMI-A-3-4
[433.433144] Dynamic subtest pipe-C-HDMI-A-3-4: SUCCESS (2.203s)
[433.443972] Starting dynamic subtest: pipe-C-HDMI-A-3-x
[435.598979] Dynamic subtest pipe-C-HDMI-A-3-x: SUCCESS (2.165s)
[435.762248] Starting dynamic subtest: pipe-D-HDMI-A-3-4
[437.957899] Dynamic subtest pipe-D-HDMI-A-3-4: SUCCESS (2.205s)
[437.968684] Starting dynamic subtest: pipe-D-HDMI-A-3-x
[440.123353] Dynamic subtest pipe-D-HDMI-A-3-x: SUCCESS (2.164s)
[440.124395] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (18.227s)
[440.475316] [083/133] (590s left) gem_softpin (zero)
[440.563933] Starting subtest: zero
[440.568712] Subtest zero: SUCCESS (0.005s)
[440.749746] [084/133] (590s left) kms_plane_multiple (2x-tiling-y)
[442.266193] Starting subtest: 2x-tiling-y
[442.268064] Subtest 2x-tiling-y: SKIP (0.000s)
[442.379770] [085/133] (588s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[443.913040] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[443.913940] Starting dynamic subtest: pipe-A-HDMI-A-3
[443.923141] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[443.933582] Starting dynamic subtest: pipe-B-HDMI-A-3
[443.943077] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[443.953372] Starting dynamic subtest: pipe-C-HDMI-A-3
[443.962621] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[443.973147] Starting dynamic subtest: pipe-D-HDMI-A-3
[443.983926] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[443.985689] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[444.186165] [086/133] (586s left) gem_mmap_gtt (basic-read-write)
[444.269271] Subtest basic-read-write: SKIP (0.000s)
[444.343867] [087/133] (586s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[444.423371] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[444.424307] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[444.564097] [088/133] (586s left) core_getstats (basic)
[444.643274] Starting subtest: basic
[444.644212] Subtest basic: SUCCESS (0.000s)
[444.791865] [089/133] (586s left) kms_cursor_edge_walk (64x64-left-edge)
[446.301496] Starting subtest: 64x64-left-edge
[446.304158] Starting dynamic subtest: pipe-A-HDMI-A-3
[449.625051] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.321s)
[449.636621] Starting dynamic subtest: pipe-D-HDMI-A-3
[452.858877] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.232s)
[452.859774] Subtest 64x64-left-edge: SUCCESS (6.557s)
[453.035935] [090/133] (578s left) kms_display_modes (extended-mode-basic)
[454.546235] Starting subtest: extended-mode-basic
[454.548531] Subtest extended-mode-basic: SKIP (0.000s)
[454.609304] [091/133] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[456.128161] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[456.129995] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[456.278840] [092/133] (575s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[457.830658] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[458.946449] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.115s)
[459.159385] [093/133] (572s left) gem_tiled_fence_blits (basic)
[459.245172] Subtest basic: SKIP (0.000s)
[459.324236] [094/133] (572s left) i915_pm_rps (min-max-config-loaded)
[459.416332] Starting subtest: min-max-config-loaded
[459.418370] Subtest min-max-config-loaded: SKIP (0.000s)
[459.558167] [095/133] (572s left) gem_unfence_active_buffers
[459.775033] [096/133] (571s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[461.353351] Starting subtest: dp-mst-type-1-suspend-resume
[461.355126] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[461.566383] [097/133] (570s left) kms_psr (pr-sprite-mmap-cpu)
[463.078506] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[463.140785] [098/133] (568s left) kms_psr (fbc-psr-dpms)
[464.652201] Subtest fbc-psr-dpms: SKIP (0.000s)
[464.707164] [099/133] (567s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[466.226007] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[466.227897] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.384738] [100/133] (565s left) gem_mmap_gtt (hang-user)
[466.491153] Subtest hang-user: SKIP (0.000s)
[466.558170] [101/133] (565s left) syncobj_basic (bad-pad-handle-to-fd)
[466.637541] Starting subtest: bad-pad-handle-to-fd
[466.638430] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[466.771972] [102/133] (565s left) syncobj_wait (invalid-wait-bad-flags)
[466.849314] Starting subtest: invalid-wait-bad-flags
[466.850193] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[466.975938] [103/133] (565s left) syncobj_basic (bad-pad-fd-to-handle)
[467.055320] Starting subtest: bad-pad-fd-to-handle
[467.056264] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[467.231696] [104/133] (564s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[468.748513] Starting subtest: stress-xrgb8888-ytiled
[468.750558] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[468.807478] [105/133] (563s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[470.321170] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[470.539641] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.219s)
[470.792415] [106/133] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[472.309924] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[472.311657] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[472.551380] [107/133] (559s left) gem_exec_schedule (fairslice-all)
[472.650055] Starting subtest: fairslice-all
[474.772541] Subtest fairslice-all: SUCCESS (2.119s)
[475.205324] [108/133] (557s left) gem_exec_flush (basic-wb-pro-default)
[475.287429] Subtest basic-wb-pro-default: SKIP (0.000s)
[475.369104] [109/133] (557s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[476.895233] Starting subtest: yf-tiled-32bpp-rotate-90
[476.897207] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[477.034394] [110/133] (555s left) kms_atomic (plane-immutable-zpos)
[478.580134] Starting subtest: plane-immutable-zpos
[478.581024] Starting dynamic subtest: pipe-A-HDMI-A-3
[479.449428] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.869s)
[479.450439] Subtest plane-immutable-zpos: SUCCESS (0.871s)
[479.633108] [111/133] (553s left) gem_ctx_param (invalid-param-get)
[479.712785] Starting subtest: invalid-param-get
[479.715068] Subtest invalid-param-get: SUCCESS (0.001s)
[479.885354] [112/133] (552s left) kms_feature_discovery (display-3x)
[481.398264] Starting subtest: display-3x
[481.400097] Subtest display-3x: SKIP (0.000s)
[481.492029] [113/133] (551s left) gem_ctx_shared (q-out-order)
[481.600423] Starting subtest: Q-out-order
[481.601409] Starting dynamic subtest: rcs0
[481.877445] Dynamic subtest rcs0: SUCCESS (0.278s)
[481.888298] Starting dynamic subtest: bcs0
[482.065708] Dynamic subtest bcs0: SUCCESS (0.187s)
[482.076881] Starting dynamic subtest: vcs0
[482.257727] Dynamic subtest vcs0: SUCCESS (0.191s)
[482.268977] Starting dynamic subtest: vcs1
[482.448947] Dynamic subtest vcs1: SUCCESS (0.190s)
[482.460135] Starting dynamic subtest: vecs0
[482.640570] Dynamic subtest vecs0: SUCCESS (0.190s)
[482.653183] Starting dynamic subtest: vecs1
[482.837834] Dynamic subtest vecs1: SUCCESS (0.190s)
[482.852422] Starting dynamic subtest: ccs0
[483.057990] Dynamic subtest ccs0: SUCCESS (0.219s)
[483.059201] Subtest Q-out-order: SUCCESS (1.453s)
[483.352360] [114/133] (549s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[484.879209] Starting subtest: extended-modeset-hang-oldfb-with-reset
[484.881366] Starting dynamic subtest: pipe-A
[495.380233] Dynamic subtest pipe-A: SUCCESS (10.499s)
[495.397385] Starting dynamic subtest: pipe-D
[506.095318] Dynamic subtest pipe-D: SUCCESS (10.709s)
[506.096296] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.216s)
[506.299267] [115/133] (526s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[507.823137] Starting subtest: fbcpsr-rgb565-draw-blt
[507.824927] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[507.960897] [116/133] (525s left) syncobj_wait (wait-for-submit-delayed-submit)
[508.062574] Starting subtest: wait-for-submit-delayed-submit
[508.164554] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[508.324293] [117/133] (524s left) dmabuf_sync_file (import-multiple-read-write)
[508.385723] Starting subtest: import-multiple-read-write
[508.389831] Subtest import-multiple-read-write: SUCCESS (0.004s)
[508.478152] [118/133] (524s left) kms_pipe_crc_basic (bad-source)
[509.989090] Starting subtest: bad-source
[509.990041] Subtest bad-source: SUCCESS (0.000s)
[510.096190] [119/133] (523s left) gem_ccs (ctrl-surf-copy)
[510.204267] Starting subtest: ctrl-surf-copy
[510.206478] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[510.259611] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.054s)
[510.270654] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[510.471900] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.211s)
[510.483972] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[510.499241] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[510.511216] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[510.718400] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.218s)
[510.730648] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[510.745985] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[510.758090] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[510.964691] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.217s)
[510.976911] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[510.992182] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.026s)
[511.004178] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[511.208893] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.215s)
[511.209852] Subtest ctrl-surf-copy: SUCCESS (1.005s)
[511.399286] [120/133] (521s left) kms_color (degamma)
[512.914203] Starting subtest: degamma
[512.915158] Starting dynamic subtest: pipe-A-HDMI-A-3
[513.592464] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.678s)
[513.604260] Starting dynamic subtest: pipe-B-HDMI-A-3
[514.085691] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.492s)
[514.096514] Starting dynamic subtest: pipe-C-HDMI-A-3
[514.583987] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.497s)
[514.594838] Starting dynamic subtest: pipe-D-HDMI-A-3
[515.052852] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.468s)
[515.053802] Subtest degamma: SUCCESS (2.140s)
[515.226124] [121/133] (518s left) gem_softpin (evict-snoop)
[515.313666] Starting subtest: evict-snoop
[515.315433] Subtest evict-snoop: SKIP (0.000s)
[515.466889] [122/133] (518s left) gem_exec_balancer (nohangcheck)
[515.865142] Starting subtest: nohangcheck
[517.501038] Subtest nohangcheck: SUCCESS (1.635s)
[517.640922] [123/133] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[519.161053] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[519.162896] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[519.326493] [124/133] (514s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[520.862092] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[520.863880] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[520.954410] [125/133] (512s left) gem_exec_whisper (basic-queues-all)
[521.055534] Starting subtest: basic-queues-all
[542.839751] Subtest basic-queues-all: SUCCESS (21.783s)
[543.082999] [126/133] (490s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[543.437146] Starting subtest: parallel-dmabuf-import-out-fence
[545.790806] Subtest parallel-dmabuf-import-out-fence: SUCCESS (2.354s)
[545.962779] [127/133] (487s left) kms_pm_rpm (cursor-dpms)
[550.023931] Starting subtest: cursor-dpms
[550.026410] Subtest cursor-dpms: SKIP (0.000s)
[550.991895] [128/133] (482s left) kms_psr (fbc-psr2-basic)
[552.507468] Subtest fbc-psr2-basic: SKIP (0.000s)
[552.569357] [129/133] (481s left) gem_userptr_blits (coherency-unsync)
[552.656167] Subtest coherency-unsync: SKIP (0.000s)
[552.834947] [130/133] (481s left) kms_psr (psr2-cursor-mmap-gtt)
[554.347444] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[554.402745] [131/133] (479s left) i915_selftest (live)
[555.382841] Starting subtest: live
[555.383870] Starting dynamic subtest: sanitycheck
[556.984913] Dynamic subtest sanitycheck: SUCCESS (1.602s)
[556.993466] Starting dynamic subtest: uncore
[558.547873] Dynamic subtest uncore: SUCCESS (1.562s)
[558.556583] Starting dynamic subtest: workarounds
[574.841157] Dynamic subtest workarounds: FAIL (16.091s)
[574.848446] Starting dynamic subtest: gt_engines
[577.008972] Dynamic subtest gt_engines: SUCCESS (2.368s)
[577.017252] Starting dynamic subtest: gt_timelines
[597.850698] Dynamic subtest gt_timelines: SUCCESS (20.840s)
[597.859376] Starting dynamic subtest: gt_contexts
[599.476104] Dynamic subtest gt_contexts: SUCCESS (1.624s)
[599.484534] Starting dynamic subtest: gt_lrc
[605.808094] Dynamic subtest gt_lrc: SUCCESS (6.331s)
[605.817317] Starting dynamic subtest: gt_mocs
[608.630144] Dynamic subtest gt_mocs: SUCCESS (2.821s)
[608.638411] Starting dynamic subtest: gt_pm
[612.805208] Dynamic subtest gt_pm: SUCCESS (4.174s)
[612.814285] Starting dynamic subtest: gt_heartbeat
[614.394220] Dynamic subtest gt_heartbeat: SUCCESS (1.588s)
[614.403274] Starting dynamic subtest: gt_tlb
[626.933890] Dynamic subtest gt_tlb: SUCCESS (12.539s)
[626.942241] Starting dynamic subtest: requests
[640.374849] Dynamic subtest requests: SUCCESS (13.440s)
[640.383180] Starting dynamic subtest: migrate
[645.150108] Dynamic subtest migrate: SUCCESS (4.774s)
[645.158393] Starting dynamic subtest: active
[646.706877] Dynamic subtest active: SUCCESS (1.556s)
[646.715346] Starting dynamic subtest: objects
[648.935085] Dynamic subtest objects: SUCCESS (2.227s)
[648.943680] Starting dynamic subtest: mman
[655.746985] Dynamic subtest mman: SUCCESS (6.811s)
[655.755530] Starting dynamic subtest: dmabuf
[657.357882] Dynamic subtest dmabuf: SUCCESS (1.610s)
[657.366464] Starting dynamic subtest: vma
[658.928909] Dynamic subtest vma: SUCCESS (1.570s)
[658.937347] Starting dynamic subtest: coherency
[663.281831] Dynamic subtest coherency: SUCCESS (4.344s)
[663.290432] Starting dynamic subtest: gtt
[673.071866] Dynamic subtest gtt: SUCCESS (9.797s)
[673.080396] Starting dynamic subtest: gem
[674.790066] Dynamic subtest gem: SUCCESS (1.717s)
[674.798553] Starting dynamic subtest: evict
[677.772052] Dynamic subtest evict: SUCCESS (2.981s)
[677.780745] Starting dynamic subtest: hugepages
[696.319909] Dynamic subtest hugepages: SUCCESS (18.547s)
[696.328401] Starting dynamic subtest: gem_contexts
[729.116038] Dynamic subtest gem_contexts: SUCCESS (32.795s)
[729.124691] Starting dynamic subtest: client
[730.712939] Dynamic subtest client: SUCCESS (1.596s)
[730.721500] Starting dynamic subtest: gem_migrate
[734.035979] Dynamic subtest gem_migrate: SUCCESS (3.322s)
[734.044731] Starting dynamic subtest: reset
[735.672980] Dynamic subtest reset: SUCCESS (1.636s)
[735.681743] Starting dynamic subtest: memory_region
[738.832890] Dynamic subtest memory_region: SUCCESS (3.159s)
[738.842257] Starting dynamic subtest: hangcheck
[767.918009] Dynamic subtest hangcheck: SUCCESS (29.084s)
[767.926758] Starting dynamic subtest: execlists
[769.495183] Dynamic subtest execlists: SUCCESS (1.576s)
[769.503752] Starting dynamic subtest: ring_submission
[771.063978] Dynamic subtest ring_submission: SUCCESS (1.568s)
[771.072537] Starting dynamic subtest: perf
[772.716926] Dynamic subtest perf: SUCCESS (1.652s)
[772.725715] Starting dynamic subtest: slpc
[779.912731] Dynamic subtest slpc: SUCCESS (7.195s)
[779.921546] Starting dynamic subtest: guc
[782.793067] Dynamic subtest guc: SUCCESS (2.879s)
[782.801438] Starting dynamic subtest: guc_multi_lrc
[784.366876] Dynamic subtest guc_multi_lrc: SUCCESS (1.573s)
[784.375572] Starting dynamic subtest: guc_hang
[786.693961] Dynamic subtest guc_hang: SUCCESS (2.326s)
[786.702554] Starting dynamic subtest: late_gt_pm
[788.319932] Dynamic subtest late_gt_pm: SUCCESS (1.625s)
[788.320932] Subtest live: FAIL (232.936s)
[788.350728] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[788.351700] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[788.353570] [132/133] (245s left) gem_userptr_blits (unsync-unmap)
[791.878334] Subtest unsync-unmap: SKIP (0.000s)
[792.018620] [FACT gem_userptr_blits (unsync-unmap)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[792.021712] [FACT gem_userptr_blits (unsync-unmap)] new: kernel.kmod_is_loaded.i915: true
[792.024694] [133/133] (242s left) gem_linear_blits (normal)
[792.965101] Starting subtest: normal
[800.472590] Subtest normal: SUCCESS (7.508s)
[800.817322] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: gem_sync
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: gem_exec_parallel
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: gen7_exec_parse
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: i915_fb_tiling
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_ctx_isolation
results: parsing output: 52/ for test: kms_invalid_mode
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: sysfs_heartbeat_interval
results: parsing output: 57/ for test: gem_compute
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: gem_fence_thrash
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: kms_plane_multiple
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: core_getstats
results: parsing output: 88/ for test: kms_cursor_edge_walk
results: parsing output: 89/ for test: kms_display_modes
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_tiled_fence_blits
results: parsing output: 93/ for test: i915_pm_rps
results: parsing output: 94/ for test: gem_unfence_active_buffers
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_pipe_stress
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: dmabuf_sync_file
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: gem_ccs
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: i915_selftest
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: gem_linear_blits
Done.