[67.712921] Initializing watchdogs
[67.713038]   /dev/watchdog0
[67.745521] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.760803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.765737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.769338] [001/156] (960s left) i915_selftest (live)
[68.672077] Starting subtest: live
[68.673837] Starting dynamic subtest: sanitycheck
[70.086264] Dynamic subtest sanitycheck: SUCCESS (1.411s)
[70.094863] Starting dynamic subtest: uncore
[72.436190] Dynamic subtest uncore: SUCCESS (2.346s)
[72.444706] Starting dynamic subtest: workarounds
[75.819436] Dynamic subtest workarounds: SUCCESS (3.379s)
[75.828252] Starting dynamic subtest: gt_engines
[77.767271] Dynamic subtest gt_engines: SUCCESS (1.946s)
[77.776180] Starting dynamic subtest: gt_timelines
[144.323626] Dynamic subtest gt_timelines: SUCCESS (66.545s)
[144.332888] Starting dynamic subtest: gt_contexts
[145.718394] Dynamic subtest gt_contexts: SUCCESS (1.395s)
[145.727329] Starting dynamic subtest: gt_lrc
[151.648432] Dynamic subtest gt_lrc: SUCCESS (5.930s)
[151.657821] Starting dynamic subtest: gt_mocs
[153.962431] Dynamic subtest gt_mocs: SUCCESS (2.314s)
[153.971357] Starting dynamic subtest: gt_pm
[157.926600] Dynamic subtest gt_pm: SUCCESS (3.964s)
[157.935433] Starting dynamic subtest: gt_heartbeat
[159.265453] Dynamic subtest gt_heartbeat: SUCCESS (1.339s)
[159.274246] Starting dynamic subtest: gt_tlb
[172.976930] Dynamic subtest gt_tlb: SUCCESS (13.712s)
[172.996380] Starting dynamic subtest: requests
[183.701623] Dynamic subtest requests: SUCCESS (10.725s)
[183.710564] Starting dynamic subtest: migrate
[188.193399] Dynamic subtest migrate: SUCCESS (4.491s)
[188.202243] Starting dynamic subtest: active
[189.573643] Dynamic subtest active: SUCCESS (1.380s)
[189.582807] Starting dynamic subtest: objects
[191.813441] Dynamic subtest objects: SUCCESS (2.240s)
[191.822528] Starting dynamic subtest: mman
[195.305296] Dynamic subtest mman: SUCCESS (3.492s)
[195.314326] Starting dynamic subtest: dmabuf
[196.768198] Dynamic subtest dmabuf: SUCCESS (1.466s)
[196.777253] Starting dynamic subtest: vma
[198.153582] Dynamic subtest vma: SUCCESS (1.382s)
[198.163115] Starting dynamic subtest: coherency
[208.181594] Dynamic subtest coherency: SUCCESS (10.027s)
[208.190896] Starting dynamic subtest: gtt
[217.215968] Dynamic subtest gtt: SUCCESS (9.034s)
[217.225311] Starting dynamic subtest: gem
[218.746671] Dynamic subtest gem: SUCCESS (1.530s)
[218.755691] Starting dynamic subtest: evict
[230.229705] Dynamic subtest evict: SUCCESS (11.482s)
[230.239024] Starting dynamic subtest: hugepages
[247.479976] Dynamic subtest hugepages: SUCCESS (17.252s)
[247.489105] Starting dynamic subtest: gem_contexts
[275.301262] Dynamic subtest gem_contexts: SUCCESS (27.817s)
[275.310412] Starting dynamic subtest: client
[276.730762] Dynamic subtest client: SUCCESS (1.429s)
[276.739793] Starting dynamic subtest: gem_migrate
[279.362597] Dynamic subtest gem_migrate: SUCCESS (2.631s)
[279.371947] Starting dynamic subtest: reset
[280.743378] Dynamic subtest reset: SUCCESS (1.380s)
[280.752831] Starting dynamic subtest: memory_region
[283.741437] Dynamic subtest memory_region: SUCCESS (2.998s)
[283.750773] Starting dynamic subtest: hangcheck
[311.621668] Dynamic subtest hangcheck: SUCCESS (27.880s)
[311.630761] Starting dynamic subtest: execlists
[312.967631] Dynamic subtest execlists: SUCCESS (1.345s)
[312.977056] Starting dynamic subtest: ring_submission
[314.352148] Dynamic subtest ring_submission: SUCCESS (1.383s)
[314.360965] Starting dynamic subtest: perf
[315.856406] Dynamic subtest perf: SUCCESS (1.504s)
[315.865747] Starting dynamic subtest: slpc
[321.692376] Dynamic subtest slpc: SUCCESS (5.835s)
[321.701415] Starting dynamic subtest: guc
[325.129657] Dynamic subtest guc: SUCCESS (3.436s)
[325.139295] Starting dynamic subtest: guc_multi_lrc
[326.512587] Dynamic subtest guc_multi_lrc: SUCCESS (1.382s)
[326.522164] Starting dynamic subtest: guc_hang
[328.665483] Dynamic subtest guc_hang: SUCCESS (2.152s)
[328.674403] Starting dynamic subtest: late_gt_pm
[330.063170] Dynamic subtest late_gt_pm: SUCCESS (1.397s)
[330.064669] Subtest live: SUCCESS (261.371s)
[330.103574] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[330.106695] [002/156] (698s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[334.849205] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[336.158258] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.308s)
[336.513588] [FACT kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true
[336.517887] [003/156] (691s left) kms_content_protection (dp-mst-type-0)
[338.070793] Starting subtest: dp-mst-type-0
[338.074722] Subtest dp-mst-type-0: SKIP (0.000s)
[338.289531] [004/156] (690s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[338.337283] Starting subtest: invalid-multi-wait-unsubmitted
[338.338994] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[338.487789] [005/156] (690s left) gem_mmap_gtt (basic-read-write-distinct)
[338.539926] Subtest basic-read-write-distinct: SKIP (0.000s)
[338.614044] [006/156] (690s left) kms_prime (basic-modeset-hybrid)
[340.118412] Subtest basic-modeset-hybrid: SKIP (0.000s)
[340.366722] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[340.373383] [007/156] (688s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[341.874334] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[341.877920] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[342.029945] [008/156] (686s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[343.566467] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[343.699084] [009/156] (685s left) tools_test (tools_test)
[343.759038] Starting subtest: tools_test
[343.859650] Subtest tools_test: SUCCESS (0.114s)
[344.016767] [010/156] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[345.518996] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[345.522951] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[345.712953] [011/156] (683s left) kms_dsc (dsc-fractional-bpp)
[347.202541] Starting subtest: dsc-fractional-bpp
[347.212645] Subtest dsc-fractional-bpp: SKIP (0.000s)
[347.358900] [012/156] (681s left) gem_exec_fence (parallel)
[347.585848] Starting subtest: parallel
[347.587885] Starting dynamic subtest: rcs0
[349.741813] Dynamic subtest rcs0: SUCCESS (2.155s)
[349.753176] Starting dynamic subtest: bcs0
[351.894121] Dynamic subtest bcs0: SUCCESS (2.151s)
[351.904985] Starting dynamic subtest: vcs0
[354.050735] Dynamic subtest vcs0: SUCCESS (2.155s)
[354.062121] Starting dynamic subtest: vcs1
[356.206405] Dynamic subtest vcs1: SUCCESS (2.155s)
[356.217373] Starting dynamic subtest: vecs0
[358.356172] Dynamic subtest vecs0: SUCCESS (2.149s)
[358.357770] Subtest parallel: SUCCESS (10.772s)
[359.143515] [013/156] (670s left) gem_wait (write-wait)
[359.218785] Starting subtest: write-wait
[359.220393] Starting dynamic subtest: all-engines
[360.309779] Dynamic subtest all-engines: SUCCESS (1.090s)
[360.322651] Starting dynamic subtest: rcs0
[361.366620] Dynamic subtest rcs0: SUCCESS (1.055s)
[361.379703] Starting dynamic subtest: bcs0
[362.425610] Dynamic subtest bcs0: SUCCESS (1.057s)
[362.438947] Starting dynamic subtest: vcs0
[363.487250] Dynamic subtest vcs0: SUCCESS (1.059s)
[363.507942] Starting dynamic subtest: vcs1
[364.555517] Dynamic subtest vcs1: SUCCESS (1.062s)
[364.576884] Starting dynamic subtest: vecs0
[365.624388] Dynamic subtest vecs0: SUCCESS (1.063s)
[365.633117] Subtest write-wait: SUCCESS (6.408s)
[365.904360] [014/156] (663s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[365.951959] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[366.053537] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[366.200362] [015/156] (663s left) gem_mmap_gtt (basic-read-write)
[366.261399] Subtest basic-read-write: SKIP (0.000s)
[366.336855] [016/156] (663s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[367.827987] Starting subtest: plane-lut1d-ctm3x4-lut1d
[368.021409] Starting dynamic subtest: pipe-A-plane-0
[368.286423] Dynamic subtest pipe-A-plane-0: SUCCESS (0.265s)
[368.325727] Starting dynamic subtest: pipe-A-plane-1
[368.484864] Dynamic subtest pipe-A-plane-1: SUCCESS (0.193s)
[368.508145] Starting dynamic subtest: pipe-A-plane-2
[368.670049] Dynamic subtest pipe-A-plane-2: SUCCESS (0.182s)
[368.990532] Starting dynamic subtest: pipe-B-plane-0
[369.157103] Dynamic subtest pipe-B-plane-0: SUCCESS (0.197s)
[369.192790] Starting dynamic subtest: pipe-B-plane-1
[369.358274] Dynamic subtest pipe-B-plane-1: SUCCESS (0.194s)
[369.393334] Starting dynamic subtest: pipe-B-plane-2
[369.559158] Dynamic subtest pipe-B-plane-2: SUCCESS (0.194s)
[369.880329] Starting dynamic subtest: pipe-C-plane-0
[370.034821] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[370.047582] Starting dynamic subtest: pipe-C-plane-1
[370.220230] Dynamic subtest pipe-C-plane-1: SUCCESS (0.183s)
[370.241234] Starting dynamic subtest: pipe-C-plane-2
[370.420260] Dynamic subtest pipe-C-plane-2: SUCCESS (0.194s)
[370.743973] Starting dynamic subtest: pipe-D-plane-0
[370.919349] Dynamic subtest pipe-D-plane-0: SUCCESS (0.197s)
[370.956439] Starting dynamic subtest: pipe-D-plane-1
[371.135900] Dynamic subtest pipe-D-plane-1: SUCCESS (0.210s)
[371.151272] Starting dynamic subtest: pipe-D-plane-2
[371.319437] Dynamic subtest pipe-D-plane-2: SUCCESS (0.178s)
[371.376841] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (3.549s)
[371.570062] [017/156] (658s left) gem_exec_schedule (preemptive-hang)
[371.748159] Starting subtest: preemptive-hang
[371.749774] Starting dynamic subtest: rcs0
[381.050881] Dynamic subtest rcs0: SUCCESS (9.303s)
[381.062228] Starting dynamic subtest: bcs0
[390.068211] Dynamic subtest bcs0: SUCCESS (9.017s)
[390.080201] Starting dynamic subtest: vcs0
[399.101394] Dynamic subtest vcs0: SUCCESS (9.032s)
[399.112935] Starting dynamic subtest: vcs1
[408.060274] Dynamic subtest vcs1: SUCCESS (8.957s)
[408.071722] Starting dynamic subtest: vecs0
[417.078642] Dynamic subtest vecs0: SUCCESS (9.017s)
[417.080101] Subtest preemptive-hang: SUCCESS (45.333s)
[417.354030] [018/156] (612s left) vgem_basic (bad-flag)
[417.403150] Starting subtest: bad-flag
[417.404811] Subtest bad-flag: SUCCESS (0.000s)
[417.503792] [019/156] (612s left) kms_cursor_crc (cursor-onscreen-512x170)
[419.285887] Starting subtest: cursor-onscreen-512x170
[419.289032] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[419.517563] [020/156] (610s left) kms_frontbuffer_tracking (hdr-1p-rte)
[421.020627] Starting subtest: hdr-1p-rte
[421.026068] Subtest hdr-1p-rte: SKIP (0.000s)
[421.267456] [021/156] (608s left) kms_psr (psr-sprite-plane-move)
[422.761860] Subtest psr-sprite-plane-move: SKIP (0.000s)
[422.831139] [022/156] (607s left) kms_plane_multiple (tiling-x)
[424.320440] Starting subtest: tiling-x
[424.322127] Starting dynamic subtest: pipe-A-HDMI-A-1
[425.242259] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.920s)
[425.255369] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.116970] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.872s)
[426.130709] Starting dynamic subtest: pipe-C-HDMI-A-1
[426.983612] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.864s)
[426.995224] Starting dynamic subtest: pipe-D-HDMI-A-1
[427.858113] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.872s)
[427.859437] Subtest tiling-x: SUCCESS (3.538s)
[428.070601] [023/156] (602s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[428.125130] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[428.231507] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[428.361282] [024/156] (601s left) gem_ccs (block-multicopy-inplace)
[428.417765] Starting subtest: block-multicopy-inplace
[428.420890] Subtest block-multicopy-inplace: SKIP (0.000s)
[428.528968] [025/156] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[430.027786] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[430.031215] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[430.225361] [026/156] (600s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[431.738244] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[431.741382] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[431.943346] [027/156] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[433.447194] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[433.450284] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[433.641582] [028/156] (597s left) kms_vblank (query-busy-hang)
[435.163260] Starting subtest: query-busy-hang
[435.164768] Starting dynamic subtest: pipe-A-HDMI-A-1
[461.483460] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.318s)
[461.497050] Starting dynamic subtest: pipe-D-HDMI-A-1
[486.488476] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (25.000s)
[486.490082] Subtest query-busy-hang: SUCCESS (51.326s)
[486.662871] [029/156] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[488.164614] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[488.168044] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.361484] [030/156] (542s left) kms_psr (psr2-cursor-blt)
[489.857650] Subtest psr2-cursor-blt: SKIP (0.000s)
[490.033788] [031/156] (541s left) syncobj_wait (single-wait-for-submit-signaled)
[490.081042] Starting subtest: single-wait-for-submit-signaled
[490.082693] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[490.198422] [032/156] (541s left) api_intel_bb (bb-with-allocator)
[490.247198] Starting subtest: bb-with-allocator
[490.265088] Subtest bb-with-allocator: SUCCESS (0.020s)
[490.439961] [033/156] (540s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[491.941788] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[491.945163] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[492.140373] [034/156] (539s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[493.634699] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[493.709564] [035/156] (537s left) gem_exec_schedule (u-semaphore-user)
[493.776701] Starting subtest: u-semaphore-user
[493.806314] Subtest u-semaphore-user: SUCCESS (0.032s)
[494.300971] [036/156] (537s left) gem_ctx_param (invalid-ctx-get)
[494.348264] Starting subtest: invalid-ctx-get
[494.349843] Subtest invalid-ctx-get: SUCCESS (0.000s)
[494.470295] [037/156] (537s left) gem_userptr_blits (usage-restrictions)
[494.546743] Starting subtest: usage-restrictions
[494.548341] Subtest usage-restrictions: SUCCESS (0.000s)
[494.732937] [038/156] (537s left) syncobj_wait (single-wait-submitted)
[494.784278] Starting subtest: single-wait-submitted
[494.889092] Subtest single-wait-submitted: SUCCESS (0.102s)
[495.021414] [039/156] (536s left) kms_cursor_legacy (forked-bo)
[496.513240] Starting subtest: forked-bo
[496.515129] Starting dynamic subtest: pipe-A
[501.935210] Dynamic subtest pipe-A: SUCCESS (5.418s)
[501.950293] Starting dynamic subtest: pipe-B
[507.370724] Dynamic subtest pipe-B: SUCCESS (5.433s)
[507.388744] Starting dynamic subtest: pipe-C
[512.817654] Dynamic subtest pipe-C: SUCCESS (5.444s)
[512.838245] Starting dynamic subtest: pipe-D
[518.285962] Dynamic subtest pipe-D: SUCCESS (5.466s)
[518.309859] Starting dynamic subtest: all-pipes
[523.736210] Dynamic subtest all-pipes: SUCCESS (5.447s)
[523.737602] Subtest forked-bo: SUCCESS (27.220s)
[523.875454] [040/156] (508s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[525.368162] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[525.370291] Starting dynamic subtest: pipe-A
[525.535270] Dynamic subtest pipe-A: SUCCESS (0.168s)
[525.567556] Starting dynamic subtest: pipe-B
[525.742217] Dynamic subtest pipe-B: SUCCESS (0.204s)
[525.753434] Starting dynamic subtest: pipe-C
[525.898921] Dynamic subtest pipe-C: SUCCESS (0.155s)
[525.910473] Starting dynamic subtest: pipe-D
[526.055976] Dynamic subtest pipe-D: SUCCESS (0.156s)
[526.057717] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.690s)
[526.274242] [041/156] (505s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[527.785120] Starting subtest: x-tiled-32bpp-rotate-0
[530.197598] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.412s)
[530.448101] [042/156] (501s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[531.956321] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[531.959595] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[532.121789] [043/156] (500s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[533.621340] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[533.624955] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[533.793784] [044/156] (498s left) gem_mmap_offset (clear)
[533.841570] Starting subtest: clear
[533.843703] Starting dynamic subtest: lmem0
[555.665739] Dynamic subtest lmem0: SUCCESS (21.818s)
[555.677552] Starting dynamic subtest: smem0
[579.185645] Dynamic subtest smem0: SUCCESS (23.520s)
[579.190099] Subtest clear: SUCCESS (45.341s)
[579.524935] [045/156] (452s left) kms_atomic (plane-invalid-params)
[581.078621] Starting subtest: plane-invalid-params
[581.080100] Starting dynamic subtest: pipe-A-HDMI-A-1
[581.650790] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.570s)
[581.652414] Subtest plane-invalid-params: SUCCESS (0.573s)
[581.848798] [046/156] (450s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[583.352729] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[583.356227] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[583.554571] [047/156] (449s left) gem_ctx_persistence (saturated-hostile)
[583.615151] Starting subtest: saturated-hostile
[583.616804] Starting dynamic subtest: rcs0
[584.424674] Dynamic subtest rcs0: SUCCESS (0.808s)
[584.440946] Starting dynamic subtest: bcs0
[585.211028] Dynamic subtest bcs0: SUCCESS (0.781s)
[585.223732] Starting dynamic subtest: vcs0
[585.993668] Dynamic subtest vcs0: SUCCESS (0.783s)
[586.009090] Starting dynamic subtest: vcs1
[586.774693] Dynamic subtest vcs1: SUCCESS (0.778s)
[586.790058] Starting dynamic subtest: vecs0
[587.558665] Dynamic subtest vecs0: SUCCESS (0.781s)
[587.560518] Subtest saturated-hostile: SUCCESS (3.945s)
[587.712897] [048/156] (445s left) gem_exec_params (larger-than-life-batch)
[587.775912] Starting subtest: larger-than-life-batch
[598.427036] Subtest larger-than-life-batch: SUCCESS (10.648s)
[598.994691] [049/156] (433s left) gem_exec_await (wide-contexts)
[599.208803] Starting subtest: wide-contexts
[621.265415] Subtest wide-contexts: SUCCESS (22.057s)
[621.514949] [050/156] (411s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[621.630742] Starting subtest: yf-tiled-to-vebox-yf-tiled
[621.632416] Starting dynamic subtest: smem
[621.723188] Dynamic subtest smem: SUCCESS (0.091s)
[621.736045] Starting dynamic subtest: lmem0
[622.485116] Dynamic subtest lmem0: SUCCESS (0.757s)
[622.486990] Subtest yf-tiled-to-vebox-yf-tiled: SUCCESS (0.852s)
[622.762507] [051/156] (410s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[624.272459] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[624.275952] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[624.469196] [052/156] (408s left) gem_exec_params (invalid-bsd-ring)
[624.528418] Starting subtest: invalid-bsd-ring
[624.530322] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[624.704314] [053/156] (408s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[624.763160] Starting subtest: single-wait-for-submit-unsubmitted
[624.870378] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[625.022988] [054/156] (408s left) gem_create (create-valid-nonaligned)
[625.070396] Starting subtest: create-valid-nonaligned
[625.071890] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[625.324892] [055/156] (408s left) kms_flip (2x-flip-vs-fences-interruptible)
[626.821720] Starting subtest: 2x-flip-vs-fences-interruptible
[626.824420] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[626.967614] [056/156] (406s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[628.471275] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[628.475013] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[628.677778] [057/156] (404s left) syncobj_wait (invalid-reset-illegal-handle)
[628.735153] Starting subtest: invalid-reset-illegal-handle
[628.736551] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[628.843087] [058/156] (404s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[630.341242] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[630.344922] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[630.537929] [059/156] (403s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[632.040262] Starting subtest: hdr-rgb101010-draw-mmap-wc
[632.043659] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[632.229238] [060/156] (401s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[633.728893] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[633.732837] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[633.889760] [061/156] (400s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[635.382496] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[635.383950] Starting dynamic subtest: pipe-A-valid-mode
[636.581216] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.197s)
[636.582727] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.200s)
[636.787937] [062/156] (397s left) gem_exec_balancer (sliced)
[636.850821] Starting subtest: sliced
[636.854227] Subtest sliced: SKIP (0.000s)
[637.276765] [063/156] (396s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[638.792373] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[638.795713] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[638.993337] [064/156] (395s left) i915_hangman (engine-engine-error)
[639.060302] Starting subtest: engine-engine-error
[639.061913] Starting dynamic subtest: rcs0
[639.758117] Dynamic subtest rcs0: SUCCESS (0.698s)
[639.773508] Starting dynamic subtest: bcs0
[640.427053] Dynamic subtest bcs0: SUCCESS (0.667s)
[640.441176] Starting dynamic subtest: vcs0
[641.097093] Dynamic subtest vcs0: SUCCESS (0.668s)
[641.111031] Starting dynamic subtest: vcs1
[641.749625] Dynamic subtest vcs1: SUCCESS (0.651s)
[641.762226] Starting dynamic subtest: vecs0
[642.411107] Dynamic subtest vecs0: SUCCESS (0.660s)
[642.412923] Subtest engine-engine-error: SUCCESS (3.353s)
[642.602077] [065/156] (391s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[644.101800] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[644.104658] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[644.302300] [066/156] (390s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[645.827806] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[647.109936] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.282s)
[647.390218] [067/156] (387s left) gem_ctx_isolation (dirty-switch)
[647.449427] Starting subtest: dirty-switch
[647.451054] Starting dynamic subtest: rcs0
[648.257227] Dynamic subtest rcs0: SUCCESS (0.807s)
[648.270512] Starting dynamic subtest: bcs0
[649.112538] Dynamic subtest bcs0: SUCCESS (0.854s)
[649.125271] Starting dynamic subtest: vcs0
[649.945846] Dynamic subtest vcs0: SUCCESS (0.832s)
[649.958791] Starting dynamic subtest: vcs1
[650.787059] Dynamic subtest vcs1: SUCCESS (0.840s)
[650.800268] Starting dynamic subtest: vecs0
[651.605396] Dynamic subtest vecs0: SUCCESS (0.817s)
[651.606946] Subtest dirty-switch: SUCCESS (4.157s)
[651.886924] [068/156] (382s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[653.420718] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[653.424308] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[653.602561] [069/156] (381s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[655.201382] Starting subtest: cursor-rapid-movement-32x10
[655.250803] Subtest cursor-rapid-movement-32x10: SKIP (0.047s)
[655.674736] [070/156] (379s left) gem_spin_batch (user-each)
[655.737195] Starting subtest: user-each
[659.041737] Subtest user-each: SUCCESS (3.304s)
[659.422711] [071/156] (375s left) syncobj_basic (bad-destroy)
[659.472371] Starting subtest: bad-destroy
[659.474118] Subtest bad-destroy: SUCCESS (0.000s)
[659.580563] [072/156] (375s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[661.080623] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[661.084271] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[661.272586] [073/156] (374s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[662.762654] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[662.764200] Starting dynamic subtest: pipe-A-valid-mode
[664.073530] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.308s)
[664.075706] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.311s)
[664.286053] [074/156] (371s left) kms_frontbuffer_tracking (fbc-suspend)
[665.787455] Starting subtest: fbc-suspend
[711.792676] Subtest fbc-suspend: SUCCESS (24.066s)
[714.991125] [075/156] (323s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[716.496126] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[716.502492] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[716.678724] [076/156] (321s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[718.870236] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[719.006254] [077/156] (319s left) kms_chamelium_audio (hdmi-audio)
[720.547531] Subtest hdmi-audio: SKIP (0.000s)
[720.685524] [078/156] (318s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[722.182200] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[722.267966] [079/156] (316s left) kms_psr (fbc-pr-primary-render)
[723.765881] Subtest fbc-pr-primary-render: SKIP (0.000s)
[723.850876] [080/156] (315s left) prime_vgem (basic-gtt)
[723.939441] Starting subtest: basic-gtt
[723.942596] Subtest basic-gtt: SKIP (0.000s)
[724.153074] [081/156] (314s left) gem_mmap_gtt (fault-concurrent-y)
[724.205429] Subtest fault-concurrent-Y: SKIP (0.000s)
[724.281579] [082/156] (314s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[725.782516] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[725.787806] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[726.024782] [083/156] (313s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[726.076462] Starting subtest: multi-wait-all-for-submit-available-submitted
[726.077998] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[726.194020] [084/156] (313s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[727.694995] Starting subtest: fbchdr-tiling-4
[727.700376] Subtest fbchdr-tiling-4: SKIP (0.000s)
[727.956961] [085/156] (311s left) kms_vrr (flip-basic-fastset)
[729.448553] Starting subtest: flip-basic-fastset
[729.454164] Subtest flip-basic-fastset: SKIP (0.000s)
[729.681626] [086/156] (309s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[731.194148] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[731.197087] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[731.383491] [087/156] (308s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[732.887889] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[732.893075] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[733.137112] [088/156] (306s left) gem_lmem_swapping (massive)
[737.627765] Starting subtest: massive
[737.629558] Starting dynamic subtest: lmem0
[752.781449] Dynamic subtest lmem0: SUCCESS (15.153s)
[752.783191] Subtest massive: SUCCESS (15.155s)
[754.794338] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[754.795510] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[754.798359] [089/156] (285s left) kms_psr (pr-basic)
[759.565131] Subtest pr-basic: SKIP (0.000s)
[759.684659] [FACT kms_psr (pr-basic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[759.689273] [FACT kms_psr (pr-basic)] new: kernel.kmod_is_loaded.i915: true
[759.694633] [090/156] (280s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[761.192606] Starting subtest: async-flip-with-page-flip-events-linear
[761.355255] Starting dynamic subtest: pipe-A-HDMI-A-1
[763.607438] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.253s)
[763.783945] Starting dynamic subtest: pipe-B-HDMI-A-1
[765.842470] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.067s)
[766.025616] Starting dynamic subtest: pipe-C-HDMI-A-1
[768.088318] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.071s)
[768.248441] Starting dynamic subtest: pipe-D-HDMI-A-1
[770.313313] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.074s)
[770.315452] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.121s)
[770.715056] [091/156] (269s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[772.209203] Starting subtest: basic-busy-flip-before-cursor-atomic
[772.212898] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[772.361003] [092/156] (267s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[773.872968] Starting subtest: y-tiled-8bpp-rotate-90
[773.972005] Subtest y-tiled-8bpp-rotate-90: SKIP (0.097s)
[774.123596] [093/156] (266s left) kms_invalid_mode (bad-vsync-start)
[775.617447] Starting subtest: bad-vsync-start
[775.618886] Starting dynamic subtest: pipe-A-HDMI-A-1
[775.658117] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.043s)
[775.674307] Starting dynamic subtest: pipe-B-HDMI-A-1
[775.675983] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[775.689503] Starting dynamic subtest: pipe-C-HDMI-A-1
[775.690976] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[775.705388] Starting dynamic subtest: pipe-D-HDMI-A-1
[775.706782] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[775.708191] Subtest bad-vsync-start: SUCCESS (0.055s)
[775.869762] [094/156] (264s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[777.362267] Starting subtest: short-flip-after-cursor-toggle
[778.372047] Subtest short-flip-after-cursor-toggle: SUCCESS (1.010s)
[778.583177] [095/156] (261s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[780.076615] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[780.078065] Starting dynamic subtest: pipe-A-HDMI-A-1
[780.092305] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[780.106054] Starting dynamic subtest: pipe-B-HDMI-A-1
[780.121134] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[780.134957] Starting dynamic subtest: pipe-C-HDMI-A-1
[780.150277] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[780.163866] Starting dynamic subtest: pipe-D-HDMI-A-1
[780.180497] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[780.183819] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.012s)
[780.355937] [096/156] (260s left) gem_exec_alignment (forked)
[780.450716] Starting subtest: forked
[816.262298] Subtest forked: SUCCESS (35.809s)
[816.532849] [097/156] (223s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[818.116019] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[818.119154] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[818.335870] [098/156] (222s left) drm_read (short-buffer-block)
[819.934509] Starting subtest: short-buffer-block
[819.936280] Subtest short-buffer-block: SUCCESS (0.000s)
[820.245917] [099/156] (220s left) perf_pmu (busy-idle)
[820.313753] Starting subtest: busy-idle
[820.315199] Starting dynamic subtest: rcs0
[820.999572] Dynamic subtest rcs0: SUCCESS (0.685s)
[821.019520] Starting dynamic subtest: bcs0
[821.664645] Dynamic subtest bcs0: SUCCESS (0.663s)
[821.684819] Starting dynamic subtest: vcs0
[822.331549] Dynamic subtest vcs0: SUCCESS (0.665s)
[822.351795] Starting dynamic subtest: vcs1
[822.995453] Dynamic subtest vcs1: SUCCESS (0.660s)
[823.021690] Starting dynamic subtest: vecs0
[823.666175] Dynamic subtest vecs0: SUCCESS (0.663s)
[823.675991] Subtest busy-idle: SUCCESS (3.355s)
[823.859697] [100/156] (217s left) syncobj_timeline (wait-for-submit-snapshot)
[823.919835] Starting subtest: wait-for-submit-snapshot
[824.003739] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[824.182378] [101/156] (216s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[825.673727] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[825.676972] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.000s)
[825.818612] [102/156] (215s left) gem_exec_balancer (bonded-semaphore)
[825.894292] Starting subtest: bonded-semaphore
[825.897890] Subtest bonded-semaphore: SKIP (0.000s)
[826.386813] [103/156] (214s left) kms_big_fb (linear-32bpp-rotate-90)
[827.901475] Starting subtest: linear-32bpp-rotate-90
[828.001295] Subtest linear-32bpp-rotate-90: SKIP (0.097s)
[828.154661] [104/156] (213s left) sw_sync (sync_multi_consumer)
[828.203344] Starting subtest: sync_multi_consumer
[828.651178] Subtest sync_multi_consumer: SUCCESS (0.445s)
[828.752739] [105/156] (212s left) perf_pmu (render-node-busy)
[828.806440] Starting subtest: render-node-busy
[828.807770] Starting dynamic subtest: rcs0
[829.408218] Dynamic subtest rcs0: SUCCESS (0.600s)
[829.427917] Starting dynamic subtest: bcs0
[829.975177] Dynamic subtest bcs0: SUCCESS (0.561s)
[829.995017] Starting dynamic subtest: vcs0
[830.539002] Dynamic subtest vcs0: SUCCESS (0.558s)
[830.558837] Starting dynamic subtest: vcs1
[831.101056] Dynamic subtest vcs1: SUCCESS (0.556s)
[831.120725] Starting dynamic subtest: vecs0
[831.664063] Dynamic subtest vecs0: SUCCESS (0.557s)
[831.670274] Subtest render-node-busy: SUCCESS (2.862s)
[831.793199] [106/156] (209s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[833.295111] Starting subtest: stress-xrgb8888-ytiled
[847.328776] Subtest stress-xrgb8888-ytiled: SUCCESS (14.041s)
[847.478290] [107/156] (194s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[849.016035] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[849.021396] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[849.272329] [108/156] (192s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[850.786858] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[850.789945] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[850.971679] [109/156] (190s left) device_reset (unbind-cold-reset-rebind)
[851.078545] Starting subtest: unbind-cold-reset-rebind
[851.081804] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[851.211701] [110/156] (190s left) gem_ctx_exec (basic-close-race)
[851.263646] Starting subtest: basic-close-race
[856.771475] Subtest basic-close-race: SUCCESS (5.502s)
[856.973777] [111/156] (184s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[858.466042] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[858.467823] Starting dynamic subtest: pipe-A-HDMI-A-1
[858.484632] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[858.500504] Starting dynamic subtest: pipe-B-HDMI-A-1
[858.517604] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[858.533339] Starting dynamic subtest: pipe-C-HDMI-A-1
[858.551303] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[858.566701] Starting dynamic subtest: pipe-D-HDMI-A-1
[858.585656] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[858.589283] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.013s)
[858.741413] [112/156] (183s left) kms_flip (2x-plain-flip)
[860.281474] Starting subtest: 2x-plain-flip
[860.304112] Subtest 2x-plain-flip: SKIP (0.021s)
[860.437313] [113/156] (181s left) syncobj_wait (multi-wait-all-submitted)
[860.490260] Starting subtest: multi-wait-all-submitted
[860.600640] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[860.790878] [114/156] (181s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[862.293702] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[862.299646] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[862.538951] [115/156] (179s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[864.067915] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[864.069533] Starting dynamic subtest: pipe-A-HDMI-A-1
[864.111904] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[864.127697] Starting dynamic subtest: pipe-B-HDMI-A-1
[864.178572] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[864.194134] Starting dynamic subtest: pipe-C-HDMI-A-1
[864.232012] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[864.247190] Starting dynamic subtest: pipe-D-HDMI-A-1
[864.292264] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[864.295786] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[864.387612] [116/156] (178s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[865.888137] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[865.893777] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[866.139546] [117/156] (176s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[867.639810] Starting subtest: psr-1p-primscrn-spr-indfb-move
[867.643157] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[867.831429] [118/156] (174s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[869.331562] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[869.334913] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[869.528615] [119/156] (173s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[871.042853] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[871.046230] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[871.245898] [120/156] (171s left) i915_pm_rc6_residency (rc6-accuracy)
[871.298908] Starting subtest: rc6-accuracy
[871.300725] Starting dynamic subtest: gt0
[874.476257] Dynamic subtest gt0: SUCCESS (3.172s)
[874.477872] Subtest rc6-accuracy: SUCCESS (3.178s)
[874.618096] [121/156] (168s left) kms_legacy_colorkey (invalid-plane)
[876.108470] Starting subtest: invalid-plane
[876.109945] Starting dynamic subtest: zero-id
[876.111454] Dynamic subtest zero-id: SUCCESS (0.000s)
[876.127150] Starting dynamic subtest: outrange-id
[876.128678] Dynamic subtest outrange-id: SUCCESS (0.000s)
[876.130334] Subtest invalid-plane: SUCCESS (0.003s)
[876.263634] [122/156] (166s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[877.762056] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[877.765291] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[877.988971] [123/156] (165s left) gem_partial_pwrite_pread (write-uncached)
[878.042602] Subtest write-uncached: SKIP (0.000s)
[878.146869] [124/156] (165s left) gem_userptr_blits (readonly-unsync)
[878.205278] Subtest readonly-unsync: SKIP (0.000s)
[878.414325] [125/156] (165s left) syncobj_basic (bad-pad-fd-to-handle)
[878.463215] Starting subtest: bad-pad-fd-to-handle
[878.464790] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[878.624808] [126/156] (164s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[880.124644] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[880.127958] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[880.302254] [127/156] (163s left) perf (invalid-oa-format-id)
[880.468463] Starting subtest: invalid-oa-format-id
[880.493984] Subtest invalid-oa-format-id: SUCCESS (0.025s)
[880.582421] [128/156] (163s left) gem_mmap_wc (pf-nonblock)
[880.632342] Subtest pf-nonblock: SKIP (0.000s)
[880.713077] [129/156] (163s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[880.764214] Starting subtest: multi-wait-for-submit-submitted-signaled
[880.765831] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[880.888172] [130/156] (163s left) kms_psr (psr2-sprite-plane-onoff)
[882.380957] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[882.559676] [131/156] (161s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[884.076980] Starting subtest: psr-shrfb-scaledprimary
[884.080212] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[884.287910] [132/156] (159s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[885.802006] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[885.805347] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[885.989720] [133/156] (158s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[887.487343] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[887.490457] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[887.659585] [134/156] (156s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[887.708243] Starting subtest: invalid-single-wait-all-unsubmitted
[887.709761] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[887.863558] [135/156] (156s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[889.355905] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[889.454622] [136/156] (155s left) kms_dp_link_training (uhbr-mst)
[890.951472] Starting subtest: uhbr-mst
[890.954427] Subtest uhbr-mst: SKIP (0.000s)
[891.092521] [137/156] (153s left) prime_busy (hang)
[891.147369] Starting subtest: hang
[891.151499] Starting dynamic subtest: rcs0
[917.359795] Dynamic subtest rcs0: SUCCESS (26.210s)
[917.375327] Starting dynamic subtest: bcs0
[924.505534] Dynamic subtest bcs0: SUCCESS (7.143s)
[924.521009] Starting dynamic subtest: vcs0
[931.548075] Dynamic subtest vcs0: SUCCESS (7.043s)
[931.563479] Starting dynamic subtest: vcs1
[938.521760] Dynamic subtest vcs1: SUCCESS (6.972s)
[938.537170] Starting dynamic subtest: vecs0
[945.496205] Dynamic subtest vecs0: SUCCESS (6.973s)
[945.497789] Subtest hang: SUCCESS (54.350s)
[945.658744] [138/156] ( 99s left) i915_drm_fdinfo (virtual-busy-all)
[945.714993] Starting subtest: virtual-busy-all
[945.718399] Subtest virtual-busy-all: SKIP (0.000s)
[945.835749] [139/156] ( 99s left) gen9_exec_parse (allowed-all)
[945.890269] Subtest allowed-all: SKIP (0.000s)
[945.984290] [140/156] ( 99s left) gem_exec_schedule (u-submit-late-slice)
[946.066484] Starting subtest: u-submit-late-slice
[946.067901] Starting dynamic subtest: rcs0
[946.120953] Dynamic subtest rcs0: SUCCESS (0.060s)
[946.136797] Starting dynamic subtest: bcs0
[946.162643] Dynamic subtest bcs0: SUCCESS (0.040s)
[946.178635] Starting dynamic subtest: vcs0
[946.205502] Dynamic subtest vcs0: SUCCESS (0.041s)
[946.221518] Starting dynamic subtest: vcs1
[946.247988] Dynamic subtest vcs1: SUCCESS (0.041s)
[946.263959] Starting dynamic subtest: vecs0
[946.290401] Dynamic subtest vecs0: SUCCESS (0.041s)
[946.291987] Subtest u-submit-late-slice: SUCCESS (0.231s)
[946.797769] [141/156] ( 98s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[946.854378] Starting subtest: x-tiled-to-vebox-y-tiled
[946.855937] Starting dynamic subtest: smem
[946.937088] Dynamic subtest smem: SUCCESS (0.082s)
[946.952882] Starting dynamic subtest: lmem0
[947.692894] Dynamic subtest lmem0: SUCCESS (0.751s)
[947.694733] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.836s)
[947.957727] [142/156] ( 97s left) api_intel_bb (reset-flags)
[948.006766] Starting subtest: reset-flags
[948.035131] Subtest reset-flags: SUCCESS (0.029s)
[948.230085] [143/156] ( 97s left) kms_flip (2x-flip-vs-wf_vblank)
[949.719625] Starting subtest: 2x-flip-vs-wf_vblank
[949.741998] Subtest 2x-flip-vs-wf_vblank: SKIP (0.021s)
[949.915479] [144/156] ( 95s left) kms_pm_dc (dc5-dpms)
[952.416856] Starting subtest: dc5-dpms
[953.712631] Subtest dc5-dpms: SUCCESS (1.292s)
[953.859510] [145/156] ( 91s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[955.360341] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[955.363670] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[955.554784] [146/156] ( 90s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[957.047811] Starting subtest: bad-rotation-90-yf-tiled-ccs
[957.049329] Starting dynamic subtest: pipe-A-HDMI-A-1
[957.064797] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[957.080926] Starting dynamic subtest: pipe-B-HDMI-A-1
[957.096518] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[957.112316] Starting dynamic subtest: pipe-C-HDMI-A-1
[957.129006] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[957.144556] Starting dynamic subtest: pipe-D-HDMI-A-1
[957.162379] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[957.166028] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.009s)
[957.337644] [147/156] ( 88s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[958.886885] Starting subtest: 4-tiled-addfb-size-offset-overflow
[958.890817] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[959.101680] [148/156] ( 86s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[960.603845] Starting subtest: fbcpsr-1p-rte
[960.607301] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[960.788555] [149/156] ( 85s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[960.843837] Subtest writes-after-reads: SKIP (0.000s)
[960.928792] [150/156] ( 85s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[962.427977] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[962.431518] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[962.646944] [151/156] ( 83s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[964.145991] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[964.149396] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[964.349660] [152/156] ( 81s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[965.843150] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[965.863501] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.021s)
[966.005448] [153/156] ( 80s left) kms_plane (plane-panning-bottom-right-suspend)
[967.497654] Starting subtest: plane-panning-bottom-right-suspend
[967.499095] Starting dynamic subtest: pipe-A
[988.750401] Dynamic subtest pipe-A: SUCCESS (10.860s)
[988.769789] Starting dynamic subtest: pipe-B
[1010.750272] Dynamic subtest pipe-B: SUCCESS (10.372s)
[1010.751740] Subtest plane-panning-bottom-right-suspend: SUCCESS (21.237s)
[1017.001086] [154/156] ( 35s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[1019.718632] Starting subtest: basic-flip-before-cursor-legacy
[1020.728965] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.011s)
[1020.938282] [155/156] ( 31s left) kms_getfb (getfb-reject-nv12)
[1022.432716] Starting subtest: getfb-reject-nv12
[1022.434236] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[1022.648300] [156/156] ( 30s left) gem_render_copy (x-tiled)
[1022.704553] Starting subtest: x-tiled
[1022.706187] Starting dynamic subtest: smem
[1022.792647] Dynamic subtest smem: SUCCESS (0.087s)
[1022.808969] Starting dynamic subtest: lmem0
[1023.551513] Dynamic subtest lmem0: SUCCESS (0.754s)
[1023.553219] Subtest x-tiled: SUCCESS (0.844s)
[1023.815413] Closing watchdogs
results: parsing output: 0/ for test: i915_selftest
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_prime
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_dsc
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_plane_multiple
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: gem_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_atomic
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_exec_await
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
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_frontbuffer_tracking
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: i915_hangman
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_ctx_isolation
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_spin_batch
results: parsing output: 70/ for test: syncobj_basic
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_frames
results: parsing output: 76/ for test: kms_chamelium_audio
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: prime_vgem
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_vrr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_invalid_mode
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_alignment
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: sw_sync
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_pipe_stress
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: device_reset
results: parsing output: 109/ for test: gem_ctx_exec
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_pm_rc6_residency
results: parsing output: 120/ for test: kms_legacy_colorkey
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: syncobj_wait
results: parsing output: 134/ for test: kms_psr2_sf
results: parsing output: 135/ for test: kms_dp_link_training
results: parsing output: 136/ for test: prime_busy
results: parsing output: 137/ for test: i915_drm_fdinfo
results: parsing output: 138/ for test: gen9_exec_parse
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: gem_render_copy
results: parsing output: 141/ for test: api_intel_bb
results: parsing output: 142/ for test: kms_flip
results: parsing output: 143/ for test: kms_pm_dc
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_flip
results: parsing output: 152/ for test: kms_plane
results: parsing output: 153/ for test: kms_cursor_legacy
results: parsing output: 154/ for test: kms_getfb
results: parsing output: 155/ for test: gem_render_copy
Done.