[47.824690] Initializing watchdogs
[47.824755]   /dev/watchdog0
[47.839996] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.845478] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.848339] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.850596] [001/133] (960s left) i915_pm_rps (fence-order)
[47.895800] Starting subtest: fence-order
[49.440527] Subtest fence-order: SUCCESS (1.536s)
[49.538466] [002/133] (958s left) gem_exec_capture (capture-invisible)
[49.575059] Starting subtest: capture-invisible
[49.575772] Starting dynamic subtest: smem0
[49.577103] Dynamic subtest smem0: SKIP (0.000s)
[49.578402] Subtest capture-invisible: SKIP (0.000s)
[49.667756] [003/133] (958s left) kms_rotation_crc (bad-pixel-format)
[49.754392] Starting subtest: bad-pixel-format
[50.777137] Subtest bad-pixel-format: SUCCESS (1.023s)
[50.960089] [004/133] (957s left) perf_pmu (most-busy-check-all)
[50.999048] Starting subtest: most-busy-check-all
[50.999805] Starting dynamic subtest: rcs0
[51.518090] Dynamic subtest rcs0: SUCCESS (0.519s)
[51.526876] Starting dynamic subtest: bcs0
[52.037660] Dynamic subtest bcs0: SUCCESS (0.518s)
[52.046060] Starting dynamic subtest: vcs0
[52.559284] Dynamic subtest vcs0: SUCCESS (0.521s)
[52.567818] Starting dynamic subtest: vcs1
[53.083343] Dynamic subtest vcs1: SUCCESS (0.523s)
[53.091574] Starting dynamic subtest: vecs0
[53.601502] Dynamic subtest vecs0: SUCCESS (0.517s)
[53.602593] Subtest most-busy-check-all: SUCCESS (2.602s)
[53.667752] [005/133] (954s left) gem_lmem_swapping (parallel-multi)
[53.704120] Subtest parallel-multi: SKIP (0.000s)
[53.737759] [006/133] (954s left) gem_mmap_gtt (hang-busy)
[53.770055] Starting subtest: hang-busy
[89.211493] Subtest hang-busy: SUCCESS (35.439s)
[89.319763] [007/133] (919s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[89.407168] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[89.407846] Starting dynamic subtest: pipe-A
[89.543216] Dynamic subtest pipe-A: SUCCESS (0.136s)
[89.552324] Starting dynamic subtest: pipe-B
[89.667710] Dynamic subtest pipe-B: SUCCESS (0.124s)
[89.674844] Starting dynamic subtest: pipe-C
[89.792859] Dynamic subtest pipe-C: SUCCESS (0.125s)
[89.798784] Starting dynamic subtest: pipe-D
[89.918081] Dynamic subtest pipe-D: SUCCESS (0.125s)
[89.918864] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.511s)
[90.084932] [008/133] (918s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[90.171695] Starting subtest: primary-yf-tiled-reflect-x-90
[90.227158] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.055s)
[90.304546] [009/133] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[90.392393] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[90.393859] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[90.487275] [010/133] (918s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[90.584473] Starting subtest: yf-tiled-32bpp-rotate-90
[90.585895] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[90.661184] [011/133] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[90.749410] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[90.750781] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[90.855192] [012/133] (917s left) api_intel_bb (object-reloc-purge-cache)
[90.887648] Starting subtest: object-reloc-purge-cache
[90.891954] Subtest object-reloc-purge-cache: SUCCESS (0.004s)
[90.988946] [013/133] (917s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[91.076140] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[91.112394] [014/133] (917s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[91.146541] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[91.256330] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s)
[91.331759] [015/133] (917s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[91.416333] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[91.417088] Starting dynamic subtest: pipe-A-HDMI-A-1
[91.423663] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[91.429589] Starting dynamic subtest: pipe-B-HDMI-A-1
[91.436265] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[91.442216] Starting dynamic subtest: pipe-C-HDMI-A-1
[91.448775] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[91.454464] Starting dynamic subtest: pipe-D-HDMI-A-1
[91.461088] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[91.462379] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[91.643704] [016/133] (917s left) kms_vblank (wait-forked-busy-hang)
[91.728641] Starting subtest: wait-forked-busy-hang
[91.730067] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.621683] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.892s)
[105.632839] Starting dynamic subtest: pipe-D-HDMI-A-1
[119.434130] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.808s)
[119.434875] Subtest wait-forked-busy-hang: SUCCESS (27.706s)
[119.582539] [017/133] (889s left) gem_lmem_swapping (parallel-random-verify-ccs)
[119.621970] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[119.657487] [018/133] (889s left) kms_cursor_crc (cursor-random-256x85)
[119.747980] Starting subtest: cursor-random-256x85
[119.752430] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.675215] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.923s)
[121.719547] Starting dynamic subtest: pipe-D-HDMI-A-1
[123.598386] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.886s)
[123.599092] Subtest cursor-random-256x85: SUCCESS (3.851s)
[123.754176] [019/133] (885s left) gem_exec_fence (submit)
[123.923486] Starting subtest: submit
[123.924340] Starting dynamic subtest: rcs0
[123.937023] Dynamic subtest rcs0: SUCCESS (0.013s)
[123.945188] Starting dynamic subtest: bcs0
[123.947462] Dynamic subtest bcs0: SUCCESS (0.010s)
[123.953853] Starting dynamic subtest: vcs0
[123.958148] Dynamic subtest vcs0: SUCCESS (0.010s)
[123.965243] Starting dynamic subtest: vcs1
[123.967607] Dynamic subtest vcs1: SUCCESS (0.009s)
[123.974372] Starting dynamic subtest: vecs0
[123.978046] Dynamic subtest vecs0: SUCCESS (0.009s)
[123.978784] Subtest submit: SUCCESS (0.054s)
[124.459320] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[124.462782] [020/133] (884s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[124.548307] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[124.549759] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[124.702784] [021/133] (884s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[124.791746] Starting subtest: cursorA-vs-flipB-legacy
[124.794060] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[124.850664] [022/133] (884s left) gem_mmap_gtt (basic-wc)
[124.884550] Starting subtest: basic-wc
[125.522352] Subtest basic-wc: SUCCESS (0.630s)
[125.599443] [023/133] (883s left) kms_flip (bo-too-big)
[125.683382] Starting subtest: bo-too-big
[125.685221] Starting dynamic subtest: A-HDMI-A1
[126.021330] Dynamic subtest A-HDMI-A1: SUCCESS (0.336s)
[126.029291] Starting dynamic subtest: B-HDMI-A1
[126.340236] Dynamic subtest B-HDMI-A1: SUCCESS (0.315s)
[126.349371] Starting dynamic subtest: C-HDMI-A1
[126.663978] Dynamic subtest C-HDMI-A1: SUCCESS (0.321s)
[126.670485] Starting dynamic subtest: D-HDMI-A1
[126.977826] Dynamic subtest D-HDMI-A1: SUCCESS (0.313s)
[126.978581] Subtest bo-too-big: SUCCESS (1.293s)
[127.151613] [024/133] (882s left) kms_plane_lowres (tiling-yf)
[127.238440] Starting subtest: tiling-yf
[127.239854] Subtest tiling-yf: SKIP (0.000s)
[127.291392] [025/133] (881s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[127.380885] Starting subtest: flip-vs-dpms-on-nop-interruptible
[127.383390] Starting dynamic subtest: A-HDMI-A1
[128.180084] Dynamic subtest A-HDMI-A1: SUCCESS (0.796s)
[128.191433] Starting dynamic subtest: B-HDMI-A1
[128.951014] Dynamic subtest B-HDMI-A1: SUCCESS (0.768s)
[128.960834] Starting dynamic subtest: C-HDMI-A1
[129.728463] Dynamic subtest C-HDMI-A1: SUCCESS (0.776s)
[129.737868] Starting dynamic subtest: D-HDMI-A1
[130.501959] Dynamic subtest D-HDMI-A1: SUCCESS (0.772s)
[130.505849] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (3.125s)
[130.652650] [026/133] (878s left) gem_exec_reloc (basic-cpu-read-active)
[130.692367] Starting subtest: basic-cpu-read-active
[130.822558] Subtest basic-cpu-read-active: SUCCESS (0.121s)
[130.935999] [027/133] (878s left) gem_ctx_shared (disjoint-timelines)
[130.976971] Starting subtest: disjoint-timelines
[130.983453] Subtest disjoint-timelines: SUCCESS (0.006s)
[131.217544] [028/133] (878s left) tools_test (tools_test)
[131.254264] Starting subtest: tools_test
[131.324776] Subtest tools_test: SUCCESS (0.075s)
[131.379160] [029/133] (877s left) kms_selftest (drm_format)
[131.411872] Starting subtest: drm_format
[131.418736] Starting dynamic subtest: drm_test_format_block_width_invalid
[131.481619] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.062s)
[131.496925] Starting dynamic subtest: drm_test_format_block_width_one_plane
[131.556553] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.072s)
[131.571855] Starting dynamic subtest: drm_test_format_block_width_two_plane
[131.622160] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.065s)
[131.638095] Starting dynamic subtest: drm_test_format_block_width_three_plane
[131.694356] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.070s)
[131.710228] Starting dynamic subtest: drm_test_format_block_width_tiled
[131.758980] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.064s)
[131.774815] Starting dynamic subtest: drm_test_format_block_height_invalid
[131.826043] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.066s)
[131.843040] Starting dynamic subtest: drm_test_format_block_height_one_plane
[131.898799] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.070s)
[131.914736] Starting dynamic subtest: drm_test_format_block_height_two_plane
[131.970524] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.071s)
[131.986077] Starting dynamic subtest: drm_test_format_block_height_three_plane
[132.036585] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.065s)
[132.051915] Starting dynamic subtest: drm_test_format_block_height_tiled
[132.110489] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.073s)
[132.127683] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[132.186605] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.073s)
[132.202441] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[132.256480] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.068s)
[132.271793] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[132.325490] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.068s)
[132.340982] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[132.394506] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.068s)
[132.410576] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[132.467554] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.072s)
[132.483382] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[132.542677] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.073s)
[132.558419] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[132.612513] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.068s)
[132.628477] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[132.688652] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.075s)
[132.689803] Subtest drm_format: SUCCESS (1.276s)
[132.816468] [030/133] (876s left) kms_pm_lpsp (kms-lpsp)
[133.906245] Starting subtest: kms-lpsp
[133.907583] Subtest kms-lpsp: SKIP (0.000s)
[133.960844] [031/133] (875s left) kms_cursor_edge_walk (128x128-right-edge)
[134.045719] Starting subtest: 128x128-right-edge
[134.046419] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.808558] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.762s)
[135.816830] Starting dynamic subtest: pipe-D-HDMI-A-1
[137.498691] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.689s)
[137.500266] Subtest 128x128-right-edge: SUCCESS (3.454s)
[137.604563] [032/133] (871s left) kms_plane_alpha_blend (alpha-transparent-fb)
[137.694899] Starting subtest: alpha-transparent-fb
[137.760302] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.050641] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.290s)
[138.060015] Starting dynamic subtest: pipe-D-HDMI-A-1
[138.393509] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.341s)
[138.394281] Subtest alpha-transparent-fb: SUCCESS (0.699s)
[138.525406] [033/133] (870s left) kms_prop_blob (invalid-get-prop-any)
[138.561723] Starting subtest: invalid-get-prop-any
[138.562979] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[138.623908] [034/133] (870s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[138.712494] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[138.713834] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[138.797869] [035/133] (870s left) perf (gen12-group-exclusive-stream-sample-oa)
[138.875342] Starting subtest: gen12-group-exclusive-stream-sample-oa
[138.884756] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.010s)
[138.936955] [036/133] (870s left) gem_close (basic)
[138.973652] Starting subtest: basic
[138.974395] Subtest basic: SUCCESS (0.000s)
[139.066660] [037/133] (870s left) gem_exec_whisper (basic-forked-all)
[139.108910] Starting subtest: basic-forked-all
[141.646989] Subtest basic-forked-all: SUCCESS (2.537s)
[141.850384] [038/133] (867s left) sriov_basic (bind-unbind-vf)
[141.884040] Starting subtest: bind-unbind-vf
[141.884783] Starting dynamic subtest: vf-1
[141.909310] Dynamic subtest vf-1: FAIL (0.012s)
[141.916141] Starting dynamic subtest: vf-2
[141.937735] Dynamic subtest vf-2: FAIL (0.006s)
[141.944341] Starting dynamic subtest: vf-3
[141.966187] Dynamic subtest vf-3: FAIL (0.006s)
[141.972454] Starting dynamic subtest: vf-4
[141.993378] Dynamic subtest vf-4: FAIL (0.006s)
[142.000286] Starting dynamic subtest: vf-5
[142.021098] Dynamic subtest vf-5: FAIL (0.006s)
[142.027402] Starting dynamic subtest: vf-6
[142.049119] Dynamic subtest vf-6: FAIL (0.005s)
[142.057297] Starting dynamic subtest: vf-7
[142.079164] Dynamic subtest vf-7: FAIL (0.006s)
[142.087469] Starting dynamic subtest: vf-random
[142.109605] Dynamic subtest vf-random: FAIL (0.005s)
[142.123806] Starting dynamic subtest: vf-last
[142.148839] Dynamic subtest vf-last: FAIL (0.006s)
[142.149511] Subtest bind-unbind-vf: FAIL (0.063s)
[142.179242] [039/133] (867s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[142.266545] Starting subtest: addfb25-yf-tiled-legacy
[142.267261] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[142.346275] [040/133] (867s left) gem_userptr_blits (coherency-unsync)
[142.384360] Subtest coherency-unsync: SKIP (0.000s)
[142.502520] [041/133] (867s left) kms_atomic_interruptible (legacy-setmode)
[142.586139] Starting subtest: legacy-setmode
[142.587682] Starting dynamic subtest: pipe-A-HDMI-A-1
[148.757797] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.170s)
[148.758487] Subtest legacy-setmode: SUCCESS (6.172s)
[148.903578] [042/133] (860s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[148.951460] Starting subtest: yf-tiled-ccs-to-yf-tiled
[148.952168] Starting dynamic subtest: smem
[149.023620] Dynamic subtest smem: SUCCESS (0.072s)
[149.024326] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.073s)
[149.216829] [043/133] (860s left) gem_ctx_bad_destroy (invalid-pad)
[149.250335] Starting subtest: invalid-pad
[149.251086] Subtest invalid-pad: SUCCESS (0.000s)
[149.319518] [044/133] (860s left) kms_dp_aux_dev
[149.648474] [045/133] (860s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[149.736523] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[149.737981] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[149.816086] [046/133] (860s left) kms_psr (psr-dpms)
[149.902994] Subtest psr-dpms: SKIP (0.000s)
[149.948208] [047/133] (860s left) gem_render_copy (x-tiled)
[149.987271] Starting subtest: x-tiled
[149.988024] Starting dynamic subtest: smem
[150.082818] Dynamic subtest smem: SUCCESS (0.095s)
[150.083533] Subtest x-tiled: SUCCESS (0.096s)
[150.260896] [048/133] (859s left) gem_exec_schedule (deep)
[150.427819] Starting subtest: deep
[150.428979] Starting dynamic subtest: rcs0
[158.475091] Dynamic subtest rcs0: SUCCESS (8.039s)
[158.485041] Starting dynamic subtest: bcs0
[166.739870] Dynamic subtest bcs0: SUCCESS (8.262s)
[166.748958] Starting dynamic subtest: vcs0
[174.983468] Dynamic subtest vcs0: SUCCESS (8.243s)
[174.992417] Starting dynamic subtest: vcs1
[183.252070] Dynamic subtest vcs1: SUCCESS (8.268s)
[183.259028] Starting dynamic subtest: vecs0
[191.504620] Dynamic subtest vecs0: SUCCESS (8.252s)
[191.505406] Subtest deep: SUCCESS (41.070s)
[191.968050] [049/133] (818s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[192.001355] Starting subtest: invalid-single-wait-all-unsubmitted
[192.002090] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[192.062880] [050/133] (818s left) kms_busy (extended-pageflip-hang-oldfb)
[192.152742] Starting subtest: extended-pageflip-hang-oldfb
[192.154298] Starting dynamic subtest: pipe-A
[192.288955] Dynamic subtest pipe-A: SUCCESS (0.134s)
[192.301100] Starting dynamic subtest: pipe-D
[192.440663] Dynamic subtest pipe-D: SUCCESS (0.147s)
[192.441448] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.288s)
[192.564049] [051/133] (817s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[192.656357] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[192.696776] [052/133] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[192.784661] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[192.785990] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[192.864552] [053/133] (817s left) gem_fence_thrash (bo-write-verify-x)
[192.895627] Starting subtest: bo-write-verify-x
[193.999840] Subtest bo-write-verify-x: SUCCESS (1.097s)
[194.073013] [054/133] (816s left) gem_eio (suspend)
[194.112707] Starting subtest: suspend
[205.314029] Subtest suspend: SUCCESS (11.201s)
[214.483494] [055/133] (804s left) gen3_render_mixed_blits
[214.571883] [056/133] (804s left) prime_vgem (basic-fence-mmap)
[214.629159] Starting subtest: basic-fence-mmap
[214.656770] Subtest basic-fence-mmap: SUCCESS (0.027s)
[214.751744] [057/133] (804s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[214.843779] Starting subtest: fbc-rgb101010-draw-mmap-wc
[217.314443] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.471s)
[217.423669] [058/133] (802s left) kms_addfb_basic (tile-pitch-mismatch)
[217.457790] Starting subtest: tile-pitch-mismatch
[217.458523] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[217.607790] [059/133] (801s left) kms_flip (2x-flip-vs-fences-interruptible)
[217.696229] Starting subtest: 2x-flip-vs-fences-interruptible
[217.705568] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.009s)
[217.801966] [060/133] (801s left) gem_userptr_blits (sync-overlap)
[217.847629] Starting subtest: sync-overlap
[217.848345] Subtest sync-overlap: SUCCESS (0.000s)
[217.948993] [061/133] (801s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[218.042737] Starting subtest: y-tiled-64bpp-rotate-180
[219.281308] Subtest y-tiled-64bpp-rotate-180: SUCCESS (1.238s)
[219.409741] [062/133] (800s left) syncobj_wait (invalid-signal-zero-handles)
[219.442667] Starting subtest: invalid-signal-zero-handles
[219.443382] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[219.501845] [063/133] (800s left) gem_ctx_exec (basic)
[219.534935] Starting subtest: basic
[219.537207] Subtest basic: SUCCESS (0.002s)
[219.643759] [064/133] (800s left) gem_exec_flush (basic-wb-ro-default)
[219.685684] Starting subtest: basic-wb-ro-default
[225.116661] Subtest basic-wb-ro-default: SUCCESS (5.432s)
[225.335994] [065/133] (794s left) kms_plane (pixel-format-4-tiled-modifier)
[225.423713] Starting subtest: pixel-format-4-tiled-modifier
[225.425064] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[225.482925] [066/133] (794s left) kms_psr (pr-primary-page-flip)
[225.570725] Subtest pr-primary-page-flip: SKIP (0.000s)
[225.615200] [067/133] (794s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[225.710389] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[225.711831] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[225.802705] [068/133] (794s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[225.889031] Starting subtest: bad-rotation-90-yf-tiled-ccs
[225.889760] Starting dynamic subtest: pipe-A-HDMI-A-1
[225.896543] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[225.903921] Starting dynamic subtest: pipe-B-HDMI-A-1
[225.910583] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[225.917785] Starting dynamic subtest: pipe-C-HDMI-A-1
[225.924291] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[225.931908] Starting dynamic subtest: pipe-D-HDMI-A-1
[225.938590] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[225.939953] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.006s)
[226.118964] [069/133] (793s left) kms_cursor_crc (cursor-offscreen-256x85)
[226.218630] Starting subtest: cursor-offscreen-256x85
[226.223700] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.483822] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.260s)
[227.526990] Starting dynamic subtest: pipe-D-HDMI-A-1
[228.737264] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.216s)
[228.738045] Subtest cursor-offscreen-256x85: SUCCESS (2.519s)
[228.863170] [070/133] (791s left) gem_eio (in-flight-internal-1us)
[228.907238] Starting subtest: in-flight-internal-1us
[229.180583] Subtest in-flight-internal-1us: SUCCESS (0.272s)
[229.295568] [071/133] (790s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[229.336740] Starting subtest: y-tiled-to-vebox-yf-tiled
[229.337416] Starting dynamic subtest: smem
[229.403519] Dynamic subtest smem: SUCCESS (0.067s)
[229.404273] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[229.587190] [072/133] (790s left) syncobj_timeline (single-wait-available-submitted)
[229.620829] Starting subtest: single-wait-available-submitted
[229.621519] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[229.679846] [073/133] (790s left) gem_tiled_blits (interruptible)
[230.066367] Starting subtest: interruptible
[240.772407] Subtest interruptible: SUCCESS (10.672s)
[240.864595] [074/133] (779s left) kms_draw_crc (draw-method-blt)
[241.004600] Starting subtest: draw-method-blt
[241.005361] Starting dynamic subtest: xrgb8888-untiled
[241.178078] Dynamic subtest xrgb8888-untiled: SUCCESS (0.173s)
[241.195366] Starting dynamic subtest: rgb565-untiled
[241.344809] Dynamic subtest rgb565-untiled: SUCCESS (0.165s)
[241.360215] Starting dynamic subtest: xrgb2101010-untiled
[241.494756] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.147s)
[241.512790] Starting dynamic subtest: xbgr16161616f-untiled
[241.653241] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.156s)
[241.670870] Starting dynamic subtest: xrgb8888-xtiled
[241.736672] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.081s)
[241.753618] Starting dynamic subtest: rgb565-xtiled
[241.819819] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[241.838448] Starting dynamic subtest: xrgb2101010-xtiled
[241.903066] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[241.915951] Starting dynamic subtest: xbgr16161616f-xtiled
[241.994595] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.090s)
[242.013111] Starting dynamic subtest: xrgb8888-ytiled
[242.094878] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.098s)
[242.113496] Starting dynamic subtest: rgb565-ytiled
[242.178203] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[242.196673] Starting dynamic subtest: xrgb2101010-ytiled
[242.269644] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.090s)
[242.287206] Starting dynamic subtest: xbgr16161616f-ytiled
[242.369792] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.098s)
[242.372930] Subtest draw-method-blt: SUCCESS (1.366s)
[242.481282] [075/133] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[242.575087] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[242.576529] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[242.673388] [076/133] (777s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[242.770364] Starting subtest: yf-tiled-16bpp-rotate-180
[242.771806] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[242.854556] [077/133] (777s left) gem_eio (in-flight-contexts-immediate)
[242.899332] Starting subtest: in-flight-contexts-immediate
[256.873637] Subtest in-flight-contexts-immediate: SUCCESS (13.971s)
[256.999766] [078/133] (763s left) gem_exec_balancer (invalid-bonds)
[257.044141] Starting subtest: invalid-bonds
[257.045532] Subtest invalid-bonds: SUCCESS (0.003s)
[257.242322] [079/133] (763s left) drm_buddy (drm_buddy)
[257.282817] Starting subtest: drm_buddy
[257.284195] Subtest drm_buddy: SKIP (0.000s)
[257.362867] [080/133] (763s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[257.449986] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[257.450734] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.457435] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[257.465501] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.472316] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[257.480185] Starting dynamic subtest: pipe-C-HDMI-A-1
[257.486950] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[257.494694] Starting dynamic subtest: pipe-D-HDMI-A-1
[257.501313] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[257.502640] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[257.697067] [081/133] (762s left) gem_exec_schedule (u-independent)
[257.741904] Starting subtest: u-independent
[257.742647] Starting dynamic subtest: rcs0
[257.847084] Dynamic subtest rcs0: SUCCESS (0.104s)
[257.866185] Starting dynamic subtest: bcs0
[257.954914] Dynamic subtest bcs0: SUCCESS (0.105s)
[257.976119] Starting dynamic subtest: vcs0
[258.069917] Dynamic subtest vcs0: SUCCESS (0.112s)
[258.088421] Starting dynamic subtest: vcs1
[258.183853] Dynamic subtest vcs1: SUCCESS (0.112s)
[258.202920] Starting dynamic subtest: vecs0
[258.297777] Dynamic subtest vecs0: SUCCESS (0.112s)
[258.298834] Subtest u-independent: SUCCESS (0.556s)
[258.598094] [082/133] (761s left) kms_invalid_mode (zero-vdisplay)
[258.687812] Starting subtest: zero-vdisplay
[258.688523] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.742450] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s)
[258.753019] Starting dynamic subtest: pipe-B-HDMI-A-1
[258.753729] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[258.762151] Starting dynamic subtest: pipe-C-HDMI-A-1
[258.762861] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[258.771452] Starting dynamic subtest: pipe-D-HDMI-A-1
[258.772215] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[258.772945] Subtest zero-vdisplay: SUCCESS (0.063s)
[258.882733] [083/133] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[258.976927] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[258.978431] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[259.072779] [084/133] (761s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[259.107474] Starting subtest: multi-wait-available-submitted-signaled
[259.108227] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[259.172010] [085/133] (761s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[259.260763] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[260.386861] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (1.126s)
[260.533290] [086/133] (760s left) kms_flip (plain-flip-fb-recreate)
[260.622372] Starting subtest: plain-flip-fb-recreate
[260.625078] Starting dynamic subtest: A-HDMI-A1
[268.463537] Dynamic subtest A-HDMI-A1: SUCCESS (7.838s)
[268.475107] Starting dynamic subtest: B-HDMI-A1
[276.260825] Dynamic subtest B-HDMI-A1: SUCCESS (7.794s)
[276.278030] Starting dynamic subtest: C-HDMI-A1
[284.061765] Dynamic subtest C-HDMI-A1: SUCCESS (7.798s)
[284.076224] Starting dynamic subtest: D-HDMI-A1
[291.879015] Dynamic subtest D-HDMI-A1: SUCCESS (7.814s)
[291.883925] Subtest plain-flip-fb-recreate: SUCCESS (31.261s)
[292.032742] [087/133] (728s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[292.122602] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[292.169516] [088/133] (728s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[292.259030] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[292.260440] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[292.349275] [089/133] (728s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[292.438737] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[292.440170] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[292.530230] [090/133] (728s left) gem_ctx_persistence (heartbeat-close)
[292.569239] Starting subtest: heartbeat-close
[292.782719] Subtest heartbeat-close: SUCCESS (0.213s)
[292.860297] [091/133] (728s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[292.895393] Starting subtest: multi-wait-all-available-submitted-signaled
[292.896143] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[292.968911] [092/133] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[293.057800] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[293.059219] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[293.170909] [093/133] (727s left) i915_pm_freq_api (freq-reset)
[293.208403] Subtest freq-reset: SKIP (0.000s)
[293.252313] [094/133] (727s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[293.338894] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[293.386815] [095/133] (727s left) gem_ccs (block-copy-uncompressed)
[293.424029] Starting subtest: block-copy-uncompressed
[293.425770] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[293.444412] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[293.453566] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[293.462230] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[293.462946] Subtest block-copy-uncompressed: SUCCESS (0.039s)
[293.567459] [096/133] (727s left) gen9_exec_parse (cmd-crossing-page)
[293.605051] Subtest cmd-crossing-page: SKIP (0.000s)
[293.653205] [097/133] (727s left) kms_concurrent (multi-plane-atomic-lowres)
[293.739596] Starting subtest: multi-plane-atomic-lowres
[293.741324] Starting dynamic subtest: pipe-A-HDMI-A-1
[294.108648] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.368s)
[294.120542] Starting dynamic subtest: pipe-B-HDMI-A-1
[294.402118] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.291s)
[294.413878] Starting dynamic subtest: pipe-C-HDMI-A-1
[294.770263] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.365s)
[294.781306] Starting dynamic subtest: pipe-D-HDMI-A-1
[295.112840] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.339s)
[295.113571] Subtest multi-plane-atomic-lowres: SUCCESS (1.373s)
[295.218886] [098/133] (725s left) kms_chamelium_hpd (vga-hpd-fast)
[295.365220] Subtest vga-hpd-fast: SKIP (0.000s)
[295.455604] [099/133] (725s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[295.555813] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[295.557199] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[295.637051] [100/133] (725s left) kms_color (ctm-green-to-red)
[295.724769] Starting subtest: ctm-green-to-red
[295.725517] Starting dynamic subtest: pipe-A-HDMI-A-1
[296.045618] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.320s)
[296.057705] Starting dynamic subtest: pipe-B-HDMI-A-1
[296.356470] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.309s)
[296.367040] Starting dynamic subtest: pipe-C-HDMI-A-1
[296.664012] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.307s)
[296.676278] Starting dynamic subtest: pipe-D-HDMI-A-1
[296.957660] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.292s)
[296.959266] Subtest ctm-green-to-red: SUCCESS (1.233s)
[297.115378] [101/133] (724s left) gem_ctx_isolation (preservation-s3)
[297.158102] Starting subtest: preservation-S3
[297.158949] Starting dynamic subtest: rcs0
[313.952276] Dynamic subtest rcs0: SUCCESS (1.330s)
[313.967609] Starting dynamic subtest: bcs0
[329.981430] Dynamic subtest bcs0: SUCCESS (1.382s)
[329.991794] Starting dynamic subtest: vcs0
[346.946669] Dynamic subtest vcs0: SUCCESS (1.410s)
[346.956159] Starting dynamic subtest: vcs1
[362.951981] Dynamic subtest vcs1: SUCCESS (1.371s)
[362.961537] Starting dynamic subtest: vecs0
[378.948552] Dynamic subtest vecs0: SUCCESS (1.354s)
[378.949266] Subtest preservation-S3: SUCCESS (6.853s)
[388.179490] [102/133] (642s left) kms_psr (psr2-cursor-render)
[388.267280] Subtest psr2-cursor-render: SKIP (0.000s)
[388.309409] [103/133] (642s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[388.393964] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[388.394792] Starting dynamic subtest: pipe-A
[389.652104] Dynamic subtest pipe-A: SUCCESS (1.258s)
[389.663764] Starting dynamic subtest: pipe-B
[390.905217] Dynamic subtest pipe-B: SUCCESS (1.251s)
[390.916188] Starting dynamic subtest: pipe-C
[391.106112] Dynamic subtest pipe-C: SUCCESS (0.200s)
[391.117104] Starting dynamic subtest: pipe-D
[391.307831] Dynamic subtest pipe-D: SUCCESS (0.201s)
[391.308533] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.912s)
[391.490541] [104/133] (638s left) gem_mmap_gtt (basic-write-read-distinct)
[391.527252] Starting subtest: basic-write-read-distinct
[391.529923] Subtest basic-write-read-distinct: SUCCESS (0.003s)
[391.613414] [105/133] (638s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[391.753794] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[391.845304] [106/133] (638s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[391.936422] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[391.937821] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[392.008541] [107/133] (638s left) gem_ctx_exec (basic-close-race)
[392.042926] Starting subtest: basic-close-race
[397.578921] Subtest basic-close-race: SUCCESS (5.498s)
[397.658783] [108/133] (632s left) gem_mmap_gtt (basic-short)
[397.691502] Starting subtest: basic-short
[397.710658] Subtest basic-short: SUCCESS (0.020s)
[397.798242] [109/133] (632s left) vgem_basic (bad-flag)
[397.836608] Starting subtest: bad-flag
[397.837336] Subtest bad-flag: SUCCESS (0.000s)
[397.889602] [110/133] (632s left) gem_pread (snoop)
[397.923438] Starting subtest: snoop
[398.748493] Subtest snoop: SUCCESS (0.816s)
[398.819311] [111/133] (631s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[400.207696] Starting subtest: modeset-non-lpsp-stress-no-wait
[400.320183] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.112s)
[400.425727] [112/133] (630s left) gem_pxp (create-protected-buffer)
[400.530288] Starting subtest: create-protected-buffer
[400.531350] Subtest create-protected-buffer: SUCCESS (0.000s)
[400.627903] [113/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[400.717483] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[400.718816] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[400.794722] [114/133] (630s left) gem_mmap_gtt (big-bo-tiledy)
[400.829429] Starting subtest: big-bo-tiledY
[401.025392] Subtest big-bo-tiledY: SUCCESS (0.197s)
[401.142922] [115/133] (629s left) syncobj_basic (bad-destroy)
[401.220480] Starting subtest: bad-destroy
[401.221215] Subtest bad-destroy: SUCCESS (0.000s)
[401.301054] [116/133] (629s left) gem_readwrite (new-obj)
[401.335423] Starting subtest: new-obj
[401.336840] Subtest new-obj: SUCCESS (0.000s)
[401.423977] [117/133] (629s left) i915_pm_rps (thresholds)
[401.462501] Starting subtest: thresholds
[401.463180] Starting dynamic subtest: gt0
[411.538910] Dynamic subtest gt0: SUCCESS (10.073s)
[411.542186] Subtest thresholds: SUCCESS (10.075s)
[411.618757] [118/133] (619s left) kms_chamelium_audio (dp-audio)
[411.768594] Subtest dp-audio: SKIP (0.000s)
[411.872600] [119/133] (619s left) gem_mmap (big-bo)
[411.910128] Starting subtest: big-bo
[411.996776] Subtest big-bo: SUCCESS (0.087s)
[412.098449] [120/133] (619s left) kms_properties (get_properties-sanity-non-atomic)
[412.229315] Starting subtest: get_properties-sanity-non-atomic
[412.231906] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s)
[412.288239] [121/133] (618s left) kms_async_flips (test-time-stamp-atomic)
[412.374750] Starting subtest: test-time-stamp-atomic
[412.499239] Starting dynamic subtest: pipe-A-HDMI-A-1
[412.610446] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.110s)
[412.745800] Starting dynamic subtest: pipe-B-HDMI-A-1
[412.836482] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.102s)
[412.952395] Starting dynamic subtest: pipe-C-HDMI-A-1
[413.026988] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.084s)
[413.145286] Starting dynamic subtest: pipe-D-HDMI-A-1
[413.227333] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.091s)
[413.228036] Subtest test-time-stamp-atomic: SUCCESS (0.854s)
[413.476434] [122/133] (617s left) kms_big_fb (linear-addfb)
[413.579752] Starting subtest: linear-addfb
[413.580522] Subtest linear-addfb: SUCCESS (0.000s)
[413.675439] [123/133] (617s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[413.765243] Starting subtest: fbc-rgb565-draw-pwrite
[415.100225] Subtest fbc-rgb565-draw-pwrite: SUCCESS (1.335s)
[415.213010] [124/133] (616s left) kms_lease (atomic-implicit-crtc)
[415.300090] Starting subtest: atomic-implicit-crtc
[415.302336] Starting dynamic subtest: pipe-A-HDMI-A-1
[415.305862] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[415.316662] Starting dynamic subtest: pipe-B-HDMI-A-1
[415.320450] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[415.331072] Starting dynamic subtest: pipe-C-HDMI-A-1
[415.334684] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s)
[415.345210] Starting dynamic subtest: pipe-D-HDMI-A-1
[415.348591] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[415.349318] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[415.418702] [125/133] (615s left) gem_exec_schedule (implicit-write-read)
[415.469230] Starting subtest: implicit-write-read
[415.469952] Starting dynamic subtest: rcs0
[415.529863] Dynamic subtest rcs0: SUCCESS (0.060s)
[415.542521] Starting dynamic subtest: bcs0
[415.594144] Dynamic subtest bcs0: SUCCESS (0.062s)
[415.609097] Starting dynamic subtest: vcs0
[415.661112] Dynamic subtest vcs0: SUCCESS (0.064s)
[415.674113] Starting dynamic subtest: vcs1
[415.726043] Dynamic subtest vcs1: SUCCESS (0.063s)
[415.738982] Starting dynamic subtest: vecs0
[415.791320] Dynamic subtest vecs0: SUCCESS (0.063s)
[415.794150] Subtest implicit-write-read: SUCCESS (0.323s)
[416.099191] [126/133] (615s left) i915_drm_fdinfo (memory-info-idle)
[416.136242] Starting subtest: memory-info-idle
[416.136950] Starting dynamic subtest: smem0
[416.175216] Dynamic subtest smem0: SUCCESS (0.038s)
[416.175942] Subtest memory-info-idle: SUCCESS (0.039s)
[416.255653] [127/133] (615s left) api_intel_allocator (simple-allocator)
[416.289016] Starting subtest: simple-allocator
[416.289779] Starting dynamic subtest: basic
[416.291709] Dynamic subtest basic: SUCCESS (0.002s)
[416.300628] Starting dynamic subtest: parallel-one
[416.472130] Dynamic subtest parallel-one: SUCCESS (0.172s)
[416.480886] Starting dynamic subtest: print
[416.481670] Dynamic subtest print: SUCCESS (0.000s)
[416.490131] Starting dynamic subtest: reuse
[416.490821] Dynamic subtest reuse: SUCCESS (0.000s)
[416.499187] Starting dynamic subtest: reserve
[416.499890] Dynamic subtest reserve: SUCCESS (0.000s)
[416.508364] Starting dynamic subtest: fork-reopen-allocator
[416.509140] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[416.509863] Subtest simple-allocator: SUCCESS (0.193s)
[416.546234] [128/133] (614s left) gem_spin_batch (resubmit)
[416.589856] Starting subtest: resubmit
[416.590592] Starting dynamic subtest: rcs0
[416.593313] Dynamic subtest rcs0: SUCCESS (0.003s)
[416.603720] Starting dynamic subtest: bcs0
[416.604486] Dynamic subtest bcs0: SUCCESS (0.002s)
[416.613261] Starting dynamic subtest: vcs0
[416.613958] Dynamic subtest vcs0: SUCCESS (0.003s)
[416.622032] Starting dynamic subtest: vcs1
[416.622724] Dynamic subtest vcs1: SUCCESS (0.002s)
[416.630380] Starting dynamic subtest: vecs0
[416.631045] Dynamic subtest vecs0: SUCCESS (0.002s)
[416.631700] Subtest resubmit: SUCCESS (0.019s)
[416.796506] [129/133] (614s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[416.893785] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[417.517649] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.623s)
[417.639753] [130/133] (613s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[417.725838] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[417.727362] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[417.786710] [131/133] (613s left) gem_eio (in-flight-contexts-10ms)
[417.828233] Starting subtest: in-flight-contexts-10ms
[431.780207] Subtest in-flight-contexts-10ms: SUCCESS (13.950s)
[431.913151] [132/133] (599s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[431.948566] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[432.049396] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.100s)
[432.139002] [133/133] (599s left) gem_userptr_blits (userfault)
[432.177521] Starting subtest: userfault
[432.179450] Subtest userfault: SUCCESS (0.003s)
[432.300998] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: gem_exec_capture
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: gem_lmem_swapping
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_lowres
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_ctx_shared
results: parsing output: 27/ for test: tools_test
results: parsing output: 28/ for test: kms_selftest
results: parsing output: 29/ for test: kms_pm_lpsp
results: parsing output: 30/ for test: kms_cursor_edge_walk
results: parsing output: 31/ for test: kms_plane_alpha_blend
results: parsing output: 32/ for test: kms_prop_blob
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: gem_close
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: sriov_basic
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_ctx_bad_destroy
results: parsing output: 43/ for test: kms_dp_aux_dev
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_busy
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_fence_thrash
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: gen3_render_mixed_blits
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_ctx_exec
results: parsing output: 63/ for test: gem_exec_flush
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_tiled_blits
results: parsing output: 73/ for test: kms_draw_crc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: drm_buddy
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_invalid_mode
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_concurrent
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: gem_ctx_isolation
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_chamelium_edid
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_exec
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: gem_pread
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: gem_pxp
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: syncobj_basic
results: parsing output: 115/ for test: gem_readwrite
results: parsing output: 116/ for test: i915_pm_rps
results: parsing output: 117/ for test: kms_chamelium_audio
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: kms_properties
results: parsing output: 120/ for test: kms_async_flips
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_userptr_blits
Done.