[69.674700] Initializing watchdogs
[69.674781]   /dev/watchdog0
[69.705623] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[69.721018] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[69.725690] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.728307] [001/130] (960s left) kms_psr (fbc-pr-sprite-plane-onoff)
[71.223971] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[71.349456] [002/130] (958s left) kms_cursor_legacy (single-bo)
[72.967195] Starting subtest: single-bo
[72.968042] Starting dynamic subtest: pipe-A
[78.355036] Dynamic subtest pipe-A: SUCCESS (5.385s)
[78.363458] Starting dynamic subtest: pipe-B
[83.737428] Dynamic subtest pipe-B: SUCCESS (5.382s)
[83.745261] Starting dynamic subtest: pipe-C
[89.119483] Dynamic subtest pipe-C: SUCCESS (5.382s)
[89.127219] Starting dynamic subtest: pipe-D
[94.502323] Dynamic subtest pipe-D: SUCCESS (5.382s)
[94.510308] Starting dynamic subtest: all-pipes
[99.885129] Dynamic subtest all-pipes: SUCCESS (5.383s)
[99.885968] Subtest single-bo: SUCCESS (26.915s)
[99.986104] [003/130] (930s left) kms_psr (psr-sprite-render)
[101.473440] Subtest psr-sprite-render: SKIP (0.000s)
[101.546702] [004/130] (928s left) gem_userptr_blits (access-control)
[101.619472] Starting subtest: access-control
[101.620922] Subtest access-control: SKIP (0.000s)
[101.801207] [005/130] (928s left) kms_cursor_crc (cursor-random-256x85)
[103.543212] Starting subtest: cursor-random-256x85
[103.559257] Starting dynamic subtest: pipe-A-HDMI-A-4
[108.199264] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.640s)
[108.232340] Starting dynamic subtest: pipe-D-HDMI-A-4
[112.682172] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.457s)
[112.683146] Subtest cursor-random-256x85: SUCCESS (9.139s)
[112.977791] [006/130] (917s left) gem_mmap_offset (mmap-boundaries)
[113.024220] Starting subtest: mmap-boundaries
[113.025214] Starting dynamic subtest: lmem0
[113.327460] Dynamic subtest lmem0: SUCCESS (0.304s)
[113.336307] Starting dynamic subtest: smem0
[115.155745] Dynamic subtest smem0: SUCCESS (1.825s)
[115.156577] Subtest mmap-boundaries: SUCCESS (2.130s)
[115.471714] [007/130] (915s left) kms_plane (pixel-format-4-tiled-modifier)
[116.955364] Starting subtest: pixel-format-4-tiled-modifier
[116.957411] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[117.064172] [008/130] (913s left) kms_big_fb (linear-8bpp-rotate-270)
[118.579735] Starting subtest: linear-8bpp-rotate-270
[118.689567] Subtest linear-8bpp-rotate-270: SKIP (0.108s)
[118.849210] [009/130] (911s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[118.899789] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[118.990251] [010/130] (911s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[120.473661] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[120.474564] Starting dynamic subtest: pipe-A-HDMI-A-4
[120.483501] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[120.491984] Starting dynamic subtest: pipe-B-HDMI-A-4
[120.500783] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[120.509100] Starting dynamic subtest: pipe-C-HDMI-A-4
[120.517152] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[120.525258] Starting dynamic subtest: pipe-D-HDMI-A-4
[120.533202] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[120.534824] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[120.721206] [011/130] (910s left) gem_exec_balancer (indices)
[120.777803] Starting subtest: indices
[122.873193] Subtest indices: SUCCESS (2.095s)
[123.287340] [012/130] (907s left) gem_render_copy (yf-tiled-ccs-to-linear)
[123.339527] Starting subtest: yf-tiled-ccs-to-linear
[123.340385] Starting dynamic subtest: smem
[123.426940] Dynamic subtest smem: SUCCESS (0.087s)
[123.435355] Starting dynamic subtest: lmem0
[123.737128] Dynamic subtest lmem0: SUCCESS (0.307s)
[123.738349] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.395s)
[124.009217] [013/130] (907s left) i915_pm_rps (reset)
[124.061768] Starting subtest: reset
[128.768627] Subtest reset: SUCCESS (4.707s)
[128.921144] [014/130] (902s left) perf (polling)
[129.043322] Starting subtest: polling
[129.044258] Starting dynamic subtest: 0-rcs0
[139.089562] Dynamic subtest 0-rcs0: SUCCESS (10.043s)
[139.090630] Subtest polling: SUCCESS (10.043s)
[139.153185] [015/130] (892s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[140.637958] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[140.638988] Starting dynamic subtest: pipe-A-HDMI-A-4
[140.663430] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[140.672681] Starting dynamic subtest: pipe-B-HDMI-A-4
[140.698116] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[140.707077] Starting dynamic subtest: pipe-C-HDMI-A-4
[140.733976] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[140.743104] Starting dynamic subtest: pipe-D-HDMI-A-4
[140.769077] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[140.771106] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.017s)
[140.883631] [016/130] (890s left) perf_pmu (interrupts)
[140.932391] Starting subtest: interrupts
[142.151252] Subtest interrupts: SUCCESS (1.216s)
[142.304398] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[142.306648] [017/130] (888s left) fbdev (unaligned-write)
[142.356866] Starting subtest: unaligned-write
[142.548522] Subtest unaligned-write: SUCCESS (0.188s)
[142.636507] [018/130] (888s left) perf (gen12-mi-rpc)
[142.749219] Starting subtest: gen12-mi-rpc
[142.750033] Starting dynamic subtest: rcs0
[142.795991] Dynamic subtest rcs0: SUCCESS (0.046s)
[142.796816] Subtest gen12-mi-rpc: SUCCESS (0.047s)
[142.869870] [019/130] (888s left) gem_pwrite_snooped
[143.062532] [020/130] (888s left) kms_psr (fbc-psr-cursor-blt)
[144.546892] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[144.617101] [021/130] (886s left) syncobj_timeline (reset-multiple-signaled)
[144.663311] Starting subtest: reset-multiple-signaled
[144.665101] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[144.772631] [022/130] (886s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[144.816839] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[144.817786] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[144.931421] [023/130] (886s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[146.416248] Starting subtest: basic-flip-before-cursor-atomic
[147.412823] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.996s)
[147.592731] [024/130] (884s left) gem_exec_schedule (preempt-other-chain)
[147.654443] Starting subtest: preempt-other-chain
[147.655281] Starting dynamic subtest: rcs0
[147.816966] Dynamic subtest rcs0: SUCCESS (0.159s)
[147.827960] Starting dynamic subtest: bcs0
[147.959184] Dynamic subtest bcs0: SUCCESS (0.142s)
[147.969455] Starting dynamic subtest: vcs0
[148.098415] Dynamic subtest vcs0: SUCCESS (0.139s)
[148.108985] Starting dynamic subtest: vcs1
[148.239619] Dynamic subtest vcs1: SUCCESS (0.141s)
[148.249987] Starting dynamic subtest: vecs0
[148.380957] Dynamic subtest vecs0: SUCCESS (0.141s)
[148.382214] Subtest preempt-other-chain: SUCCESS (0.723s)
[148.840136] [025/130] (883s left) gem_exec_capture (capture-invisible)
[148.890907] Starting subtest: capture-invisible
[148.891964] Starting dynamic subtest: lmem0
[148.893977] Dynamic subtest lmem0: SKIP (0.000s)
[148.904542] Starting dynamic subtest: smem0
[148.906783] Dynamic subtest smem0: SKIP (0.000s)
[148.909191] Subtest capture-invisible: SKIP (0.001s)
[149.070542] [026/130] (882s left) i915_drm_fdinfo (idle)
[149.120878] Starting subtest: idle
[149.121810] Starting dynamic subtest: rcs0
[149.680178] Dynamic subtest rcs0: SUCCESS (0.562s)
[149.693130] Starting dynamic subtest: bcs0
[150.188343] Dynamic subtest bcs0: SUCCESS (0.503s)
[150.198445] Starting dynamic subtest: vcs0
[150.693721] Dynamic subtest vcs0: SUCCESS (0.505s)
[150.703962] Starting dynamic subtest: vcs1
[151.199740] Dynamic subtest vcs1: SUCCESS (0.505s)
[151.209962] Starting dynamic subtest: vecs0
[151.705782] Dynamic subtest vecs0: SUCCESS (0.505s)
[151.706675] Subtest idle: SUCCESS (2.585s)
[151.837947] [027/130] (880s left) i915_selftest (live)
[152.728436] Starting subtest: live
[152.729411] Starting dynamic subtest: sanitycheck
[154.137688] Dynamic subtest sanitycheck: SUCCESS (1.409s)
[154.146389] Starting dynamic subtest: uncore
[155.550644] Dynamic subtest uncore: SUCCESS (1.413s)
[155.559368] Starting dynamic subtest: workarounds
[158.912881] Dynamic subtest workarounds: SUCCESS (3.362s)
[158.921709] Starting dynamic subtest: gt_engines
[160.890039] Dynamic subtest gt_engines: SUCCESS (1.974s)
[160.898533] Starting dynamic subtest: gt_timelines
[227.073849] Dynamic subtest gt_timelines: SUCCESS (66.185s)
[227.082664] Starting dynamic subtest: gt_contexts
[228.507781] Dynamic subtest gt_contexts: SUCCESS (1.433s)
[228.516308] Starting dynamic subtest: gt_lrc
[234.565842] Dynamic subtest gt_lrc: SUCCESS (6.058s)
[234.574273] Starting dynamic subtest: gt_mocs
[236.864798] Dynamic subtest gt_mocs: SUCCESS (2.298s)
[236.873180] Starting dynamic subtest: gt_pm
[240.898777] Dynamic subtest gt_pm: SUCCESS (4.034s)
[240.907402] Starting dynamic subtest: gt_heartbeat
[242.310770] Dynamic subtest gt_heartbeat: SUCCESS (1.411s)
[242.319256] Starting dynamic subtest: gt_tlb
[256.042063] Dynamic subtest gt_tlb: SUCCESS (13.731s)
[256.050386] Starting dynamic subtest: requests
[266.820115] Dynamic subtest requests: SUCCESS (10.777s)
[266.828381] Starting dynamic subtest: migrate
[271.418713] Dynamic subtest migrate: SUCCESS (4.598s)
[271.427837] Starting dynamic subtest: active
[272.823685] Dynamic subtest active: SUCCESS (1.404s)
[272.832587] Starting dynamic subtest: objects
[275.160330] Dynamic subtest objects: SUCCESS (2.339s)
[275.169499] Starting dynamic subtest: mman
[278.690651] Dynamic subtest mman: SUCCESS (3.526s)
[278.699490] Starting dynamic subtest: dmabuf
[280.152829] Dynamic subtest dmabuf: SUCCESS (1.461s)
[280.161494] Starting dynamic subtest: vma
[281.532776] Dynamic subtest vma: SUCCESS (1.379s)
[281.541621] Starting dynamic subtest: coherency
[291.545667] Dynamic subtest coherency: SUCCESS (10.015s)
[291.554803] Starting dynamic subtest: gtt
[300.600315] Dynamic subtest gtt: SUCCESS (9.051s)
[300.608564] Starting dynamic subtest: gem
[302.160760] Dynamic subtest gem: SUCCESS (1.560s)
[302.169553] Starting dynamic subtest: evict
[313.652040] Dynamic subtest evict: SUCCESS (11.490s)
[313.660589] Starting dynamic subtest: hugepages
[331.077150] Dynamic subtest hugepages: SUCCESS (17.424s)
[331.086259] Starting dynamic subtest: gem_contexts
[358.854449] Dynamic subtest gem_contexts: SUCCESS (27.776s)
[358.863474] Starting dynamic subtest: client
[360.337617] Dynamic subtest client: SUCCESS (1.482s)
[360.346332] Starting dynamic subtest: gem_migrate
[362.933809] Dynamic subtest gem_migrate: SUCCESS (2.595s)
[362.942848] Starting dynamic subtest: reset
[364.388818] Dynamic subtest reset: SUCCESS (1.454s)
[364.397388] Starting dynamic subtest: memory_region
[367.398816] Dynamic subtest memory_region: SUCCESS (3.009s)
[367.407445] Starting dynamic subtest: hangcheck
[395.364928] Dynamic subtest hangcheck: SUCCESS (27.965s)
[395.373484] Starting dynamic subtest: execlists
[396.743828] Dynamic subtest execlists: SUCCESS (1.378s)
[396.752841] Starting dynamic subtest: ring_submission
[398.144655] Dynamic subtest ring_submission: SUCCESS (1.400s)
[398.153363] Starting dynamic subtest: perf
[399.690853] Dynamic subtest perf: SUCCESS (1.545s)
[399.700333] Starting dynamic subtest: slpc
[405.555796] Dynamic subtest slpc: SUCCESS (5.864s)
[405.564887] Starting dynamic subtest: guc
[409.044971] Dynamic subtest guc: SUCCESS (3.488s)
[409.053990] Starting dynamic subtest: guc_multi_lrc
[410.479851] Dynamic subtest guc_multi_lrc: SUCCESS (1.434s)
[410.488410] Starting dynamic subtest: guc_hang
[412.654640] Dynamic subtest guc_hang: SUCCESS (2.174s)
[412.662983] Starting dynamic subtest: late_gt_pm
[414.091535] Dynamic subtest late_gt_pm: SUCCESS (1.436s)
[414.092443] Subtest live: SUCCESS (261.359s)
[414.134077] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[414.135483] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[414.137922] [028/130] (617s left) kms_rotation_crc (sprite-rotation-270)
[418.912139] Starting subtest: sprite-rotation-270
[429.185147] Subtest sprite-rotation-270: SUCCESS (10.274s)
[429.485995] [FACT kms_rotation_crc (sprite-rotation-270)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[429.489389] [FACT kms_rotation_crc (sprite-rotation-270)] new: kernel.kmod_is_loaded.i915: true
[429.492565] [029/130] (602s left) perf (whitelisted-registers-userspace-config)
[429.624187] Starting subtest: whitelisted-registers-userspace-config
[429.624985] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[429.703532] [030/130] (602s left) kms_invalid_mode (bad-vsync-end)
[431.188542] Starting subtest: bad-vsync-end
[431.191580] Starting dynamic subtest: pipe-A-HDMI-A-4
[431.228307] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.038s)
[431.240446] Starting dynamic subtest: pipe-B-HDMI-A-4
[431.241411] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[431.251669] Starting dynamic subtest: pipe-C-HDMI-A-4
[431.252867] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[431.264046] Starting dynamic subtest: pipe-D-HDMI-A-4
[431.265034] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[431.265927] Subtest bad-vsync-end: SUCCESS (0.051s)
[431.413339] [031/130] (600s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[432.905788] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[432.907350] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[433.078392] [032/130] (599s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[434.571325] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[434.573339] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[434.761910] [033/130] (597s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[434.808927] Starting subtest: etime-multi-wait-all-for-submit-submitted
[434.921639] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[435.068416] [034/130] (597s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[436.557788] Starting subtest: fbcpsr-slowdraw
[436.559329] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[436.738967] [035/130] (596s left) kms_draw_crc (draw-method-blt)
[438.226977] Starting subtest: draw-method-blt
[438.227944] Starting dynamic subtest: xrgb8888-untiled
[438.593792] Dynamic subtest xrgb8888-untiled: SUCCESS (0.366s)
[438.631714] Starting dynamic subtest: rgb565-untiled
[438.943762] Dynamic subtest rgb565-untiled: SUCCESS (0.343s)
[438.974890] Starting dynamic subtest: xrgb2101010-untiled
[439.260811] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.310s)
[439.301345] Starting dynamic subtest: xbgr16161616f-untiled
[439.577203] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.309s)
[439.624369] Starting dynamic subtest: xrgb8888-xtiled
[439.760369] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.176s)
[439.794274] Starting dynamic subtest: rgb565-xtiled
[439.927097] Dynamic subtest rgb565-xtiled: SUCCESS (0.160s)
[439.970067] Starting dynamic subtest: xrgb2101010-xtiled
[440.093612] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.159s)
[440.138510] Starting dynamic subtest: xbgr16161616f-xtiled
[440.260624] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.160s)
[440.300800] Starting dynamic subtest: xrgb8888-ytiled
[440.443538] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.176s)
[440.488325] Starting dynamic subtest: rgb565-ytiled
[440.626982] Dynamic subtest rgb565-ytiled: SUCCESS (0.176s)
[440.669848] Starting dynamic subtest: xrgb2101010-ytiled
[440.793516] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.159s)
[440.838376] Starting dynamic subtest: xbgr16161616f-ytiled
[440.960488] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.160s)
[440.969118] Subtest draw-method-blt: SUCCESS (2.738s)
[441.217544] [036/130] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[442.709150] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[442.710937] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[442.883517] [037/130] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[444.375822] Starting subtest: fbcpsr-2p-rte
[444.377433] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[444.550931] [038/130] (588s left) kms_chamelium_frames (hdmi-frame-dump)
[446.084282] Subtest hdmi-frame-dump: SKIP (0.000s)
[446.223288] [039/130] (586s left) gem_mmap_wc (read)
[446.271334] Subtest read: SKIP (0.000s)
[446.347433] [040/130] (586s left) prime_vgem (fence-flip-hang)
[446.421740] Subtest fence-flip-hang: SKIP (0.000s)
[446.589910] [041/130] (586s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[448.075489] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[448.077085] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[448.189804] [042/130] (585s left) gem_busy (close-race)
[448.254205] Starting subtest: close-race
[470.496739] Subtest close-race: SUCCESS (22.242s)
[471.084555] [043/130] (562s left) kms_atomic (plane-cursor-legacy)
[472.626437] Starting subtest: plane-cursor-legacy
[472.627258] Starting dynamic subtest: pipe-A-HDMI-A-4
[472.990905] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.363s)
[472.991792] Subtest plane-cursor-legacy: SUCCESS (0.366s)
[473.168784] [044/130] (560s left) gem_exec_fence (nb-await)
[473.347502] Starting subtest: nb-await
[473.348363] Starting dynamic subtest: rcs0
[473.433163] Dynamic subtest rcs0: SUCCESS (0.086s)
[473.448603] Starting dynamic subtest: bcs0
[473.500475] Dynamic subtest bcs0: SUCCESS (0.065s)
[473.530057] Starting dynamic subtest: vcs0
[473.579439] Dynamic subtest vcs0: SUCCESS (0.075s)
[473.597861] Starting dynamic subtest: vcs1
[473.648557] Dynamic subtest vcs1: SUCCESS (0.063s)
[473.673447] Starting dynamic subtest: vecs0
[473.723744] Dynamic subtest vecs0: SUCCESS (0.072s)
[473.732202] Subtest nb-await: SUCCESS (0.381s)
[474.461081] [045/130] (559s left) gem_ctx_engines (none)
[474.519446] Starting subtest: none
[474.520469] Subtest none: SUCCESS (0.002s)
[474.771462] [046/130] (559s left) kms_psr (pr-primary-mmap-gtt)
[476.268272] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[476.345483] [047/130] (557s left) gem_mmap_wc (invalid-flags)
[476.390216] Subtest invalid-flags: SKIP (0.000s)
[476.462490] [048/130] (557s left) gem_mmap_wc (write-prefaulted)
[476.508158] Subtest write-prefaulted: SKIP (0.000s)
[476.580133] [049/130] (557s left) drm_read (short-buffer-block)
[478.134832] Starting subtest: short-buffer-block
[478.135717] Subtest short-buffer-block: SUCCESS (0.000s)
[478.385631] [050/130] (555s left) gem_ctx_persistence (file)
[478.442456] Starting subtest: file
[478.548201] Subtest file: SUCCESS (0.104s)
[478.764467] [051/130] (555s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[480.250473] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[480.251280] Starting dynamic subtest: pipe-A
[482.450243] Dynamic subtest pipe-A: SUCCESS (2.200s)
[482.463465] Starting dynamic subtest: pipe-B
[484.673677] Dynamic subtest pipe-B: SUCCESS (2.222s)
[484.690494] Starting dynamic subtest: pipe-C
[484.965360] Dynamic subtest pipe-C: SUCCESS (0.290s)
[484.980439] Starting dynamic subtest: pipe-D
[485.255218] Dynamic subtest pipe-D: SUCCESS (0.288s)
[485.258584] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.007s)
[485.463535] [052/130] (548s left) core_getclient (basic)
[485.513168] Starting subtest: basic
[485.514196] Subtest basic: SUCCESS (0.000s)
[485.635488] [053/130] (548s left) vgem_basic (bad-handle)
[485.695651] Starting subtest: bad-handle
[485.696632] Subtest bad-handle: SUCCESS (0.000s)
[485.798970] [054/130] (548s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[487.285543] Starting subtest: 2x-long-flip-vs-cursor-legacy
[487.288188] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[487.399972] [055/130] (547s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[488.893909] Starting subtest: basic-busy-flip-before-cursor-varying-size
[488.895720] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[489.024676] [056/130] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[490.526311] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[490.527981] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[490.702011] [057/130] (543s left) perf_pmu (rc6)
[490.754572] Starting subtest: rc6
[490.755520] Starting dynamic subtest: gt0
[497.099948] Dynamic subtest gt0: SUCCESS (6.341s)
[497.111264] Starting dynamic subtest: runtime-pm-gt0
[504.729357] Dynamic subtest runtime-pm-gt0: SUCCESS (7.624s)
[504.740421] Starting dynamic subtest: runtime-pm-long-gt0
[517.290785] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.561s)
[517.302484] Starting dynamic subtest: other-idle-gt0
[517.304097] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[517.304908] Subtest rc6: SUCCESS (26.535s)
[517.964627] [058/130] (516s left) gem_mmap (bad-offset)
[518.009834] Subtest bad-offset: SKIP (0.000s)
[518.088256] [059/130] (516s left) kms_chamelium_color (ctm-0-25)
[519.576164] Subtest ctm-0-25: SKIP (0.000s)
[519.653847] [060/130] (515s left) kms_lease (implicit-plane-lease)
[521.141551] Starting subtest: implicit-plane-lease
[521.144248] Subtest implicit-plane-lease: SUCCESS (0.003s)
[521.224328] [061/130] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[522.714735] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[522.716323] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[522.807944] [062/130] (512s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[524.299320] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[524.317839] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.018s)
[524.391449] [063/130] (510s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[525.879821] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[525.953521] [064/130] (509s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[527.438245] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[529.226506] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.788s)
[529.370764] [065/130] (505s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[529.424606] Starting subtest: rel-constants-invalid-rel-gen5
[529.425451] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[529.518415] [066/130] (505s left) gem_exec_fence (basic-wait-all)
[529.575852] Starting subtest: basic-wait-all
[529.672219] Subtest basic-wait-all: SUCCESS (0.096s)
[530.382625] [067/130] (505s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[531.873299] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[531.891641] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.017s)
[531.967456] [068/130] (503s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[533.453326] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[533.454230] Starting dynamic subtest: pipe-A-HDMI-A-4
[533.461233] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[533.472925] Starting dynamic subtest: pipe-B-HDMI-A-4
[533.480102] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[533.491600] Starting dynamic subtest: pipe-C-HDMI-A-4
[533.498566] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[533.509848] Starting dynamic subtest: pipe-D-HDMI-A-4
[533.517126] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[533.517916] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.013s)
[533.682064] [069/130] (501s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[533.736441] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[533.737381] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[533.811813] [070/130] (501s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[535.297634] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[535.375754] [071/130] (500s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[536.885589] Starting subtest: x-tiled-32bpp-rotate-180
[538.834323] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.944s)
[538.979899] [072/130] (496s left) gem_exec_reloc (basic-write-cpu)
[539.032234] Subtest basic-write-cpu: SKIP (0.000s)
[539.125646] [073/130] (496s left) kms_flip (2x-flip-vs-panning)
[540.609242] Starting subtest: 2x-flip-vs-panning
[540.627461] Subtest 2x-flip-vs-panning: SKIP (0.017s)
[540.712828] [074/130] (495s left) core_sysfs (read-all-entries)
[540.757801] Starting subtest: read-all-entries
[540.764139] Subtest read-all-entries: SUCCESS (0.007s)
[540.845272] [075/130] (495s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[542.351237] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[542.946497] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.596s)
[543.125833] [076/130] (492s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[544.630435] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[544.631992] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[544.734648] [077/130] (491s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[546.229969] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[546.231591] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[546.330325] [078/130] (489s left) gem_exec_schedule (deep)
[546.562133] Starting subtest: deep
[546.566899] Starting dynamic subtest: rcs0
[562.430297] Dynamic subtest rcs0: SUCCESS (15.873s)
[562.442162] Starting dynamic subtest: bcs0
[578.745414] Dynamic subtest bcs0: SUCCESS (16.314s)
[578.757347] Starting dynamic subtest: vcs0
[595.011728] Dynamic subtest vcs0: SUCCESS (16.265s)
[595.023781] Starting dynamic subtest: vcs1
[611.244625] Dynamic subtest vcs1: SUCCESS (16.230s)
[611.261991] Starting dynamic subtest: vecs0
[627.632284] Dynamic subtest vecs0: SUCCESS (16.382s)
[627.633192] Subtest deep: SUCCESS (81.078s)
[628.595243] [079/130] (407s left) syncobj_timeline (etime-single-wait-submitted)
[628.643529] Starting subtest: etime-single-wait-submitted
[628.753448] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[628.828293] [080/130] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[630.319951] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[630.322158] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[630.446653] [081/130] (405s left) api_intel_bb (blit-reloc-purge-cache)
[630.509136] Starting subtest: blit-reloc-purge-cache
[630.511192] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[630.614533] [082/130] (405s left) syncobj_timeline (signal)
[630.662577] Starting subtest: signal
[630.663571] Subtest signal: SUCCESS (0.000s)
[630.746424] [083/130] (405s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[632.234150] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[632.309302] [084/130] (404s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[633.815454] Starting subtest: y-tiled-32bpp-rotate-180
[635.717110] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.899s)
[635.878972] [085/130] (400s left) kms_pm_dc (dc9-dpms)
[638.374121] Starting subtest: dc9-dpms
[638.727644] Subtest dc9-dpms: SUCCESS (0.352s)
[638.837415] [086/130] (397s left) gem_exercise_blt (fast-copy-emit)
[638.889019] Starting subtest: fast-copy-emit
[638.889762] Starting dynamic subtest: linear-smem-smem-emit
[638.922876] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.033s)
[638.935828] Starting dynamic subtest: linear-smem-lmem0-emit
[638.939516] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[638.952278] Starting dynamic subtest: linear-lmem0-smem-emit
[639.001809] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.061s)
[639.014660] Starting dynamic subtest: linear-lmem0-lmem0-emit
[639.061830] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.059s)
[639.074642] Starting dynamic subtest: ymajor-smem-smem-emit
[639.078794] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s)
[639.091689] Starting dynamic subtest: ymajor-smem-lmem0-emit
[639.094323] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s)
[639.107141] Starting dynamic subtest: ymajor-lmem0-smem-emit
[639.155237] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.059s)
[639.168109] Starting dynamic subtest: ymajor-lmem0-lmem0-emit
[639.215755] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.059s)
[639.228908] Starting dynamic subtest: tile4-smem-smem-emit
[639.232720] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[639.245733] Starting dynamic subtest: tile4-smem-lmem0-emit
[639.248152] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[639.262552] Starting dynamic subtest: tile4-lmem0-smem-emit
[639.308968] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.059s)
[639.322036] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[639.368477] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.058s)
[639.381661] Starting dynamic subtest: tile64-smem-smem-emit
[639.384667] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[639.397684] Starting dynamic subtest: tile64-smem-lmem0-emit
[639.400115] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[639.413180] Starting dynamic subtest: tile64-lmem0-smem-emit
[639.476493] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.075s)
[639.489947] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[639.536695] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.059s)
[639.537468] Subtest fast-copy-emit: SUCCESS (0.648s)
[639.648841] [087/130] (397s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[639.703284] Starting subtest: y-tiled-to-vebox-x-tiled
[639.704126] Starting dynamic subtest: smem
[639.787712] Dynamic subtest smem: SUCCESS (0.084s)
[639.801141] Starting dynamic subtest: lmem0
[640.539402] Dynamic subtest lmem0: SUCCESS (0.747s)
[640.540315] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.834s)
[640.772587] [088/130] (396s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[642.257422] Starting subtest: cursorB-vs-flipB-varying-size
[642.259219] Subtest cursorB-vs-flipB-varying-size: SKIP (0.002s)
[642.339023] [089/130] (394s left) perf_pmu (idle)
[642.389390] Starting subtest: idle
[642.390250] Starting dynamic subtest: rcs0
[642.946177] Dynamic subtest rcs0: SUCCESS (0.552s)
[642.959633] Starting dynamic subtest: bcs0
[643.464208] Dynamic subtest bcs0: SUCCESS (0.513s)
[643.477627] Starting dynamic subtest: vcs0
[643.983183] Dynamic subtest vcs0: SUCCESS (0.514s)
[643.996575] Starting dynamic subtest: vcs1
[644.499199] Dynamic subtest vcs1: SUCCESS (0.511s)
[644.512605] Starting dynamic subtest: vecs0
[645.015215] Dynamic subtest vecs0: SUCCESS (0.511s)
[645.016078] Subtest idle: SUCCESS (2.626s)
[645.089492] [090/130] (391s left) gem_userptr_blits (stress-purge)
[645.150946] Starting subtest: stress-purge
[650.536681] Subtest stress-purge: SUCCESS (5.385s)
[650.670983] [091/130] (386s left) kms_plane_multiple (2x-tiling-yf)
[652.221290] Starting subtest: 2x-tiling-yf
[652.223022] Subtest 2x-tiling-yf: SKIP (0.000s)
[652.305687] [092/130] (384s left) kms_psr (psr2-cursor-plane-move)
[653.792226] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[653.870957] [093/130] (383s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[653.924251] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[653.925123] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[654.006520] [094/130] (383s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[655.493650] Starting subtest: nonblocking-crc-frame-sequence
[655.494570] Starting dynamic subtest: pipe-A-HDMI-A-4
[656.228842] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.734s)
[656.242854] Starting dynamic subtest: pipe-B-HDMI-A-4
[656.792128] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.561s)
[656.806083] Starting dynamic subtest: pipe-C-HDMI-A-4
[657.375253] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.580s)
[657.389237] Starting dynamic subtest: pipe-D-HDMI-A-4
[657.947887] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.570s)
[657.948750] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.456s)
[658.123645] [095/130] (379s left) gem_exec_reloc (basic-cpu-read)
[658.176705] Subtest basic-cpu-read: SKIP (0.000s)
[658.266147] [096/130] (379s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[659.751807] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[659.752705] Starting dynamic subtest: pipe-A
[662.402789] Dynamic subtest pipe-A: SUCCESS (2.652s)
[662.426305] Starting dynamic subtest: pipe-B
[664.894970] Dynamic subtest pipe-B: SUCCESS (2.490s)
[664.923876] Starting dynamic subtest: pipe-C
[665.202461] Dynamic subtest pipe-C: SUCCESS (0.304s)
[665.217502] Starting dynamic subtest: pipe-D
[665.492417] Dynamic subtest pipe-D: SUCCESS (0.288s)
[665.493547] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.743s)
[665.669110] [097/130] (371s left) kms_chamelium_hpd (vga-hpd)
[667.207456] Subtest vga-hpd: SKIP (0.000s)
[667.328236] [098/130] (370s left) gem_exec_schedule (preempt-queue-contexts-chain)
[667.393011] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[667.762249] [099/130] (369s left) kms_cursor_crc (cursor-onscreen-64x21)
[669.403256] Starting subtest: cursor-onscreen-64x21
[669.409602] Starting dynamic subtest: pipe-A-HDMI-A-4
[672.215150] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.805s)
[672.252406] Starting dynamic subtest: pipe-D-HDMI-A-4
[674.881825] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.640s)
[674.882870] Subtest cursor-onscreen-64x21: SUCCESS (5.478s)
[675.317589] [100/130] (362s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[675.369381] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[675.445934] [101/130] (362s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[676.956561] Starting subtest: yf-tiled-64bpp-rotate-0
[676.958305] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[677.080750] [102/130] (360s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[678.581154] Starting subtest: fbcpsr-indfb-scaledprimary
[678.582707] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[678.683213] [103/130] (359s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[680.175462] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[680.177086] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[680.287251] [104/130] (357s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[681.779548] Starting subtest: async-flip-with-page-flip-events-linear
[682.045874] Starting dynamic subtest: pipe-A-HDMI-A-4
[684.352425] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.302s)
[684.543529] Starting dynamic subtest: pipe-B-HDMI-A-4
[686.595072] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.058s)
[686.780534] Starting dynamic subtest: pipe-C-HDMI-A-4
[688.829403] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.057s)
[689.009044] Starting dynamic subtest: pipe-D-HDMI-A-4
[691.065201] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.064s)
[691.066115] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.285s)
[691.368381] [105/130] (346s left) gem_mmap_gtt (basic-write)
[691.415799] Subtest basic-write: SKIP (0.000s)
[691.528617] [106/130] (346s left) kms_scaling_modes (scaling-mode-none)
[693.013448] Starting subtest: scaling-mode-none
[693.018366] Subtest scaling-mode-none: SKIP (0.002s)
[693.098204] [107/130] (345s left) kms_vblank (ts-continuation-modeset-hang)
[694.589316] Starting subtest: ts-continuation-modeset-hang
[694.591938] Starting dynamic subtest: pipe-A-HDMI-A-4
[721.518849] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.928s)
[721.534786] Starting dynamic subtest: pipe-D-HDMI-A-4
[746.451323] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.927s)
[746.452167] Subtest ts-continuation-modeset-hang: SUCCESS (51.864s)
[746.604306] [108/130] (291s left) kms_flip_event_leak (basic)
[748.091292] Starting subtest: basic
[748.092164] Starting dynamic subtest: pipe-A-HDMI-A-4
[748.460319] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.367s)
[748.475033] Starting dynamic subtest: pipe-B-HDMI-A-4
[748.673597] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.211s)
[748.689126] Starting dynamic subtest: pipe-C-HDMI-A-4
[748.900869] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.223s)
[748.915961] Starting dynamic subtest: pipe-D-HDMI-A-4
[749.102795] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.199s)
[749.103813] Subtest basic: SUCCESS (1.013s)
[749.242769] [109/130] (289s left) gem_tiled_partial_pwrite_pread (writes)
[749.293879] Subtest writes: SKIP (0.000s)
[749.400275] [110/130] (289s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[750.886073] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[750.886956] Starting dynamic subtest: pipe-A-HDMI-A-4
[750.890253] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[750.902252] Starting dynamic subtest: pipe-B-HDMI-A-4
[750.905602] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[750.917332] Starting dynamic subtest: pipe-C-HDMI-A-4
[750.920608] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[750.932085] Starting dynamic subtest: pipe-D-HDMI-A-4
[750.935759] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[750.937506] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.011s)
[751.124070] [111/130] (287s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[752.610425] Starting subtest: cursorB-vs-flipA-atomic-transitions
[752.613836] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.003s)
[752.687550] [112/130] (286s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[754.176992] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[756.595233] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.417s)
[756.747216] [113/130] (282s left) kms_color (legacy-gamma)
[758.232235] Starting subtest: legacy-gamma
[758.233135] Starting dynamic subtest: pipe-A-HDMI-A-4
[758.959983] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.727s)
[758.972114] Starting dynamic subtest: pipe-B-HDMI-A-4
[759.472284] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.510s)
[759.484318] Starting dynamic subtest: pipe-C-HDMI-A-4
[759.995124] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.521s)
[760.007327] Starting dynamic subtest: pipe-D-HDMI-A-4
[760.529181] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.533s)
[760.529993] Subtest legacy-gamma: SUCCESS (2.298s)
[760.679345] [114/130] (278s left) gem_userptr_blits (forbidden-operations)
[760.732505] Starting subtest: forbidden-operations
[760.734150] Subtest forbidden-operations: SKIP (0.000s)
[760.879995] [115/130] (278s left) gem_ctx_param (invalid-get-engines)
[760.925403] Starting subtest: invalid-get-engines
[760.926262] Subtest invalid-get-engines: SUCCESS (0.001s)
[761.012388] [116/130] (278s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[762.500997] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[762.502809] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[762.591908] [117/130] (276s left) syncobj_wait (single-wait-all-submitted)
[762.639495] Starting subtest: single-wait-all-submitted
[762.744868] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[762.887929] [118/130] (276s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[764.377435] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[764.378952] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[764.478898] [119/130] (274s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[765.971927] Starting subtest: psr-rgb565-draw-mmap-gtt
[765.973716] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[766.079417] [120/130] (273s left) kms_content_protection (dp-mst-type-1)
[767.627896] Starting subtest: dp-mst-type-1
[767.629558] Subtest dp-mst-type-1: SKIP (0.000s)
[767.775451] [121/130] (271s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[769.265960] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[769.267804] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[769.359122] [122/130] (270s left) gem_exec_schedule (wide)
[769.582613] Starting subtest: wide
[769.584033] Starting dynamic subtest: rcs0
[784.947205] Dynamic subtest rcs0: SUCCESS (15.363s)
[784.963388] Starting dynamic subtest: bcs0
[801.404643] Dynamic subtest bcs0: SUCCESS (16.453s)
[801.420678] Starting dynamic subtest: vcs0
[817.433260] Dynamic subtest vcs0: SUCCESS (16.028s)
[817.445808] Starting dynamic subtest: vcs1
[833.206663] Dynamic subtest vcs1: SUCCESS (15.772s)
[833.219165] Starting dynamic subtest: vecs0
[849.035024] Dynamic subtest vecs0: SUCCESS (15.816s)
[849.035996] Subtest wide: SUCCESS (79.448s)
[850.474725] [123/130] (189s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[851.980667] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[853.080024] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.095s)
[853.230420] [124/130] (186s left) prime_self_import (basic-llseek-bad)
[853.274622] Starting subtest: basic-llseek-bad
[853.277822] Subtest basic-llseek-bad: SUCCESS (0.003s)
[853.374467] [125/130] (186s left) gem_softpin (zero)
[853.425144] Starting subtest: zero
[853.431040] Subtest zero: SUCCESS (0.006s)
[853.555324] [126/130] (186s left) i915_getparams_basic (basic-subslice-total)
[853.600688] Starting subtest: basic-subslice-total
[853.602272] Subtest basic-subslice-total: SUCCESS (0.000s)
[853.674949] [127/130] (186s left) gem_exec_params (dr4-dirt)
[853.725786] Starting subtest: DR4-dirt
[853.726744] Subtest DR4-dirt: SUCCESS (0.000s)
[853.839892] [128/130] (186s left) prime_busy (hang)
[853.891477] Starting subtest: hang
[853.892312] Starting dynamic subtest: rcs0
[880.436957] Dynamic subtest rcs0: SUCCESS (26.545s)
[880.450500] Starting dynamic subtest: bcs0
[887.588331] Dynamic subtest bcs0: SUCCESS (7.149s)
[887.600439] Starting dynamic subtest: vcs0
[894.563420] Dynamic subtest vcs0: SUCCESS (6.975s)
[894.576939] Starting dynamic subtest: vcs1
[901.540059] Dynamic subtest vcs1: SUCCESS (6.974s)
[901.551910] Starting dynamic subtest: vecs0
[908.577400] Dynamic subtest vecs0: SUCCESS (7.037s)
[908.579826] Subtest hang: SUCCESS (54.688s)
[908.674458] [129/130] (131s left) gem_exec_flush (basic-wb-rw-before-default)
[908.726040] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[908.823347] [130/130] (131s left) gen9_exec_parse (basic-rejected)
[908.874133] Subtest basic-rejected: SKIP (0.000s)
[908.953910] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: i915_pm_rps
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_pwrite_snooped
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: gem_exec_capture
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: i915_selftest
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_draw_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_busy
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: gem_ctx_engines
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: core_getclient
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_mmap
results: parsing output: 58/ for test: kms_chamelium_color
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: core_sysfs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: gem_exercise_blt
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_pipe_crc_basic
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_fenced_exec_thrash
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_async_flips
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_scaling_modes
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_flip_event_leak
results: parsing output: 108/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: i915_getparams_basic
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: prime_busy
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: gen9_exec_parse
Done.