[63.177089] Initializing watchdogs
[63.177169]   /dev/watchdog0
[63.217546] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[63.232578] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.237632] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.240725] [001/155] (960s left) i915_selftest (live)
[64.238245] Starting subtest: live
[64.239165] Starting dynamic subtest: sanitycheck
[65.710962] Dynamic subtest sanitycheck: SUCCESS (1.464s)
[65.719186] Starting dynamic subtest: uncore
[67.122921] Dynamic subtest uncore: SUCCESS (1.404s)
[67.131479] Starting dynamic subtest: workarounds
[70.488880] Dynamic subtest workarounds: SUCCESS (3.353s)
[70.496658] Starting dynamic subtest: gt_engines
[72.955027] Dynamic subtest gt_engines: SUCCESS (2.460s)
[72.963478] Starting dynamic subtest: gt_timelines
[139.822054] Dynamic subtest gt_timelines: SUCCESS (66.842s)
[139.830520] Starting dynamic subtest: gt_contexts
[141.272014] Dynamic subtest gt_contexts: SUCCESS (1.450s)
[141.279996] Starting dynamic subtest: gt_lrc
[147.570120] Dynamic subtest gt_lrc: SUCCESS (6.297s)
[147.578081] Starting dynamic subtest: gt_mocs
[149.903968] Dynamic subtest gt_mocs: SUCCESS (2.333s)
[149.912061] Starting dynamic subtest: gt_pm
[153.979110] Dynamic subtest gt_pm: SUCCESS (4.075s)
[153.987317] Starting dynamic subtest: gt_heartbeat
[155.435120] Dynamic subtest gt_heartbeat: SUCCESS (1.456s)
[155.442898] Starting dynamic subtest: gt_tlb
[169.147885] Dynamic subtest gt_tlb: SUCCESS (13.717s)
[169.156113] Starting dynamic subtest: requests
[179.846236] Dynamic subtest requests: SUCCESS (10.694s)
[179.854607] Starting dynamic subtest: migrate
[184.355788] Dynamic subtest migrate: SUCCESS (4.509s)
[184.363631] Starting dynamic subtest: active
[185.798873] Dynamic subtest active: SUCCESS (1.443s)
[185.806580] Starting dynamic subtest: objects
[188.151868] Dynamic subtest objects: SUCCESS (2.353s)
[188.160377] Starting dynamic subtest: mman
[191.761851] Dynamic subtest mman: SUCCESS (3.610s)
[191.769796] Starting dynamic subtest: dmabuf
[193.293755] Dynamic subtest dmabuf: SUCCESS (1.532s)
[193.301737] Starting dynamic subtest: vma
[194.718952] Dynamic subtest vma: SUCCESS (1.425s)
[194.727038] Starting dynamic subtest: coherency
[204.937961] Dynamic subtest coherency: SUCCESS (10.218s)
[204.946632] Starting dynamic subtest: gtt
[213.973395] Dynamic subtest gtt: SUCCESS (9.035s)
[213.982481] Starting dynamic subtest: gem
[215.556031] Dynamic subtest gem: SUCCESS (1.582s)
[215.564917] Starting dynamic subtest: evict
[227.092014] Dynamic subtest evict: SUCCESS (11.535s)
[227.100495] Starting dynamic subtest: hugepages
[244.407231] Dynamic subtest hugepages: SUCCESS (17.314s)
[244.415260] Starting dynamic subtest: gem_contexts
[272.712907] Dynamic subtest gem_contexts: SUCCESS (28.304s)
[272.720753] Starting dynamic subtest: client
[274.216962] Dynamic subtest client: SUCCESS (1.503s)
[274.225192] Starting dynamic subtest: gem_migrate
[276.898990] Dynamic subtest gem_migrate: SUCCESS (2.681s)
[276.907227] Starting dynamic subtest: reset
[278.334057] Dynamic subtest reset: SUCCESS (1.434s)
[278.342141] Starting dynamic subtest: memory_region
[281.380853] Dynamic subtest memory_region: SUCCESS (3.046s)
[281.389252] Starting dynamic subtest: hangcheck
[310.901975] Dynamic subtest hangcheck: SUCCESS (29.522s)
[310.909891] Starting dynamic subtest: execlists
[312.318991] Dynamic subtest execlists: SUCCESS (1.416s)
[312.327698] Starting dynamic subtest: ring_submission
[313.767951] Dynamic subtest ring_submission: SUCCESS (1.448s)
[313.776629] Starting dynamic subtest: perf
[315.369997] Dynamic subtest perf: SUCCESS (1.601s)
[315.378358] Starting dynamic subtest: slpc
[321.293954] Dynamic subtest slpc: SUCCESS (5.923s)
[321.302469] Starting dynamic subtest: guc
[324.817980] Dynamic subtest guc: SUCCESS (3.523s)
[324.826395] Starting dynamic subtest: guc_multi_lrc
[326.254855] Dynamic subtest guc_multi_lrc: SUCCESS (1.436s)
[326.262917] Starting dynamic subtest: guc_hang
[328.476648] Dynamic subtest guc_hang: SUCCESS (2.221s)
[328.484811] Starting dynamic subtest: late_gt_pm
[329.949706] Dynamic subtest late_gt_pm: SUCCESS (1.472s)
[329.950681] Subtest live: SUCCESS (265.655s)
[329.988292] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[329.990697] [002/155] (693s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[334.810454] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[336.132110] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.320s)
[336.443780] [FACT kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true
[336.447275] [003/155] (687s left) kms_content_protection (dp-mst-type-0)
[337.997233] Starting subtest: dp-mst-type-0
[337.998948] Subtest dp-mst-type-0: SKIP (0.000s)
[338.180508] [004/155] (685s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[338.227548] Starting subtest: invalid-multi-wait-unsubmitted
[338.228429] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[338.381461] [005/155] (685s left) gem_mmap_gtt (basic-read-write-distinct)
[338.426050] Subtest basic-read-write-distinct: SKIP (0.000s)
[338.502027] [006/155] (685s left) kms_prime (basic-modeset-hybrid)
[340.006909] Subtest basic-modeset-hybrid: SKIP (0.000s)
[340.264252] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[340.271485] [007/155] (683s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[341.766836] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[341.768524] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[341.944783] [008/155] (682s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[343.489431] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[343.625582] [009/155] (680s left) tools_test (tools_test)
[343.680224] Starting subtest: tools_test
[343.777422] Subtest tools_test: SUCCESS (0.107s)
[343.885924] [010/155] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[345.382039] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[345.383925] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[345.578778] [011/155] (679s left) kms_dsc (dsc-fractional-bpp)
[347.068600] Starting subtest: dsc-fractional-bpp
[347.075236] Subtest dsc-fractional-bpp: SKIP (0.000s)
[347.195836] [012/155] (677s left) gem_exec_fence (parallel)
[347.430928] Starting subtest: parallel
[347.432172] Starting dynamic subtest: rcs0
[349.586269] Dynamic subtest rcs0: SUCCESS (2.155s)
[349.595854] Starting dynamic subtest: bcs0
[351.739902] Dynamic subtest bcs0: SUCCESS (2.153s)
[351.749522] Starting dynamic subtest: vcs0
[353.895007] Dynamic subtest vcs0: SUCCESS (2.154s)
[353.905146] Starting dynamic subtest: vcs1
[356.044552] Dynamic subtest vcs1: SUCCESS (2.148s)
[356.054247] Starting dynamic subtest: vecs0
[358.197169] Dynamic subtest vecs0: SUCCESS (2.151s)
[358.198169] Subtest parallel: SUCCESS (10.767s)
[358.844060] [013/155] (665s left) gem_wait (write-wait)
[358.906404] Starting subtest: write-wait
[358.907657] Starting dynamic subtest: all-engines
[360.015366] Dynamic subtest all-engines: SUCCESS (1.110s)
[360.029224] Starting dynamic subtest: rcs0
[361.077994] Dynamic subtest rcs0: SUCCESS (1.060s)
[361.119179] Starting dynamic subtest: bcs0
[362.156861] Dynamic subtest bcs0: SUCCESS (1.073s)
[362.176618] Starting dynamic subtest: vcs0
[363.224778] Dynamic subtest vcs0: SUCCESS (1.062s)
[363.268700] Starting dynamic subtest: vcs1
[364.307046] Dynamic subtest vcs1: SUCCESS (1.076s)
[364.320471] Starting dynamic subtest: vecs0
[365.366843] Dynamic subtest vecs0: SUCCESS (1.055s)
[365.374129] Subtest write-wait: SUCCESS (6.464s)
[365.662181] [014/155] (659s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[365.708930] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[365.815287] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[365.961687] [015/155] (658s left) gem_mmap_gtt (basic-read-write)
[366.005776] Subtest basic-read-write: SKIP (0.000s)
[366.088516] [016/155] (658s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[367.577480] Starting subtest: plane-lut1d-ctm3x4-lut1d
[367.781984] Starting dynamic subtest: pipe-A-plane-0
[368.046250] Dynamic subtest pipe-A-plane-0: SUCCESS (0.265s)
[368.074756] Starting dynamic subtest: pipe-A-plane-1
[368.247321] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[368.272454] Starting dynamic subtest: pipe-A-plane-2
[368.447193] Dynamic subtest pipe-A-plane-2: SUCCESS (0.195s)
[368.766187] Starting dynamic subtest: pipe-B-plane-0
[368.930384] Dynamic subtest pipe-B-plane-0: SUCCESS (0.197s)
[368.963313] Starting dynamic subtest: pipe-B-plane-1
[369.146889] Dynamic subtest pipe-B-plane-1: SUCCESS (0.211s)
[369.175421] Starting dynamic subtest: pipe-B-plane-2
[369.328203] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[369.644567] Starting dynamic subtest: pipe-C-plane-0
[369.826060] Dynamic subtest pipe-C-plane-0: SUCCESS (0.214s)
[369.861897] Starting dynamic subtest: pipe-C-plane-1
[370.024057] Dynamic subtest pipe-C-plane-1: SUCCESS (0.193s)
[370.037314] Starting dynamic subtest: pipe-C-plane-2
[370.226111] Dynamic subtest pipe-C-plane-2: SUCCESS (0.199s)
[370.565344] Starting dynamic subtest: pipe-D-plane-0
[370.738491] Dynamic subtest pipe-D-plane-0: SUCCESS (0.197s)
[370.762963] Starting dynamic subtest: pipe-D-plane-1
[370.938383] Dynamic subtest pipe-D-plane-1: SUCCESS (0.194s)
[370.957874] Starting dynamic subtest: pipe-D-plane-2
[371.138574] Dynamic subtest pipe-D-plane-2: SUCCESS (0.194s)
[371.192850] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (3.616s)
[371.403582] [017/155] (653s left) gem_exec_schedule (preemptive-hang)
[371.603921] Starting subtest: preemptive-hang
[371.604898] Starting dynamic subtest: rcs0
[381.050839] Dynamic subtest rcs0: SUCCESS (9.451s)
[381.060944] Starting dynamic subtest: bcs0
[390.070516] Dynamic subtest bcs0: SUCCESS (9.018s)
[390.080670] Starting dynamic subtest: vcs0
[399.098470] Dynamic subtest vcs0: SUCCESS (9.027s)
[399.108817] Starting dynamic subtest: vcs1
[408.061657] Dynamic subtest vcs1: SUCCESS (8.961s)
[408.072690] Starting dynamic subtest: vecs0
[417.075648] Dynamic subtest vecs0: SUCCESS (9.013s)
[417.076592] Subtest preemptive-hang: SUCCESS (45.479s)
[417.355197] [018/155] (607s left) vgem_basic (bad-flag)
[417.414860] Starting subtest: bad-flag
[417.415820] Subtest bad-flag: SUCCESS (0.000s)
[417.531854] [019/155] (607s left) kms_cursor_crc (cursor-onscreen-512x170)
[419.323567] Starting subtest: cursor-onscreen-512x170
[419.329603] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[419.590443] [020/155] (605s left) kms_frontbuffer_tracking (hdr-1p-rte)
[421.087935] Starting subtest: hdr-1p-rte
[421.089890] Subtest hdr-1p-rte: SKIP (0.000s)
[421.244482] [021/155] (604s left) kms_psr (psr-sprite-plane-move)
[422.738382] Subtest psr-sprite-plane-move: SKIP (0.000s)
[422.824762] [022/155] (602s left) kms_plane_multiple (tiling-x)
[424.314292] Starting subtest: tiling-x
[424.315210] Starting dynamic subtest: pipe-A-HDMI-A-3
[425.285028] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.970s)
[425.296896] Starting dynamic subtest: pipe-B-HDMI-A-3
[426.168161] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.881s)
[426.180158] Starting dynamic subtest: pipe-C-HDMI-A-3
[427.074248] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.903s)
[427.086080] Starting dynamic subtest: pipe-D-HDMI-A-3
[427.956526] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.881s)
[427.961477] Subtest tiling-x: SUCCESS (3.644s)
[428.169082] [023/155] (597s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[428.219579] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[428.326096] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[428.468019] [024/155] (597s left) gem_ccs (block-multicopy-inplace)
[428.520530] Starting subtest: block-multicopy-inplace
[428.522334] Subtest block-multicopy-inplace: SKIP (0.000s)
[428.653893] [025/155] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[430.149342] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[430.151277] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[430.310889] [026/155] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[431.807262] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[431.809126] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[431.989125] [027/155] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[433.487264] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[433.490093] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[433.683305] [028/155] (592s left) kms_vblank (query-busy-hang)
[435.174431] Starting subtest: query-busy-hang
[435.175300] Starting dynamic subtest: pipe-A-HDMI-A-3
[461.481326] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.305s)
[461.494534] Starting dynamic subtest: pipe-D-HDMI-A-3
[486.472888] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.986s)
[486.473867] Subtest query-busy-hang: SUCCESS (51.299s)
[486.676235] [029/155] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[488.173057] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[488.174844] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.392916] [030/155] (537s left) kms_psr (psr2-cursor-blt)
[489.886753] Subtest psr2-cursor-blt: SKIP (0.000s)
[489.965985] [031/155] (536s left) syncobj_wait (single-wait-for-submit-signaled)
[490.013939] Starting subtest: single-wait-for-submit-signaled
[490.015132] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[490.126288] [032/155] (536s left) api_intel_bb (bb-with-allocator)
[490.173139] Starting subtest: bb-with-allocator
[490.192358] Subtest bb-with-allocator: SUCCESS (0.021s)
[490.376008] [033/155] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[491.871027] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[491.872942] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[492.059804] [034/155] (534s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[493.567844] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[493.648959] [035/155] (533s left) gem_exec_schedule (u-semaphore-user)
[493.713536] Starting subtest: u-semaphore-user
[493.743107] Subtest u-semaphore-user: SUCCESS (0.031s)
[494.162172] [036/155] (532s left) gem_ctx_param (invalid-ctx-get)
[494.208729] Starting subtest: invalid-ctx-get
[494.209588] Subtest invalid-ctx-get: SUCCESS (0.000s)
[494.345186] [037/155] (532s left) gem_userptr_blits (usage-restrictions)
[494.397485] Starting subtest: usage-restrictions
[494.398305] Subtest usage-restrictions: SUCCESS (0.000s)
[494.611826] [038/155] (532s left) syncobj_wait (single-wait-submitted)
[494.657761] Starting subtest: single-wait-submitted
[494.764328] Subtest single-wait-submitted: SUCCESS (0.105s)
[494.934335] [039/155] (532s left) kms_cursor_legacy (forked-bo)
[496.425488] Starting subtest: forked-bo
[496.426463] Starting dynamic subtest: pipe-A
[501.855466] Dynamic subtest pipe-A: SUCCESS (5.424s)
[501.874443] Starting dynamic subtest: pipe-B
[507.297694] Dynamic subtest pipe-B: SUCCESS (5.440s)
[507.318474] Starting dynamic subtest: pipe-C
[512.747065] Dynamic subtest pipe-C: SUCCESS (5.445s)
[512.767409] Starting dynamic subtest: pipe-D
[518.193664] Dynamic subtest pipe-D: SUCCESS (5.445s)
[518.212635] Starting dynamic subtest: all-pipes
[523.635562] Dynamic subtest all-pipes: SUCCESS (5.439s)
[523.636495] Subtest forked-bo: SUCCESS (27.206s)
[523.754424] [040/155] (503s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[525.245361] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[525.246221] Starting dynamic subtest: pipe-A
[525.412941] Dynamic subtest pipe-A: SUCCESS (0.168s)
[525.431246] Starting dynamic subtest: pipe-B
[525.604546] Dynamic subtest pipe-B: SUCCESS (0.189s)
[525.616432] Starting dynamic subtest: pipe-C
[525.761870] Dynamic subtest pipe-C: SUCCESS (0.156s)
[525.774125] Starting dynamic subtest: pipe-D
[525.919018] Dynamic subtest pipe-D: SUCCESS (0.156s)
[525.919958] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.675s)
[526.130813] [041/155] (501s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[527.640391] Starting subtest: x-tiled-32bpp-rotate-0
[529.681448] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.036s)
[529.883713] [042/155] (497s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[531.379918] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[531.386183] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[531.565349] [043/155] (495s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[533.060892] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[533.062828] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[533.240697] [044/155] (494s left) gem_mmap_offset (clear)
[533.287043] Starting subtest: clear
[533.290139] Starting dynamic subtest: lmem0
[555.236688] Dynamic subtest lmem0: SUCCESS (21.941s)
[555.247847] Starting dynamic subtest: smem0
[582.378111] Dynamic subtest smem0: SUCCESS (27.145s)
[582.379147] Subtest clear: SUCCESS (49.089s)
[582.549198] [045/155] (445s left) kms_atomic (plane-invalid-params)
[584.109653] Starting subtest: plane-invalid-params
[584.110668] Starting dynamic subtest: pipe-A-HDMI-A-3
[584.681058] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.570s)
[584.681961] Subtest plane-invalid-params: SUCCESS (0.573s)
[584.884536] [046/155] (442s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[586.381894] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[586.383661] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[586.547341] [047/155] (441s left) gem_ctx_persistence (saturated-hostile)
[586.604297] Starting subtest: saturated-hostile
[586.605331] Starting dynamic subtest: rcs0
[587.418327] Dynamic subtest rcs0: SUCCESS (0.813s)
[587.434243] Starting dynamic subtest: bcs0
[588.196333] Dynamic subtest bcs0: SUCCESS (0.776s)
[588.210412] Starting dynamic subtest: vcs0
[588.975915] Dynamic subtest vcs0: SUCCESS (0.777s)
[588.990233] Starting dynamic subtest: vcs1
[589.763125] Dynamic subtest vcs1: SUCCESS (0.783s)
[589.776180] Starting dynamic subtest: vecs0
[590.542182] Dynamic subtest vecs0: SUCCESS (0.776s)
[590.545147] Subtest saturated-hostile: SUCCESS (3.939s)
[590.683194] [048/155] (437s left) gem_exec_params (larger-than-life-batch)
[590.737445] Starting subtest: larger-than-life-batch
[601.410129] Subtest larger-than-life-batch: SUCCESS (10.670s)
[601.987538] [049/155] (425s left) gem_exec_await (wide-contexts)
[602.177551] Starting subtest: wide-contexts
[624.131105] Subtest wide-contexts: SUCCESS (21.954s)
[624.399755] [050/155] (403s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[624.508978] Starting subtest: yf-tiled-to-vebox-yf-tiled
[624.509913] Starting dynamic subtest: smem
[624.598946] Dynamic subtest smem: SUCCESS (0.089s)
[624.612026] Starting dynamic subtest: lmem0
[625.359222] Dynamic subtest lmem0: SUCCESS (0.755s)
[625.360566] Subtest yf-tiled-to-vebox-yf-tiled: SUCCESS (0.847s)
[625.616716] [051/155] (402s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[627.117513] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[627.119197] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[627.286328] [052/155] (400s left) gem_exec_params (invalid-bsd-ring)
[627.341483] Starting subtest: invalid-bsd-ring
[627.342459] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[627.484980] [053/155] (400s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[627.541715] Starting subtest: single-wait-for-submit-unsubmitted
[627.646574] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[627.801393] [054/155] (400s left) gem_create (create-valid-nonaligned)
[627.864171] Starting subtest: create-valid-nonaligned
[627.865237] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[628.112759] [055/155] (400s left) kms_flip (2x-flip-vs-fences-interruptible)
[629.608479] Starting subtest: 2x-flip-vs-fences-interruptible
[629.610403] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[629.796039] [056/155] (398s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[631.291937] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[631.293687] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[631.546212] [057/155] (397s left) syncobj_wait (invalid-reset-illegal-handle)
[631.617610] Starting subtest: invalid-reset-illegal-handle
[631.618442] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[631.767115] [058/155] (397s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[633.262105] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[633.264194] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[633.473896] [059/155] (395s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[634.968536] Starting subtest: hdr-rgb101010-draw-mmap-wc
[634.970248] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[635.145882] [060/155] (394s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[636.642294] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[636.644196] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[636.798262] [061/155] (392s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[638.291436] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[638.292301] Starting dynamic subtest: pipe-A-valid-mode
[639.457448] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.164s)
[639.458317] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.167s)
[639.667261] [062/155] (389s left) gem_exec_balancer (sliced)
[639.728467] Starting subtest: sliced
[639.730650] Subtest sliced: SKIP (0.000s)
[640.160713] [063/155] (389s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[641.675190] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[641.676950] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[641.840507] [064/155] (387s left) i915_hangman (engine-engine-error)
[641.903026] Starting subtest: engine-engine-error
[641.904119] Starting dynamic subtest: rcs0
[642.601529] Dynamic subtest rcs0: SUCCESS (0.698s)
[642.619857] Starting dynamic subtest: bcs0
[643.267374] Dynamic subtest bcs0: SUCCESS (0.664s)
[643.280735] Starting dynamic subtest: vcs0
[643.930432] Dynamic subtest vcs0: SUCCESS (0.662s)
[643.944411] Starting dynamic subtest: vcs1
[644.596407] Dynamic subtest vcs1: SUCCESS (0.664s)
[644.610052] Starting dynamic subtest: vecs0
[645.258344] Dynamic subtest vecs0: SUCCESS (0.660s)
[645.259259] Subtest engine-engine-error: SUCCESS (3.357s)
[645.424148] [065/155] (384s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[646.918255] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[646.920019] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[647.102489] [066/155] (382s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[648.614107] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[649.889528] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.276s)
[650.126592] [067/155] (379s left) gem_ctx_isolation (dirty-switch)
[650.184914] Starting subtest: dirty-switch
[650.185949] Starting dynamic subtest: rcs0
[650.976163] Dynamic subtest rcs0: SUCCESS (0.790s)
[650.989953] Starting dynamic subtest: bcs0
[651.807038] Dynamic subtest bcs0: SUCCESS (0.830s)
[651.821180] Starting dynamic subtest: vcs0
[652.639671] Dynamic subtest vcs0: SUCCESS (0.831s)
[652.652956] Starting dynamic subtest: vcs1
[653.485544] Dynamic subtest vcs1: SUCCESS (0.844s)
[653.499321] Starting dynamic subtest: vecs0
[654.308890] Dynamic subtest vecs0: SUCCESS (0.822s)
[654.309884] Subtest dirty-switch: SUCCESS (4.125s)
[654.627637] [068/155] (375s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[656.121740] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[656.123518] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[656.302620] [069/155] (373s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[657.905739] Starting subtest: cursor-rapid-movement-32x10
[657.960158] Subtest cursor-rapid-movement-32x10: SKIP (0.052s)
[658.375589] [070/155] (371s left) gem_spin_batch (user-each)
[658.435449] Starting subtest: user-each
[661.742807] Subtest user-each: SUCCESS (3.307s)
[662.111441] [071/155] (368s left) syncobj_basic (bad-destroy)
[662.158099] Starting subtest: bad-destroy
[662.159101] Subtest bad-destroy: SUCCESS (0.000s)
[662.280911] [072/155] (368s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[663.776795] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[663.778516] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[663.942121] [073/155] (366s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[665.433998] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[665.436484] Starting dynamic subtest: pipe-A-valid-mode
[666.749212] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.313s)
[666.750163] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.316s)
[666.959942] [074/155] (363s left) kms_frontbuffer_tracking (fbc-suspend)
[668.456167] Starting subtest: fbc-suspend
[724.646493] Subtest fbc-suspend: SUCCESS (23.958s)
[728.895502] [075/155] (305s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[730.490559] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[730.492245] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[730.758397] [076/155] (303s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[732.306152] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[732.444399] [077/155] (302s left) kms_chamelium_audio (hdmi-audio)
[733.984211] Subtest hdmi-audio: SKIP (0.000s)
[734.122107] [078/155] (300s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[735.614475] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[735.728810] [079/155] (299s left) kms_psr (fbc-pr-primary-render)
[737.220244] Subtest fbc-pr-primary-render: SKIP (0.000s)
[737.303642] [080/155] (297s left) prime_vgem (basic-gtt)
[737.379136] Starting subtest: basic-gtt
[737.381164] Subtest basic-gtt: SKIP (0.000s)
[737.564253] [081/155] (297s left) gem_mmap_gtt (fault-concurrent-y)
[737.610662] Subtest fault-concurrent-Y: SKIP (0.000s)
[737.686753] [082/155] (297s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[739.183752] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[739.185785] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[739.385230] [083/155] (295s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[739.434134] Starting subtest: multi-wait-all-for-submit-available-submitted
[739.435124] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[739.544066] [084/155] (295s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[741.046475] Starting subtest: fbchdr-tiling-4
[741.048274] Subtest fbchdr-tiling-4: SKIP (0.000s)
[741.221431] [085/155] (294s left) kms_vrr (flip-basic-fastset)
[742.714036] Starting subtest: flip-basic-fastset
[742.716763] Subtest flip-basic-fastset: SKIP (0.000s)
[742.834230] [086/155] (292s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[744.339475] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[744.341185] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[744.529167] [087/155] (291s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[746.025680] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[746.027750] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[746.204584] [088/155] (289s left) gem_lmem_swapping (massive)
[750.617745] Starting subtest: massive
[750.623228] Starting dynamic subtest: lmem0
[759.494461] Dynamic subtest lmem0: SUCCESS (8.882s)
[759.495505] Subtest massive: SUCCESS (8.885s)
[760.963497] [FACT gem_lmem_swapping (massive)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[760.964706] [FACT gem_lmem_swapping (massive)] deleted: kernel.kmod_is_loaded.i915: true
[760.968666] [089/155] (274s left) kms_psr (pr-basic)
[765.794017] Subtest pr-basic: SKIP (0.000s)
[765.906379] [FACT kms_psr (pr-basic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[765.910452] [FACT kms_psr (pr-basic)] new: kernel.kmod_is_loaded.i915: true
[765.914621] [090/155] (270s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[767.418064] Starting subtest: async-flip-with-page-flip-events-linear
[767.585060] Starting dynamic subtest: pipe-A-HDMI-A-3
[769.840608] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.256s)
[770.015411] Starting dynamic subtest: pipe-B-HDMI-A-3
[772.087730] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.079s)
[772.269006] Starting dynamic subtest: pipe-C-HDMI-A-3
[774.344528] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.083s)
[774.502548] Starting dynamic subtest: pipe-D-HDMI-A-3
[776.570537] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.075s)
[776.571870] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.152s)
[776.959579] [091/155] (259s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[778.450982] Starting subtest: basic-busy-flip-before-cursor-atomic
[778.452916] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[778.593383] [092/155] (257s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[780.106427] Starting subtest: y-tiled-8bpp-rotate-90
[780.222133] Subtest y-tiled-8bpp-rotate-90: SKIP (0.114s)
[780.391706] [093/155] (255s left) kms_invalid_mode (bad-vsync-start)
[781.882982] Starting subtest: bad-vsync-start
[781.883891] Starting dynamic subtest: pipe-A-HDMI-A-3
[781.921848] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.038s)
[781.936421] Starting dynamic subtest: pipe-B-HDMI-A-3
[781.937722] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[781.951627] Starting dynamic subtest: pipe-C-HDMI-A-3
[781.952613] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[781.965073] Starting dynamic subtest: pipe-D-HDMI-A-3
[781.966000] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[781.966871] Subtest bad-vsync-start: SUCCESS (0.051s)
[782.182276] [094/155] (254s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[783.676875] Starting subtest: short-flip-after-cursor-toggle
[784.669542] Subtest short-flip-after-cursor-toggle: SUCCESS (0.993s)
[784.875496] [095/155] (251s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[786.371099] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[786.371933] Starting dynamic subtest: pipe-A-HDMI-A-3
[786.379942] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[786.392553] Starting dynamic subtest: pipe-B-HDMI-A-3
[786.400753] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[786.413229] Starting dynamic subtest: pipe-C-HDMI-A-3
[786.421465] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[786.433729] Starting dynamic subtest: pipe-D-HDMI-A-3
[786.442389] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[786.444067] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[786.680794] [096/155] (249s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[788.176475] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[788.178623] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[788.378282] [097/155] (248s left) drm_read (short-buffer-block)
[789.933329] Starting subtest: short-buffer-block
[789.934362] Subtest short-buffer-block: SUCCESS (0.000s)
[790.183245] [098/155] (246s left) perf_pmu (busy-idle)
[790.244350] Starting subtest: busy-idle
[790.245306] Starting dynamic subtest: rcs0
[790.957543] Dynamic subtest rcs0: SUCCESS (0.712s)
[790.975063] Starting dynamic subtest: bcs0
[791.619563] Dynamic subtest bcs0: SUCCESS (0.660s)
[791.636908] Starting dynamic subtest: vcs0
[792.282977] Dynamic subtest vcs0: SUCCESS (0.661s)
[792.300901] Starting dynamic subtest: vcs1
[792.947532] Dynamic subtest vcs1: SUCCESS (0.662s)
[792.964961] Starting dynamic subtest: vecs0
[793.613611] Dynamic subtest vecs0: SUCCESS (0.664s)
[793.614713] Subtest busy-idle: SUCCESS (3.370s)
[793.763571] [099/155] (243s left) syncobj_timeline (wait-for-submit-snapshot)
[793.811467] Starting subtest: wait-for-submit-snapshot
[793.895499] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[794.017495] [100/155] (242s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[795.508926] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[795.510679] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.000s)
[795.622372] [101/155] (241s left) gem_exec_balancer (bonded-semaphore)
[795.687075] Starting subtest: bonded-semaphore
[795.688906] Subtest bonded-semaphore: SKIP (0.000s)
[796.170635] [102/155] (240s left) kms_big_fb (linear-32bpp-rotate-90)
[797.678969] Starting subtest: linear-32bpp-rotate-90
[797.788691] Subtest linear-32bpp-rotate-90: SKIP (0.108s)
[797.957896] [103/155] (239s left) sw_sync (sync_multi_consumer)
[798.003879] Starting subtest: sync_multi_consumer
[798.448414] Subtest sync_multi_consumer: SUCCESS (0.440s)
[798.554065] [104/155] (238s left) perf_pmu (render-node-busy)
[798.611788] Starting subtest: render-node-busy
[798.612664] Starting dynamic subtest: rcs0
[799.206424] Dynamic subtest rcs0: SUCCESS (0.598s)
[799.224318] Starting dynamic subtest: bcs0
[799.765389] Dynamic subtest bcs0: SUCCESS (0.557s)
[799.783668] Starting dynamic subtest: vcs0
[800.326540] Dynamic subtest vcs0: SUCCESS (0.559s)
[800.344741] Starting dynamic subtest: vcs1
[800.882450] Dynamic subtest vcs1: SUCCESS (0.554s)
[800.900298] Starting dynamic subtest: vecs0
[801.439404] Dynamic subtest vecs0: SUCCESS (0.555s)
[801.442583] Subtest render-node-busy: SUCCESS (2.833s)
[801.554799] [105/155] (235s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[803.049761] Starting subtest: stress-xrgb8888-ytiled
[816.966555] Subtest stress-xrgb8888-ytiled: SUCCESS (13.917s)
[817.156034] [106/155] (220s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[818.651667] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[818.653724] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[818.856483] [107/155] (218s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[820.351261] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[820.352997] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[820.556301] [108/155] (217s left) device_reset (unbind-cold-reset-rebind)
[820.659376] Starting subtest: unbind-cold-reset-rebind
[820.661253] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[820.795952] [109/155] (216s left) gem_ctx_exec (basic-close-race)
[820.844595] Starting subtest: basic-close-race
[826.386976] Subtest basic-close-race: SUCCESS (5.538s)
[826.568162] [110/155] (211s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[828.057906] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[828.058815] Starting dynamic subtest: pipe-A-HDMI-A-3
[828.068193] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[828.082042] Starting dynamic subtest: pipe-B-HDMI-A-3
[828.090686] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[828.104417] Starting dynamic subtest: pipe-C-HDMI-A-3
[828.113921] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[828.127266] Starting dynamic subtest: pipe-D-HDMI-A-3
[828.136635] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[828.138629] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.013s)
[828.361282] [111/155] (209s left) kms_flip (2x-plain-flip)
[829.851498] Starting subtest: 2x-plain-flip
[829.870079] Subtest 2x-plain-flip: SKIP (0.019s)
[830.017206] [112/155] (207s left) syncobj_wait (multi-wait-all-submitted)
[830.064963] Starting subtest: multi-wait-all-submitted
[830.176156] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[830.396160] [113/155] (207s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[831.891377] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[831.895036] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[832.137353] [114/155] (206s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[833.626085] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[833.627098] Starting dynamic subtest: pipe-A-HDMI-A-3
[833.652632] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[833.667010] Starting dynamic subtest: pipe-B-HDMI-A-3
[833.692661] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[833.706593] Starting dynamic subtest: pipe-C-HDMI-A-3
[833.736705] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[833.750624] Starting dynamic subtest: pipe-D-HDMI-A-3
[833.776581] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[833.778668] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[833.948312] [115/155] (204s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[835.445262] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[835.447171] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[835.641293] [116/155] (202s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[837.137866] Starting subtest: psr-1p-primscrn-spr-indfb-move
[837.139868] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[837.313575] [117/155] (201s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[838.808046] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[838.809771] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[838.963701] [118/155] (199s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[840.461694] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[840.463673] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[840.669942] [119/155] (198s left) i915_pm_rc6_residency (rc6-accuracy)
[840.718054] Starting subtest: rc6-accuracy
[840.718929] Starting dynamic subtest: gt0
[843.894660] Dynamic subtest gt0: SUCCESS (3.170s)
[843.895675] Subtest rc6-accuracy: SUCCESS (3.176s)
[844.017376] [120/155] (194s left) kms_legacy_colorkey (invalid-plane)
[845.507121] Starting subtest: invalid-plane
[845.508107] Starting dynamic subtest: zero-id
[845.509086] Dynamic subtest zero-id: SUCCESS (0.000s)
[845.523492] Starting dynamic subtest: outrange-id
[845.524934] Dynamic subtest outrange-id: SUCCESS (0.000s)
[845.526204] Subtest invalid-plane: SUCCESS (0.003s)
[845.624473] [121/155] (193s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[847.125277] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[847.127746] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[847.291127] [122/155] (191s left) gem_partial_pwrite_pread (write-uncached)
[847.344564] Subtest write-uncached: SKIP (0.000s)
[847.447967] [123/155] (191s left) gem_userptr_blits (readonly-unsync)
[847.504406] Subtest readonly-unsync: SKIP (0.000s)
[847.674974] [124/155] (191s left) syncobj_basic (bad-pad-fd-to-handle)
[847.736965] Starting subtest: bad-pad-fd-to-handle
[847.737980] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[847.858304] [125/155] (191s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render)
[849.351852] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render
[849.353636] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[849.530431] [126/155] (189s left) perf (invalid-oa-format-id)
[849.686904] Starting subtest: invalid-oa-format-id
[849.712912] Subtest invalid-oa-format-id: SUCCESS (0.026s)
[849.799742] [127/155] (189s left) gem_mmap_wc (pf-nonblock)
[849.845682] Subtest pf-nonblock: SKIP (0.000s)
[849.933717] [128/155] (189s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[849.980182] Starting subtest: multi-wait-for-submit-submitted-signaled
[849.981065] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[850.125823] [129/155] (189s left) kms_psr (psr2-sprite-plane-onoff)
[851.615663] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[851.696396] [130/155] (187s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[853.191656] Starting subtest: psr-shrfb-scaledprimary
[853.193787] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[853.346804] [131/155] (186s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[854.844042] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[854.845652] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[855.048913] [132/155] (184s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[856.544626] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[856.546486] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[856.751833] [133/155] (183s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[856.813375] Starting subtest: invalid-single-wait-all-unsubmitted
[856.814364] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[856.954368] [134/155] (183s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[858.444317] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[858.629993] [135/155] (181s left) kms_dp_link_training (uhbr-mst)
[860.133904] Starting subtest: uhbr-mst
[860.135664] Subtest uhbr-mst: SKIP (0.000s)
[860.280252] [136/155] (180s left) prime_busy (hang)
[860.337957] Starting subtest: hang
[860.338828] Starting dynamic subtest: rcs0
[886.687388] Dynamic subtest rcs0: SUCCESS (26.349s)
[886.701736] Starting dynamic subtest: bcs0
[893.767922] Dynamic subtest bcs0: SUCCESS (7.078s)
[893.782083] Starting dynamic subtest: vcs0
[900.808047] Dynamic subtest vcs0: SUCCESS (7.040s)
[900.823910] Starting dynamic subtest: vcs1
[907.783991] Dynamic subtest vcs1: SUCCESS (6.974s)
[907.799996] Starting dynamic subtest: vecs0
[914.760963] Dynamic subtest vecs0: SUCCESS (6.974s)
[914.761820] Subtest hang: SUCCESS (54.424s)
[914.905212] [137/155] (125s left) i915_drm_fdinfo (virtual-busy-all)
[914.955470] Starting subtest: virtual-busy-all
[914.957385] Subtest virtual-busy-all: SKIP (0.000s)
[915.079058] [138/155] (125s left) gen9_exec_parse (allowed-all)
[915.131924] Subtest allowed-all: SKIP (0.000s)
[915.214432] [139/155] (125s left) gem_exec_schedule (u-submit-late-slice)
[915.275864] Starting subtest: u-submit-late-slice
[915.276887] Starting dynamic subtest: rcs0
[915.332650] Dynamic subtest rcs0: SUCCESS (0.056s)
[915.348708] Starting dynamic subtest: bcs0
[915.375953] Dynamic subtest bcs0: SUCCESS (0.042s)
[915.392153] Starting dynamic subtest: vcs0
[915.416880] Dynamic subtest vcs0: SUCCESS (0.039s)
[915.432846] Starting dynamic subtest: vcs1
[915.458328] Dynamic subtest vcs1: SUCCESS (0.040s)
[915.474555] Starting dynamic subtest: vecs0
[915.501269] Dynamic subtest vecs0: SUCCESS (0.041s)
[915.502317] Subtest u-submit-late-slice: SUCCESS (0.226s)
[915.987736] [140/155] (124s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[916.040483] Starting subtest: x-tiled-to-vebox-y-tiled
[916.041650] Starting dynamic subtest: smem
[916.126588] Dynamic subtest smem: SUCCESS (0.085s)
[916.142616] Starting dynamic subtest: lmem0
[916.890746] Dynamic subtest lmem0: SUCCESS (0.754s)
[916.891917] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.843s)
[917.156426] [141/155] (123s left) api_intel_bb (reset-flags)
[917.202971] Starting subtest: reset-flags
[917.229849] Subtest reset-flags: SUCCESS (0.027s)
[917.408016] [142/155] (123s left) kms_flip (2x-flip-vs-wf_vblank)
[918.897846] Starting subtest: 2x-flip-vs-wf_vblank
[918.916133] Subtest 2x-flip-vs-wf_vblank: SKIP (0.019s)
[919.058971] [143/155] (121s left) kms_pm_dc (dc5-dpms)
[921.560997] Starting subtest: dc5-dpms
[922.844177] Subtest dc5-dpms: SUCCESS (1.280s)
[923.009148] [144/155] (118s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[924.503602] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[924.505554] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[924.680502] [145/155] (116s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[926.192858] Starting subtest: bad-rotation-90-yf-tiled-ccs
[926.193751] Starting dynamic subtest: pipe-A-HDMI-A-3
[926.201967] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[926.216622] Starting dynamic subtest: pipe-B-HDMI-A-3
[926.225157] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[926.239558] Starting dynamic subtest: pipe-C-HDMI-A-3
[926.248364] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[926.262379] Starting dynamic subtest: pipe-D-HDMI-A-3
[926.271261] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[926.272940] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.010s)
[926.508015] [146/155] (114s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[928.018044] Starting subtest: 4-tiled-addfb-size-offset-overflow
[928.020036] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[928.180970] [147/155] (113s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[929.676387] Starting subtest: fbcpsr-1p-rte
[929.678156] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[929.873891] [148/155] (111s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[929.925810] Subtest writes-after-reads: SKIP (0.000s)
[930.010230] [149/155] (111s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[931.505748] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[931.507833] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[931.684498] [150/155] (110s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[933.184035] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[933.186391] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[933.432677] [151/155] (108s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[934.922721] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[934.941145] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.019s)
[935.088205] [152/155] (106s left) kms_plane (plane-panning-bottom-right-suspend)
[936.577875] Starting subtest: plane-panning-bottom-right-suspend
[936.580419] Starting dynamic subtest: pipe-A
[962.675011] Dynamic subtest pipe-A: SUCCESS (10.764s)
[962.691683] Starting dynamic subtest: pipe-B
[989.655449] Dynamic subtest pipe-B: SUCCESS (10.577s)
[989.656173] Subtest plane-panning-bottom-right-suspend: SUCCESS (21.347s)
[995.870978] [153/155] ( 52s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[997.362506] Starting subtest: basic-flip-before-cursor-legacy
[998.344998] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.983s)
[998.558922] [154/155] ( 49s left) kms_getfb (getfb-reject-nv12)
[1000.871408] Starting subtest: getfb-reject-nv12
[1000.873990] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[1001.009173] [155/155] ( 47s left) gem_render_copy (x-tiled)
[1001.064490] Starting subtest: x-tiled
[1001.065403] Starting dynamic subtest: smem
[1001.152865] Dynamic subtest smem: SUCCESS (0.088s)
[1001.168759] Starting dynamic subtest: lmem0
[1001.925689] Dynamic subtest lmem0: SUCCESS (0.767s)
[1001.926804] Subtest x-tiled: SUCCESS (0.858s)
[1002.174844] 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: kms_frontbuffer_tracking
results: parsing output: 96/ for test: drm_read
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: kms_pipe_stress
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: device_reset
results: parsing output: 108/ for test: gem_ctx_exec
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
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: i915_pm_rc6_residency
results: parsing output: 119/ for test: kms_legacy_colorkey
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_partial_pwrite_pread
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: syncobj_basic
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
results: parsing output: 133/ for test: kms_psr2_sf
results: parsing output: 134/ for test: kms_dp_link_training
results: parsing output: 135/ for test: prime_busy
results: parsing output: 136/ for test: i915_drm_fdinfo
results: parsing output: 137/ for test: gen9_exec_parse
results: parsing output: 138/ for test: gem_exec_schedule
results: parsing output: 139/ for test: gem_render_copy
results: parsing output: 140/ for test: api_intel_bb
results: parsing output: 141/ for test: kms_flip
results: parsing output: 142/ for test: kms_pm_dc
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_ccs
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: kms_plane
results: parsing output: 152/ for test: kms_cursor_legacy
results: parsing output: 153/ for test: kms_getfb
results: parsing output: 154/ for test: gem_render_copy
Done.