[63.433618] Initializing watchdogs
[63.433702]   /dev/watchdog0
[63.464950] [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.480472] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.485294] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.488515] [001/154] (960s left) kms_chamelium_frames (dp-crc-single)
[65.031677] Subtest dp-crc-single: SKIP (0.000s)
[65.226694] [002/154] (958s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[66.723428] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[66.725490] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[66.893652] [003/154] (957s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[68.409218] Starting subtest: y-tiled-64bpp-rotate-270
[68.493304] Subtest y-tiled-64bpp-rotate-270: SKIP (0.084s)
[68.657876] [004/154] (955s left) kms_lease (lease-get)
[70.147238] Starting subtest: lease-get
[70.148120] Starting dynamic subtest: pipe-A-HDMI-A-3
[70.149100] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.001s)
[70.158115] Starting dynamic subtest: pipe-B-HDMI-A-3
[70.159096] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[70.167445] Starting dynamic subtest: pipe-C-HDMI-A-3
[70.168413] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[70.176616] Starting dynamic subtest: pipe-D-HDMI-A-3
[70.177548] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[70.178476] Subtest lease-get: SUCCESS (0.010s)
[70.320290] [005/154] (954s left) kms_atomic_transition (plane-toggle-modeset-transition)
[71.817651] Starting subtest: plane-toggle-modeset-transition
[71.818920] Starting dynamic subtest: pipe-A-HDMI-A-3
[72.998559] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.175s)
[73.011236] Starting dynamic subtest: pipe-B-HDMI-A-3
[73.941783] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.932s)
[73.944272] Subtest plane-toggle-modeset-transition: SUCCESS (2.126s)
[74.101915] [006/154] (950s left) kms_async_flips (async-flip-dpms)
[75.591217] Starting subtest: async-flip-dpms
[75.858886] Starting dynamic subtest: pipe-A-HDMI-A-3
[78.637949] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.779s)
[79.609144] Starting dynamic subtest: pipe-B-HDMI-A-3
[81.737950] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.140s)
[82.020405] Starting dynamic subtest: pipe-C-HDMI-A-3
[84.151536] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.144s)
[84.413580] Starting dynamic subtest: pipe-D-HDMI-A-3
[86.541673] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.160s)
[86.542554] Subtest async-flip-dpms: SUCCESS (10.952s)
[86.924802] [007/154] (937s left) gem_exec_suspend (basic-s3)
[86.988090] Starting subtest: basic-S3
[86.989051] Starting dynamic subtest: smem
[117.334281] Dynamic subtest smem: SUCCESS (14.047s)
[117.345384] Starting dynamic subtest: lmem0
[147.236637] Dynamic subtest lmem0: SUCCESS (13.825s)
[147.237808] Subtest basic-S3: SUCCESS (27.873s)
[151.508085] [008/154] (877s left) gem_create (create-clear)
[151.554653] Starting subtest: create-clear
[151.555736] Starting dynamic subtest: lmem0
[185.214673] Dynamic subtest lmem0: SUCCESS (33.653s)
[185.227341] Starting dynamic subtest: smem0
[219.125912] Dynamic subtest smem0: SUCCESS (33.914s)
[219.126927] Subtest create-clear: SUCCESS (67.567s)
[219.854709] [009/154] (808s left) gem_mmap (bad-offset)
[219.901829] Subtest bad-offset: SKIP (0.000s)
[219.966651] [010/154] (808s left) kms_cursor_edge_walk (128x128-top-edge)
[221.450854] Starting subtest: 128x128-top-edge
[221.452685] Starting dynamic subtest: pipe-A-HDMI-A-3
[224.815901] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.364s)
[224.828059] Starting dynamic subtest: pipe-D-HDMI-A-3
[228.060336] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.243s)
[228.061187] Subtest 128x128-top-edge: SUCCESS (6.610s)
[228.252044] [011/154] (800s left) gem_exec_store (dword)
[228.309592] Starting subtest: dword
[228.310530] Starting dynamic subtest: rcs0
[228.371813] Dynamic subtest rcs0: SUCCESS (0.062s)
[228.384588] Starting dynamic subtest: bcs0
[228.411834] Dynamic subtest bcs0: SUCCESS (0.039s)
[228.425878] Starting dynamic subtest: vcs0
[228.454607] Dynamic subtest vcs0: SUCCESS (0.042s)
[228.475853] Starting dynamic subtest: vcs1
[228.499855] Dynamic subtest vcs1: SUCCESS (0.045s)
[228.526543] Starting dynamic subtest: vecs0
[228.546819] Dynamic subtest vecs0: SUCCESS (0.046s)
[228.547964] Subtest dword: SUCCESS (0.237s)
[228.808664] [012/154] (800s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[229.472141] Starting subtest: syncobj-timeline-multiple-ext-nodes
[229.474057] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.008s)
[229.759845] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[229.762189] [013/154] (799s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[231.255631] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[231.257304] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[231.438320] [014/154] (797s left) kms_color (gamma)
[232.927247] Starting subtest: gamma
[232.928225] Starting dynamic subtest: pipe-A-HDMI-A-3
[233.594030] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.667s)
[233.605722] Starting dynamic subtest: pipe-B-HDMI-A-3
[234.135106] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.536s)
[234.146445] Starting dynamic subtest: pipe-C-HDMI-A-3
[234.653716] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.523s)
[234.665405] Starting dynamic subtest: pipe-D-HDMI-A-3
[235.201958] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.547s)
[235.202899] Subtest gamma: SUCCESS (2.274s)
[235.402679] [015/154] (793s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[236.899737] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[236.901455] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[237.079750] [016/154] (792s left) gem_render_tiled_blits (basic)
[237.131444] Subtest basic: SKIP (0.000s)
[237.210936] [017/154] (792s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[238.758726] Starting subtest: dp-mst-type-0-suspend-resume
[238.760564] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[238.938856] [018/154] (790s left) kms_psr (pr-sprite-blt)
[240.427631] Subtest pr-sprite-blt: SKIP (0.000s)
[240.510063] [019/154] (788s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[242.004755] Starting subtest: hdr-2p-pri-indfb-multidraw
[242.007051] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[242.180772] [020/154] (787s left) gem_mmap_offset (clear)
[242.227518] Starting subtest: clear
[242.228599] Starting dynamic subtest: lmem0
[264.341884] Dynamic subtest lmem0: SUCCESS (22.106s)
[264.354959] Starting dynamic subtest: smem0
[291.678235] Dynamic subtest smem0: SUCCESS (27.336s)
[291.679357] Subtest clear: SUCCESS (49.442s)
[291.894613] [021/154] (737s left) kms_pm_backlight (fade)
[293.453656] Subtest fade: SKIP (0.000s)
[293.532180] [022/154] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[295.029240] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[295.030951] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[295.189850] [023/154] (734s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite)
[296.687525] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite
[296.689667] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[296.866868] [024/154] (733s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[298.357232] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[298.358144] Starting dynamic subtest: pipe-A
[301.020322] Dynamic subtest pipe-A: SUCCESS (2.663s)
[301.044945] Starting dynamic subtest: pipe-B
[303.793619] Dynamic subtest pipe-B: SUCCESS (2.772s)
[303.817392] Starting dynamic subtest: pipe-C
[304.117304] Dynamic subtest pipe-C: SUCCESS (0.322s)
[304.138114] Starting dynamic subtest: pipe-D
[304.441392] Dynamic subtest pipe-D: SUCCESS (0.323s)
[304.442390] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.084s)
[304.665962] [025/154] (725s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[306.164089] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[306.165800] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[306.352959] [026/154] (723s left) gem_request_retire (retire-vma-not-inactive)
[306.405645] Starting subtest: retire-vma-not-inactive
[306.442603] Subtest retire-vma-not-inactive: SUCCESS (0.036s)
[306.656915] [027/154] (723s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[308.152522] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[308.155068] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[308.336837] [028/154] (722s left) kms_plane_multiple (2x-tiling-none)
[309.826738] Starting subtest: 2x-tiling-none
[309.828768] Subtest 2x-tiling-none: SKIP (0.000s)
[309.938513] [029/154] (720s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[311.443569] Starting subtest: psrhdr-farfromfence-mmap-gtt
[311.445527] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[311.644711] [030/154] (718s left) gem_mmap_wc (pf-nonblock)
[311.707872] Subtest pf-nonblock: SKIP (0.000s)
[311.798941] [031/154] (718s left) kms_big_fb (4-tiled-addfb)
[313.317252] Starting subtest: 4-tiled-addfb
[313.319034] Subtest 4-tiled-addfb: SKIP (0.000s)
[313.496363] [032/154] (717s left) kms_feature_discovery (display-2x)
[315.007651] Starting subtest: display-2x
[315.009572] Subtest display-2x: SKIP (0.000s)
[315.126738] [033/154] (715s left) kms_vblank (ts-continuation-idle)
[316.628477] Starting subtest: ts-continuation-idle
[316.629443] Starting dynamic subtest: pipe-A-HDMI-A-3
[316.970611] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.341s)
[316.985683] Starting dynamic subtest: pipe-D-HDMI-A-3
[317.178168] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.204s)
[317.179039] Subtest ts-continuation-idle: SUCCESS (0.551s)
[317.394546] [034/154] (713s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[318.891103] Starting subtest: fbchdr-rgb101010-draw-blt
[318.892786] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[319.115981] [035/154] (712s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[319.182965] Subtest no-spare-fences-busy: SKIP (0.000s)
[319.255613] [036/154] (711s left) kms_flip (nonexisting-fb)
[320.744943] Starting subtest: nonexisting-fb
[320.751590] Starting dynamic subtest: A-HDMI-A3
[321.190692] Dynamic subtest A-HDMI-A3: SUCCESS (0.439s)
[321.208244] Starting dynamic subtest: B-HDMI-A3
[321.388118] Dynamic subtest B-HDMI-A3: SUCCESS (0.196s)
[321.401854] Starting dynamic subtest: C-HDMI-A3
[321.588885] Dynamic subtest C-HDMI-A3: SUCCESS (0.200s)
[321.602728] Starting dynamic subtest: D-HDMI-A3
[321.790456] Dynamic subtest D-HDMI-A3: SUCCESS (0.200s)
[321.792625] Subtest nonexisting-fb: SUCCESS (1.047s)
[322.015582] [037/154] (709s left) vgem_basic (busy-fence)
[322.064945] Starting subtest: busy-fence
[322.065945] Subtest busy-fence: SUCCESS (0.000s)
[322.163055] [038/154] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[323.659270] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[323.661008] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.861388] [039/154] (707s left) gem_ctx_param (invalid-ctx-set)
[323.916692] Starting subtest: invalid-ctx-set
[323.917648] Subtest invalid-ctx-set: SUCCESS (0.001s)
[324.063322] [040/154] (707s left) perf_pmu (busy-double-start)
[324.113730] Starting subtest: busy-double-start
[324.114649] Starting dynamic subtest: rcs0
[327.727688] Dynamic subtest rcs0: SUCCESS (3.613s)
[327.756747] Starting dynamic subtest: bcs0
[331.323701] Dynamic subtest bcs0: SUCCESS (3.595s)
[331.341443] Starting dynamic subtest: vcs0
[334.909679] Dynamic subtest vcs0: SUCCESS (3.585s)
[334.924648] Starting dynamic subtest: vcs1
[338.500617] Dynamic subtest vcs1: SUCCESS (3.590s)
[338.514611] Starting dynamic subtest: vecs0
[342.094764] Dynamic subtest vecs0: SUCCESS (3.593s)
[342.095944] Subtest busy-double-start: SUCCESS (17.981s)
[342.217511] [041/154] (689s left) i915_module_load (resize-bar)
[342.262663] Starting subtest: resize-bar
[346.725749] Subtest resize-bar: SKIP (4.462s)
[346.801487] [042/154] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[348.299291] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[348.301401] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[348.465233] [043/154] (683s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[349.962524] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[349.964505] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[350.138632] [044/154] (681s left) gem_mmap_wc (read-write-distinct)
[350.186533] Subtest read-write-distinct: SKIP (0.000s)
[350.269275] [045/154] (681s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[351.762446] Starting subtest: hdr-rgb101010-draw-blt
[351.764207] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[351.931656] [046/154] (680s left) api_intel_bb (full-batch)
[351.980370] Starting subtest: full-batch
[352.007287] Subtest full-batch: SUCCESS (0.027s)
[352.196915] [047/154] (680s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[352.248225] Subtest tiled-to-tiled: SKIP (0.000s)
[352.336541] [048/154] (679s left) kms_plane (pixel-format-linear-modifier)
[353.826392] Starting subtest: pixel-format-linear-modifier
[353.874474] Starting dynamic subtest: pipe-A-plane-0
[354.924666] Dynamic subtest pipe-A-plane-0: SUCCESS (1.050s)
[354.962058] Starting dynamic subtest: pipe-A-plane-3
[355.592496] Dynamic subtest pipe-A-plane-3: SUCCESS (0.664s)
[355.641334] Starting dynamic subtest: pipe-A-plane-5
[356.324368] Dynamic subtest pipe-A-plane-5: SUCCESS (0.729s)
[356.338038] Starting dynamic subtest: pipe-A-plane-7
[356.541160] Dynamic subtest pipe-A-plane-7: SUCCESS (0.216s)
[356.758637] Starting dynamic subtest: pipe-B-plane-0
[357.629934] Dynamic subtest pipe-B-plane-0: SUCCESS (0.883s)
[357.680378] Starting dynamic subtest: pipe-B-plane-3
[358.347388] Dynamic subtest pipe-B-plane-3: SUCCESS (0.714s)
[358.394622] Starting dynamic subtest: pipe-B-plane-5
[359.080367] Dynamic subtest pipe-B-plane-5: SUCCESS (0.729s)
[359.097621] Starting dynamic subtest: pipe-B-plane-7
[359.329292] Dynamic subtest pipe-B-plane-7: SUCCESS (0.246s)
[359.402871] Subtest pixel-format-linear-modifier: SUCCESS (5.576s)
[359.624587] [049/154] (672s left) perf (missing-sample-flags)
[359.785317] Starting subtest: missing-sample-flags
[359.786276] Subtest missing-sample-flags: SUCCESS (0.000s)
[359.860173] [050/154] (672s left) dumb_buffer (create-valid-dumb)
[359.910403] Starting subtest: create-valid-dumb
[359.911357] Subtest create-valid-dumb: SUCCESS (0.000s)
[360.070094] [051/154] (672s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[361.565076] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[361.566671] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[361.739209] [052/154] (670s left) perf (polling)
[361.852005] Starting subtest: polling
[361.852877] Starting dynamic subtest: 0-rcs0
[371.897886] Dynamic subtest 0-rcs0: SUCCESS (10.041s)
[371.898867] Subtest polling: SUCCESS (10.042s)
[371.976490] [053/154] (660s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[373.485721] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[374.614532] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.123s)
[374.844037] [054/154] (657s left) kms_cursor_crc (cursor-onscreen-64x64)
[376.463054] Starting subtest: cursor-onscreen-64x64
[376.469027] Starting dynamic subtest: pipe-A-HDMI-A-3
[379.081394] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.612s)
[379.121132] Starting dynamic subtest: pipe-D-HDMI-A-3
[381.762581] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.655s)
[381.763575] Subtest cursor-onscreen-64x64: SUCCESS (5.300s)
[382.295192] [055/154] (650s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[383.791711] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[383.811461] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.019s)
[383.963030] [056/154] (649s left) gem_ctx_isolation (clean)
[384.021807] Starting subtest: clean
[384.022878] Starting dynamic subtest: rcs0
[384.135884] Dynamic subtest rcs0: SUCCESS (0.114s)
[384.150171] Starting dynamic subtest: bcs0
[384.268940] Dynamic subtest bcs0: SUCCESS (0.132s)
[384.282620] Starting dynamic subtest: vcs0
[384.406358] Dynamic subtest vcs0: SUCCESS (0.136s)
[384.420173] Starting dynamic subtest: vcs1
[384.542747] Dynamic subtest vcs1: SUCCESS (0.135s)
[384.556531] Starting dynamic subtest: vecs0
[384.672126] Dynamic subtest vecs0: SUCCESS (0.128s)
[384.673171] Subtest clean: SUCCESS (0.651s)
[385.044084] [057/154] (648s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[386.539181] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[386.542042] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[386.717245] [058/154] (646s left) perf_pmu (all-busy-check-all)
[386.768256] Starting subtest: all-busy-check-all
[387.339123] Subtest all-busy-check-all: SUCCESS (0.571s)
[387.466734] [059/154] (645s left) kms_psr (psr-cursor-mmap-gtt)
[388.956861] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[389.043427] [060/154] (644s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[390.538075] Starting subtest: 2x-plain-flip-ts-check-interruptible
[390.558329] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.019s)
[390.718197] [061/154] (642s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[392.206887] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[392.293980] [062/154] (641s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[393.783821] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[393.784754] Starting dynamic subtest: pipe-A-valid-mode
[395.121814] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.336s)
[395.122843] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.338s)
[395.327249] [063/154] (638s left) gem_exec_schedule (preempt-contexts)
[395.393006] Starting subtest: preempt-contexts
[395.393996] Starting dynamic subtest: rcs0
[395.482420] Dynamic subtest rcs0: SUCCESS (0.089s)
[395.497352] Starting dynamic subtest: bcs0
[395.552726] Dynamic subtest bcs0: SUCCESS (0.069s)
[395.567868] Starting dynamic subtest: vcs0
[395.625361] Dynamic subtest vcs0: SUCCESS (0.071s)
[395.640707] Starting dynamic subtest: vcs1
[395.697544] Dynamic subtest vcs1: SUCCESS (0.071s)
[395.712677] Starting dynamic subtest: vecs0
[395.770149] Dynamic subtest vecs0: SUCCESS (0.071s)
[395.771091] Subtest preempt-contexts: SUCCESS (0.378s)
[396.251979] [064/154] (637s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[397.747386] Starting subtest: fbc-shrfb-scaledprimary
[399.192643] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.446s)
[399.447902] [065/154] (634s left) kms_psr (fbc-pr-primary-mmap-gtt)
[400.936908] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[401.021967] [066/154] (632s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[402.510378] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[402.512334] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.000s)
[402.646313] [067/154] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[404.150067] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[404.151780] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[404.420730] [068/154] (629s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[405.916565] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[405.918552] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[406.124099] [069/154] (628s left) gen9_exec_parse (bb-oversize)
[406.183445] Subtest bb-oversize: SKIP (0.000s)
[406.276338] [070/154] (628s left) syncobj_timeline (multi-wait-all-signaled)
[406.322677] Starting subtest: multi-wait-all-signaled
[406.323568] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[406.450981] [071/154] (627s left) gem_exec_balancer (sliced)
[406.509626] Starting subtest: sliced
[406.511465] Subtest sliced: SKIP (0.000s)
[406.941847] [072/154] (627s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[408.437451] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[408.439489] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[408.642629] [073/154] (625s left) syncobj_wait (wait-delayed-signal)
[408.704143] Starting subtest: wait-delayed-signal
[408.810326] Subtest wait-delayed-signal: SUCCESS (0.103s)
[408.995592] [074/154] (625s left) gem_mmap_gtt (basic-small-bo)
[409.041768] Subtest basic-small-bo: SKIP (0.000s)
[409.153724] [075/154] (625s left) kms_big_fb (linear-addfb)
[410.679175] Starting subtest: linear-addfb
[410.680049] Subtest linear-addfb: SUCCESS (0.000s)
[410.844400] [076/154] (624s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[412.353325] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[413.463478] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.105s)
[413.629891] [077/154] (621s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[415.125227] Starting subtest: psr-shrfb-scaledprimary
[415.126938] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[415.315179] [078/154] (619s left) gem_softpin (allocator-fork)
[415.368961] Starting subtest: allocator-fork
[417.697123] Subtest allocator-fork: SUCCESS (2.324s)
[417.899812] [079/154] (617s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[419.389158] Starting subtest: random-ccs-data-y-tiled-ccs
[419.390361] Starting dynamic subtest: pipe-A-HDMI-A-3
[419.401795] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[419.416018] Starting dynamic subtest: pipe-B-HDMI-A-3
[419.427698] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[419.441327] Starting dynamic subtest: pipe-C-HDMI-A-3
[419.453369] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[419.466981] Starting dynamic subtest: pipe-D-HDMI-A-3
[419.481155] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[419.483972] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.009s)
[419.676440] [080/154] (615s left) prime_self_import (export-vs-gem_close-race)
[419.721290] Starting subtest: export-vs-gem_close-race
[424.755705] Subtest export-vs-gem_close-race: SUCCESS (5.034s)
[424.922312] [081/154] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[426.437164] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[426.438957] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[426.617769] [082/154] (608s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[428.107853] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[428.183817] [083/154] (607s left) syncobj_wait (single-wait-all-submitted)
[428.230108] Starting subtest: single-wait-all-submitted
[428.336323] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[428.513585] [084/154] (607s left) gem_softpin (evict-snoop-interruptible)
[428.567220] Starting subtest: evict-snoop-interruptible
[428.568929] Subtest evict-snoop-interruptible: SKIP (0.000s)
[428.703084] [085/154] (607s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[430.197525] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[430.199385] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[430.364735] [086/154] (605s left) kms_pipe_crc_basic (nonblocking-crc)
[431.874915] Starting subtest: nonblocking-crc
[431.877461] Starting dynamic subtest: pipe-A-HDMI-A-3
[432.643571] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.767s)
[432.659075] Starting dynamic subtest: pipe-B-HDMI-A-3
[433.221574] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.575s)
[433.237828] Starting dynamic subtest: pipe-C-HDMI-A-3
[433.760639] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.536s)
[433.776185] Starting dynamic subtest: pipe-D-HDMI-A-3
[434.349952] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.587s)
[434.350865] Subtest nonblocking-crc: SUCCESS (2.476s)
[434.546505] [087/154] (601s left) kms_cursor_legacy (torture-bo)
[436.037781] Starting subtest: torture-bo
[436.038716] Starting dynamic subtest: pipe-A
[441.566841] Dynamic subtest pipe-A: SUCCESS (5.524s)
[441.591444] Starting dynamic subtest: pipe-B
[447.031132] Dynamic subtest pipe-B: SUCCESS (5.462s)
[447.054372] Starting dynamic subtest: pipe-C
[452.481193] Dynamic subtest pipe-C: SUCCESS (5.450s)
[452.495357] Starting dynamic subtest: pipe-D
[457.935516] Dynamic subtest pipe-D: SUCCESS (5.452s)
[457.949457] Starting dynamic subtest: all-pipes
[463.401789] Dynamic subtest all-pipes: SUCCESS (5.464s)
[463.402723] Subtest torture-bo: SUCCESS (27.360s)
[463.543955] [088/154] (572s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[465.051632] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[465.053519] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[465.241148] [089/154] (570s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[466.730994] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[466.733038] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[466.949312] [090/154] (569s left) gem_wait (wait)
[467.016206] Starting subtest: wait
[467.017286] Starting dynamic subtest: all-engines
[468.105840] Dynamic subtest all-engines: SUCCESS (1.091s)
[468.126013] Starting dynamic subtest: rcs0
[469.165181] Dynamic subtest rcs0: SUCCESS (1.055s)
[469.220662] Starting dynamic subtest: bcs0
[470.232183] Dynamic subtest bcs0: SUCCESS (1.060s)
[470.256893] Starting dynamic subtest: vcs0
[471.299241] Dynamic subtest vcs0: SUCCESS (1.060s)
[471.323031] Starting dynamic subtest: vcs1
[472.364168] Dynamic subtest vcs1: SUCCESS (1.058s)
[472.381934] Starting dynamic subtest: vecs0
[473.422322] Dynamic subtest vecs0: SUCCESS (1.053s)
[473.430947] Subtest wait: SUCCESS (6.411s)
[473.763870] [091/154] (562s left) prime_mmap (test_aperture_limit)
[473.810954] Starting subtest: test_aperture_limit
[473.811887] Starting dynamic subtest: test_aperture_limit-smem
[473.833144] Dynamic subtest test_aperture_limit-smem: SKIP (0.021s)
[473.834998] Subtest test_aperture_limit: SKIP (0.022s)
[473.963277] [092/154] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[474.010344] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[474.121250] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[474.264102] [093/154] (562s left) gem_ctx_persistence (legacy-engines-persistence)
[474.315966] Starting subtest: legacy-engines-persistence
[474.316936] Starting dynamic subtest: render
[475.108967] Dynamic subtest render: SUCCESS (0.792s)
[475.126127] Starting dynamic subtest: bsd1
[475.881920] Dynamic subtest bsd1: SUCCESS (0.770s)
[475.900641] Starting dynamic subtest: bsd2
[476.643854] Dynamic subtest bsd2: SUCCESS (0.759s)
[476.662027] Starting dynamic subtest: blt
[477.417797] Dynamic subtest blt: SUCCESS (0.766s)
[477.432380] Starting dynamic subtest: vebox
[478.177661] Dynamic subtest vebox: SUCCESS (0.762s)
[478.178713] Subtest legacy-engines-persistence: SUCCESS (3.863s)
[478.346608] [094/154] (558s left) gem_exec_reloc (basic-softpin)
[478.400143] Subtest basic-softpin: SKIP (0.000s)
[478.500956] [095/154] (558s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[479.990568] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[480.065836] [096/154] (556s left) gem_barrier_race (remote-request)
[480.119825] Starting subtest: remote-request
[480.120870] Starting dynamic subtest: rcs0
[485.182130] Dynamic subtest rcs0: SUCCESS (5.062s)
[485.183297] Subtest remote-request: SUCCESS (5.063s)
[485.373173] [097/154] (551s left) i915_selftest (perf)
[486.375093] Starting subtest: perf
[486.376171] Starting dynamic subtest: engine_cs
[487.835294] Dynamic subtest engine_cs: SUCCESS (1.459s)
[487.847560] Starting dynamic subtest: request
[492.381591] Dynamic subtest request: SUCCESS (4.545s)
[492.393714] Starting dynamic subtest: migrate
[494.042169] Dynamic subtest migrate: SUCCESS (1.659s)
[494.053740] Starting dynamic subtest: region
[507.888332] Dynamic subtest region: SUCCESS (13.845s)
[507.889463] Subtest perf: SUCCESS (21.514s)
[507.936217] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[507.937330] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[507.940275] [098/154] (528s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[512.753179] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[512.754900] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[512.983527] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[512.986791] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[512.996619] [099/154] (524s left) syncobj_wait (invalid-signal-one-illegal-handle)
[513.069598] Starting subtest: invalid-signal-one-illegal-handle
[513.070539] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[513.192781] [100/154] (523s left) kms_selftest (drm_plane_helper)
[513.313644] Starting subtest: drm_plane_helper
[513.320298] Starting dynamic subtest: drm_test_check_plane_state
[513.389899] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.070s)
[513.403001] Starting dynamic subtest: drm_test_check_invalid_plane_state
[513.465045] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.072s)
[513.466590] Subtest drm_plane_helper: SUCCESS (0.152s)
[513.709056] [101/154] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[515.206303] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[515.208240] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[515.368251] [102/154] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[516.865605] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[516.867563] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[517.101345] [103/154] (520s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[518.596301] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[518.598028] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[518.769090] [104/154] (518s left) gem_create (create-valid-nonaligned)
[518.817707] Starting subtest: create-valid-nonaligned
[518.818699] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[519.157380] [105/154] (518s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[520.689451] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[520.828497] [106/154] (517s left) gem_render_copy (yf-tiled-ccs-to-linear)
[520.882896] Starting subtest: yf-tiled-ccs-to-linear
[520.883842] Starting dynamic subtest: smem
[520.984248] Dynamic subtest smem: SUCCESS (0.101s)
[520.999111] Starting dynamic subtest: lmem0
[521.298577] Dynamic subtest lmem0: SUCCESS (0.308s)
[521.299880] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.412s)
[521.586832] [107/154] (516s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[523.081938] Starting subtest: psr-rgb565-draw-mmap-wc
[523.083597] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[523.280115] [108/154] (514s left) gem_exec_schedule (fairslice)
[523.350713] Starting subtest: fairslice
[523.351625] Starting dynamic subtest: rcs0
[525.392998] Dynamic subtest rcs0: SUCCESS (2.041s)
[525.406851] Starting dynamic subtest: bcs0
[527.415987] Dynamic subtest bcs0: SUCCESS (2.021s)
[527.429313] Starting dynamic subtest: vcs0
[529.437168] Dynamic subtest vcs0: SUCCESS (2.019s)
[529.451103] Starting dynamic subtest: vcs1
[531.457997] Dynamic subtest vcs1: SUCCESS (2.019s)
[531.471440] Starting dynamic subtest: vecs0
[533.480625] Dynamic subtest vecs0: SUCCESS (2.021s)
[533.481636] Subtest fairslice: SUCCESS (10.129s)
[533.875177] [109/154] (504s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[535.370594] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[535.372725] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[535.599014] [110/154] (502s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[537.104989] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[537.106810] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[537.271600] [111/154] (501s left) gem_ringfill (legacy-basic)
[537.679430] Starting subtest: legacy-basic
[537.684106] Starting dynamic subtest: default
[537.759556] Dynamic subtest default: SUCCESS (0.079s)
[537.777286] Starting dynamic subtest: render
[537.801609] Dynamic subtest render: SUCCESS (0.040s)
[537.823600] Starting dynamic subtest: bsd
[537.845691] Dynamic subtest bsd: SUCCESS (0.042s)
[537.868127] Starting dynamic subtest: bsd1
[537.889693] Dynamic subtest bsd1: SUCCESS (0.042s)
[537.911657] Starting dynamic subtest: bsd2
[537.933689] Dynamic subtest bsd2: SUCCESS (0.041s)
[537.956183] Starting dynamic subtest: blt
[537.977700] Dynamic subtest blt: SUCCESS (0.042s)
[537.999766] Starting dynamic subtest: vebox
[538.022673] Dynamic subtest vebox: SUCCESS (0.043s)
[538.023715] Subtest legacy-basic: SUCCESS (0.344s)
[538.210373] [112/154] (500s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[539.706908] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[539.708598] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[539.879087] [113/154] (498s left) gem_eio (create-ext)
[540.063201] Starting subtest: create-ext
[540.326826] Subtest create-ext: SUCCESS (0.263s)
[541.887560] [114/154] (496s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[543.381778] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[543.382654] Starting dynamic subtest: pipe-A-HDMI-A-3
[543.404396] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[543.418854] Starting dynamic subtest: pipe-B-HDMI-A-3
[543.441665] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[543.455625] Starting dynamic subtest: pipe-C-HDMI-A-3
[543.478271] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[543.492406] Starting dynamic subtest: pipe-D-HDMI-A-3
[543.517383] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[543.519253] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[543.711743] [115/154] (495s left) gem_eio (in-flight-contexts-10ms)
[543.888727] Starting subtest: in-flight-contexts-10ms
[557.234362] Subtest in-flight-contexts-10ms: SUCCESS (13.347s)
[558.815474] [116/154] (480s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[558.869994] Starting subtest: multi-wait-for-submit-submitted-signaled
[558.870911] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[558.994364] [117/154] (479s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[560.513989] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[560.514992] Starting dynamic subtest: pipe-A-HDMI-A-3
[560.524556] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[560.539680] Starting dynamic subtest: pipe-B-HDMI-A-3
[560.548364] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[560.562864] Starting dynamic subtest: pipe-C-HDMI-A-3
[560.571506] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[560.585905] Starting dynamic subtest: pipe-D-HDMI-A-3
[560.594828] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[560.596544] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[560.823221] [118/154] (478s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[562.312674] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[573.247511] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.933s)
[573.462132] [119/154] (465s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[574.977215] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[575.599305] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.622s)
[575.800649] [120/154] (463s left) prime_vgem (busy)
[575.859283] Starting subtest: busy
[575.860636] Starting dynamic subtest: rcs0
[575.932002] Dynamic subtest rcs0: SUCCESS (0.074s)
[575.951524] Starting dynamic subtest: bcs0
[575.957771] Dynamic subtest bcs0: SUCCESS (0.021s)
[575.975880] Starting dynamic subtest: vcs0
[575.998440] Dynamic subtest vcs0: SUCCESS (0.039s)
[576.016161] Starting dynamic subtest: vcs1
[576.039289] Dynamic subtest vcs1: SUCCESS (0.039s)
[576.059641] Starting dynamic subtest: vecs0
[576.080082] Dynamic subtest vecs0: SUCCESS (0.039s)
[576.081250] Subtest busy: SUCCESS (0.223s)
[576.294375] [121/154] (462s left) i915_drm_fdinfo (virtual-busy-hang-all)
[576.345024] Starting subtest: virtual-busy-hang-all
[576.347268] Subtest virtual-busy-hang-all: SKIP (0.000s)
[576.509865] [122/154] (462s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[578.005093] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[578.006654] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[578.168628] [123/154] (461s left) gem_sync (basic-many-each)
[578.230862] Starting subtest: basic-many-each
[580.641826] Subtest basic-many-each: SUCCESS (2.411s)
[580.981660] [124/154] (458s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[582.476977] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[582.479235] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[582.681672] [125/154] (457s left) kms_atomic (crtc-invalid-params-fence)
[584.187126] Starting subtest: crtc-invalid-params-fence
[584.188108] Starting dynamic subtest: pipe-A-HDMI-A-3
[584.587487] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.399s)
[584.588368] Subtest crtc-invalid-params-fence: SUCCESS (0.402s)
[584.800981] [126/154] (454s left) gem_exec_params (rel-constants-invalid)
[584.855073] Starting subtest: rel-constants-invalid
[584.855946] Subtest rel-constants-invalid: SUCCESS (0.000s)
[585.074490] [127/154] (454s left) api_intel_allocator (two-level-inception-interruptible)
[585.123439] Starting subtest: two-level-inception-interruptible
[590.562637] Subtest two-level-inception-interruptible: SUCCESS (5.440s)
[590.773581] [128/154] (449s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[590.823991] Starting subtest: wait-all-for-submit-delayed-submit
[590.930405] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[591.117017] [129/154] (449s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[591.169360] Starting subtest: invalid-bsd2-flag-on-vebox
[591.170406] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[591.354970] [130/154] (448s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[591.402925] Starting subtest: etime-single-wait-for-submit-submitted
[591.510104] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[591.628582] [131/154] (448s left) prime_self_import (basic-with_two_bos)
[591.672914] Starting subtest: basic-with_two_bos
[591.676761] Subtest basic-with_two_bos: SUCCESS (0.005s)
[591.825338] [132/154] (448s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[593.314862] Starting subtest: cursorB-vs-flipB-atomic-transitions
[593.316709] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s)
[593.527852] [133/154] (447s left) gem_exec_balancer (noheartbeat)
[593.953937] Starting subtest: noheartbeat
[593.955788] Subtest noheartbeat: SKIP (0.000s)
[594.074089] [134/154] (446s left) kms_lease (cursor-implicit-plane)
[595.565975] Starting subtest: cursor-implicit-plane
[595.567100] Starting dynamic subtest: pipe-A-HDMI-A-3
[595.963049] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.395s)
[595.980626] Starting dynamic subtest: pipe-B-HDMI-A-3
[596.179909] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.212s)
[596.201727] Starting dynamic subtest: pipe-C-HDMI-A-3
[596.423973] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.239s)
[596.444787] Starting dynamic subtest: pipe-D-HDMI-A-3
[596.680584] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.254s)
[596.681661] Subtest cursor-implicit-plane: SUCCESS (1.115s)
[596.964566] [135/154] (443s left) gem_exec_schedule (u-submit-early-slice)
[597.028946] Starting subtest: u-submit-early-slice
[597.030043] Starting dynamic subtest: rcs0
[597.092462] Dynamic subtest rcs0: SUCCESS (0.063s)
[597.109963] Starting dynamic subtest: bcs0
[597.138030] Dynamic subtest bcs0: SUCCESS (0.044s)
[597.155399] Starting dynamic subtest: vcs0
[597.184570] Dynamic subtest vcs0: SUCCESS (0.045s)
[597.201940] Starting dynamic subtest: vcs1
[597.230988] Dynamic subtest vcs1: SUCCESS (0.045s)
[597.248034] Starting dynamic subtest: vecs0
[597.274783] Dynamic subtest vecs0: SUCCESS (0.042s)
[597.276033] Subtest u-submit-early-slice: SUCCESS (0.247s)
[597.768787] [136/154] (443s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[599.257890] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[599.260483] Starting dynamic subtest: pipe-A-HDMI-A-3
[599.264260] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[599.279583] Starting dynamic subtest: pipe-B-HDMI-A-3
[599.283371] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[599.298535] Starting dynamic subtest: pipe-C-HDMI-A-3
[599.302287] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[599.316818] Starting dynamic subtest: pipe-D-HDMI-A-3
[599.320555] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[599.322437] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.011s)
[599.618784] [137/154] (441s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[601.114369] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[604.367391] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.253s)
[604.572091] [138/154] (436s left) gem_exec_whisper (basic-queues-priority)
[604.632783] Starting subtest: basic-queues-priority
[620.109829] Subtest basic-queues-priority: SUCCESS (15.471s)
[620.396122] [139/154] (420s left) kms_psr (fbc-psr2-primary-page-flip)
[621.887119] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[621.965405] [140/154] (419s left) kms_scaling_modes (scaling-mode-full-aspect)
[623.457997] Starting subtest: scaling-mode-full-aspect
[623.463667] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[623.570323] [141/154] (417s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[625.068201] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[625.069950] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[625.273421] [142/154] (416s left) i915_pm_rps (thresholds)
[625.329671] Starting subtest: thresholds
[625.331447] Subtest thresholds: SKIP (0.000s)
[625.476267] [143/154] (416s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[626.970948] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[626.973139] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[627.170360] [144/154] (414s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[628.668033] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[628.669673] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[628.871857] [145/154] (412s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[630.368967] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[630.371115] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[630.586068] [146/154] (411s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[632.082861] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[632.085096] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[632.272871] [147/154] (409s left) kms_cursor_crc (cursor-sliding-128x42)
[633.957199] Starting subtest: cursor-sliding-128x42
[633.963883] Starting dynamic subtest: pipe-A-HDMI-A-3
[638.172953] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.209s)
[638.213289] Starting dynamic subtest: pipe-D-HDMI-A-3
[642.653714] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.456s)
[642.654595] Subtest cursor-sliding-128x42: SUCCESS (8.698s)
[643.093749] [148/154] (399s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[644.605638] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[644.607793] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[644.771009] [149/154] (397s left) kms_rotation_crc (primary-rotation-180)
[646.261779] Starting subtest: primary-rotation-180
[656.958747] Subtest primary-rotation-180: SUCCESS (10.697s)
[657.222694] [150/154] (385s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[657.270449] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[657.271465] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[657.382144] [151/154] (385s left) perf_pmu (render-node-busy)
[657.436613] Starting subtest: render-node-busy
[657.437580] Starting dynamic subtest: rcs0
[658.034393] Dynamic subtest rcs0: SUCCESS (0.598s)
[658.053913] Starting dynamic subtest: bcs0
[658.593358] Dynamic subtest bcs0: SUCCESS (0.557s)
[658.613056] Starting dynamic subtest: vcs0
[659.155317] Dynamic subtest vcs0: SUCCESS (0.560s)
[659.175392] Starting dynamic subtest: vcs1
[659.715394] Dynamic subtest vcs1: SUCCESS (0.558s)
[659.735779] Starting dynamic subtest: vecs0
[660.276365] Dynamic subtest vecs0: SUCCESS (0.559s)
[660.279692] Subtest render-node-busy: SUCCESS (2.842s)
[660.434981] [152/154] (382s left) kms_getfb (getfb2-into-addfb2)
[661.925892] Starting subtest: getfb2-into-addfb2
[661.926852] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[662.137575] [153/154] (380s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[663.639882] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[663.641628] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[663.800260] [154/154] (379s left) syncobj_timeline (wait-any-interrupted)
[663.848960] Starting subtest: wait-any-interrupted
[663.961124] Subtest wait-any-interrupted: SUCCESS (0.107s)
[664.145570] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: gem_exec_suspend
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_mmap
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: gem_exec_store
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_render_tiled_blits
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_pm_backlight
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_request_retire
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_plane_multiple
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_fenced_exec_thrash
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_param
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: i915_module_load
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_wc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: gem_set_tiling_vs_blt
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: dumb_buffer
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_ctx_isolation
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: gem_mmap_gtt
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_softpin
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: prime_self_import
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_wait
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_barrier_race
results: parsing output: 96/ for test: i915_selftest
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_selftest
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_ringfill
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_atomic
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: prime_self_import
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_exec_balancer
results: parsing output: 133/ for test: kms_lease
results: parsing output: 134/ for test: gem_exec_schedule
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_exec_whisper
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_scaling_modes
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: i915_pm_rps
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_cursor_crc
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: kms_rotation_crc
results: parsing output: 149/ for test: syncobj_wait
results: parsing output: 150/ for test: perf_pmu
results: parsing output: 151/ for test: kms_getfb
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: syncobj_timeline
Done.