[66.820519] Initializing watchdogs
[66.820599]   /dev/watchdog0
[66.850993] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[66.865833] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[66.870394] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.873613] [001/132] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[66.935920] Starting subtest: invalid-bsd2-flag-on-render
[66.937300] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[67.088051] [002/132] (960s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[67.136851] Starting subtest: rel-constants-invalid-rel-gen5
[67.138238] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[67.298998] [003/132] (960s left) kms_chamelium_frames (dp-frame-dump)
[68.821930] Subtest dp-frame-dump: SKIP (0.000s)
[68.930571] [004/132] (958s left) gem_lmem_swapping (basic)
[73.067916] Starting subtest: basic
[73.069922] Starting dynamic subtest: lmem0
[96.116157] Dynamic subtest lmem0: SUCCESS (23.056s)
[96.117475] Subtest basic: SUCCESS (23.056s)
[97.465292] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[97.467562] [005/132] (930s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[100.723559] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[100.829905] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[100.914028] [FACT syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[100.917315] [006/132] (926s left) gem_mmap_gtt (hang)
[100.966382] Subtest hang: SKIP (0.000s)
[101.041840] [007/132] (926s left) gem_ringfill (basic-all)
[101.467096] Starting subtest: basic-all
[102.748794] Subtest basic-all: SUCCESS (1.285s)
[102.962461] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[102.965771] [008/132] (924s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[104.458925] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[107.002725] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.546s)
[107.219844] [009/132] (920s left) kms_frontbuffer_tracking (psr-suspend)
[108.710433] Starting subtest: psr-suspend
[108.713634] Subtest psr-suspend: SKIP (0.000s)
[108.886585] [010/132] (919s left) kms_psr (fbc-psr2-primary-blt)
[110.386199] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[110.446641] [011/132] (917s left) gem_partial_pwrite_pread (writes-after-reads)
[110.499375] Subtest writes-after-reads: SKIP (0.000s)
[110.600392] [012/132] (917s left) kms_prop_blob (blob-multiple)
[110.648136] Starting subtest: blob-multiple
[110.649760] Subtest blob-multiple: SUCCESS (0.002s)
[110.780680] [013/132] (917s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[112.272980] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[112.276233] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[112.464064] [014/132] (915s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[113.972973] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[113.975680] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[114.167702] [015/132] (914s left) kms_lease (atomic-implicit-crtc)
[115.658079] Starting subtest: atomic-implicit-crtc
[115.659731] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.667809] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[115.677815] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.686073] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.008s)
[115.695827] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.704365] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.007s)
[115.713960] Starting dynamic subtest: pipe-D-HDMI-A-1
[115.722989] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.007s)
[115.724967] Subtest atomic-implicit-crtc: SUCCESS (0.031s)
[115.843970] [016/132] (912s left) kms_psr (psr2-sprite-mmap-cpu)
[117.330847] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[117.423975] [017/132] (911s left) perf_pmu (invalid-open)
[117.485091] Starting subtest: invalid-open
[117.486890] Subtest invalid-open: SUCCESS (0.000s)
[117.622717] [018/132] (911s left) kms_psr (pr-primary-blt)
[119.110442] Subtest pr-primary-blt: SKIP (0.000s)
[119.178158] [019/132] (909s left) syncobj_wait (multi-wait-for-submit-signaled)
[119.226227] Starting subtest: multi-wait-for-submit-signaled
[119.227901] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[119.337414] [020/132] (909s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[120.823745] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[120.825508] Starting dynamic subtest: pipe-A
[120.975812] Dynamic subtest pipe-A: SUCCESS (0.154s)
[120.987433] Starting dynamic subtest: pipe-B
[121.133455] Dynamic subtest pipe-B: SUCCESS (0.158s)
[121.142957] Starting dynamic subtest: pipe-C
[121.272901] Dynamic subtest pipe-C: SUCCESS (0.139s)
[121.282873] Starting dynamic subtest: pipe-D
[121.413188] Dynamic subtest pipe-D: SUCCESS (0.140s)
[121.414887] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.591s)
[121.643711] [021/132] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[123.138630] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[123.142597] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[123.342198] [022/132] (905s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[124.831665] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[124.928540] [023/132] (904s left) kms_dp_link_training (uhbr-sst)
[126.419675] Starting subtest: uhbr-sst
[126.422817] Subtest uhbr-sst: SKIP (0.000s)
[126.562647] [024/132] (902s left) kms_content_protection (type1)
[128.113377] Starting subtest: type1
[128.118534] Subtest type1: SKIP (0.002s)
[128.324911] [025/132] (901s left) gem_exec_whisper (basic-normal)
[128.383706] Starting subtest: basic-normal
[130.306039] Subtest basic-normal: SUCCESS (1.921s)
[130.529261] [026/132] (899s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[132.033873] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[133.170967] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.138s)
[133.408583] [027/132] (896s left) kms_invalid_mode (bad-vsync-start)
[134.896474] Starting subtest: bad-vsync-start
[134.897893] Starting dynamic subtest: pipe-A-HDMI-A-1
[134.942408] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.047s)
[134.953312] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.954858] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[134.964423] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.965873] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[134.975168] Starting dynamic subtest: pipe-D-HDMI-A-1
[134.976668] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[134.978113] Subtest bad-vsync-start: SUCCESS (0.055s)
[135.111123] [028/132] (894s left) kms_pm_rpm (dpms-non-lpsp)
[139.019549] Starting subtest: dpms-non-lpsp
[139.023055] Subtest dpms-non-lpsp: SKIP (0.001s)
[139.945983] [029/132] (889s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[141.432066] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[141.433559] Starting dynamic subtest: pipe-A-HDMI-A-1
[141.448213] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[141.458108] Starting dynamic subtest: pipe-B-HDMI-A-1
[141.473474] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[141.482947] Starting dynamic subtest: pipe-C-HDMI-A-1
[141.498740] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[141.508241] Starting dynamic subtest: pipe-D-HDMI-A-1
[141.525150] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[141.528419] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[141.663012] [030/132] (888s left) gem_mmap_offset (mmap-unmap)
[141.713194] Starting subtest: mmap-unmap
[141.714576] Starting dynamic subtest: lmem0
[142.984233] Dynamic subtest lmem0: SUCCESS (1.269s)
[142.993721] Starting dynamic subtest: smem0
[144.834096] Dynamic subtest smem0: SUCCESS (1.849s)
[144.835455] Subtest mmap-unmap: SUCCESS (3.119s)
[145.079400] [031/132] (884s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[148.993110] Starting subtest: gem-execbuf-stress-pc8
[149.078534] Subtest gem-execbuf-stress-pc8: SKIP (0.084s)
[150.634518] [032/132] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[152.137300] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[152.140258] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[152.299138] [033/132] (877s left) kms_cursor_edge_walk (64x64-top-edge)
[153.784828] Starting subtest: 64x64-top-edge
[153.786164] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.096072] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.309s)
[157.105907] Starting dynamic subtest: pipe-D-HDMI-A-1
[160.318664] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.212s)
[160.320700] Subtest 64x64-top-edge: SUCCESS (6.525s)
[160.483574] [034/132] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[161.975927] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[161.978851] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[162.188742] [035/132] (868s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[163.677637] Starting subtest: cursorA-vs-flipB-toggle
[163.690305] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[163.806475] [036/132] (866s left) gem_busy (close-race)
[163.871552] Starting subtest: close-race
[186.033097] Subtest close-race: SUCCESS (22.162s)
[186.613998] [037/132] (843s left) kms_plane_multiple (tiling-x)
[188.158222] Starting subtest: tiling-x
[188.159642] Starting dynamic subtest: pipe-A-HDMI-A-1
[189.017391] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.856s)
[189.028077] Starting dynamic subtest: pipe-B-HDMI-A-1
[189.770410] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.753s)
[189.781423] Starting dynamic subtest: pipe-C-HDMI-A-1
[190.509830] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.738s)
[190.522339] Starting dynamic subtest: pipe-D-HDMI-A-1
[191.242456] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.730s)
[191.243916] Subtest tiling-x: SUCCESS (3.083s)
[191.427342] [038/132] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[192.924555] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[192.927714] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[193.123773] [039/132] (837s left) gem_exec_reloc (basic-write-cpu-noreloc)
[193.179450] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[193.271023] [040/132] (837s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[194.762986] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[194.766333] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[194.962087] [041/132] (835s left) gem_exec_schedule (semaphore-noskip)
[195.036476] Starting subtest: semaphore-noskip
[195.411480] Subtest semaphore-noskip: SUCCESS (0.372s)
[195.811904] [042/132] (835s left) prime_mmap (test_dup)
[195.861233] Starting subtest: test_dup
[195.862939] Starting dynamic subtest: test_dup-smem
[195.925705] Dynamic subtest test_dup-smem: SUCCESS (0.065s)
[195.936295] Starting dynamic subtest: test_dup-lmem0
[195.991173] Dynamic subtest test_dup-lmem0: SUCCESS (0.064s)
[195.992506] Subtest test_dup: SUCCESS (0.131s)
[196.108291] [043/132] (834s left) gem_lmem_swapping (verify)
[200.328857] Starting subtest: verify
[200.331758] Starting dynamic subtest: lmem0
[240.279443] Dynamic subtest lmem0: SUCCESS (39.951s)
[240.280879] Subtest verify: SUCCESS (39.952s)
[241.646254] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[241.647383] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[241.650112] [044/132] (789s left) syncobj_wait (single-wait-submitted)
[244.916921] Starting subtest: single-wait-submitted
[245.023166] Subtest single-wait-submitted: SUCCESS (0.107s)
[245.125436] [FACT syncobj_wait (single-wait-submitted)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[245.128573] [FACT syncobj_wait (single-wait-submitted)] new: kernel.kmod_is_loaded.i915: true
[245.133443] [045/132] (786s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[246.620287] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[246.621839] Starting dynamic subtest: pipe-A-valid-mode
[247.840917] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.218s)
[247.842496] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (1.220s)
[248.012597] [046/132] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[249.508339] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[252.098412] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.593s)
[252.315516] [047/132] (779s left) prime_mmap (test_forked)
[252.363950] Starting subtest: test_forked
[252.365678] Starting dynamic subtest: test_forked-smem
[252.437923] Dynamic subtest test_forked-smem: SUCCESS (0.074s)
[252.448236] Starting dynamic subtest: test_forked-lmem0
[252.511777] Dynamic subtest test_forked-lmem0: SUCCESS (0.073s)
[252.513535] Subtest test_forked: SUCCESS (0.149s)
[252.665837] [048/132] (778s left) gem_fence_thrash (bo-write-verify-y)
[252.711823] Starting subtest: bo-write-verify-y
[252.717784] Subtest bo-write-verify-y: SKIP (0.003s)
[252.792074] [049/132] (778s left) i915_selftest (live)
[253.692999] Starting subtest: live
[253.694569] Starting dynamic subtest: sanitycheck
[255.009688] Dynamic subtest sanitycheck: SUCCESS (1.316s)
[255.019661] Starting dynamic subtest: uncore
[256.325320] Dynamic subtest uncore: SUCCESS (1.315s)
[256.334237] Starting dynamic subtest: workarounds
[259.542471] Dynamic subtest workarounds: SUCCESS (3.216s)
[259.551616] Starting dynamic subtest: gt_engines
[261.395398] Dynamic subtest gt_engines: SUCCESS (1.852s)
[261.404531] Starting dynamic subtest: gt_timelines
[327.075545] Dynamic subtest gt_timelines: SUCCESS (65.681s)
[327.084649] Starting dynamic subtest: gt_contexts
[328.462156] Dynamic subtest gt_contexts: SUCCESS (1.386s)
[328.470723] Starting dynamic subtest: gt_lrc
[334.435482] Dynamic subtest gt_lrc: SUCCESS (5.972s)
[334.444905] Starting dynamic subtest: gt_mocs
[336.663270] Dynamic subtest gt_mocs: SUCCESS (2.227s)
[336.672604] Starting dynamic subtest: gt_pm
[340.592154] Dynamic subtest gt_pm: SUCCESS (3.928s)
[340.601117] Starting dynamic subtest: gt_heartbeat
[341.936350] Dynamic subtest gt_heartbeat: SUCCESS (1.343s)
[341.945916] Starting dynamic subtest: gt_tlb
[355.692873] Dynamic subtest gt_tlb: SUCCESS (13.755s)
[355.702063] Starting dynamic subtest: requests
[366.295891] Dynamic subtest requests: SUCCESS (10.602s)
[366.306220] Starting dynamic subtest: migrate
[370.722416] Dynamic subtest migrate: SUCCESS (4.425s)
[370.731993] Starting dynamic subtest: active
[372.061101] Dynamic subtest active: SUCCESS (1.338s)
[372.069542] Starting dynamic subtest: objects
[374.314325] Dynamic subtest objects: SUCCESS (2.252s)
[374.323955] Starting dynamic subtest: mman
[377.811492] Dynamic subtest mman: SUCCESS (3.496s)
[377.821191] Starting dynamic subtest: dmabuf
[379.203197] Dynamic subtest dmabuf: SUCCESS (1.390s)
[379.212232] Starting dynamic subtest: vma
[380.533418] Dynamic subtest vma: SUCCESS (1.329s)
[380.542864] Starting dynamic subtest: coherency
[390.510385] Dynamic subtest coherency: SUCCESS (9.976s)
[390.519856] Starting dynamic subtest: gtt
[399.512659] Dynamic subtest gtt: SUCCESS (9.001s)
[399.521337] Starting dynamic subtest: gem
[401.014702] Dynamic subtest gem: SUCCESS (1.500s)
[401.024260] Starting dynamic subtest: evict
[412.384854] Dynamic subtest evict: SUCCESS (11.369s)
[412.394205] Starting dynamic subtest: hugepages
[429.565793] Dynamic subtest hugepages: SUCCESS (17.180s)
[429.574794] Starting dynamic subtest: gem_contexts
[457.431591] Dynamic subtest gem_contexts: SUCCESS (27.865s)
[457.440806] Starting dynamic subtest: client
[458.808733] Dynamic subtest client: SUCCESS (1.376s)
[458.817928] Starting dynamic subtest: gem_migrate
[461.311437] Dynamic subtest gem_migrate: SUCCESS (2.501s)
[461.320656] Starting dynamic subtest: reset
[462.649141] Dynamic subtest reset: SUCCESS (1.336s)
[462.658647] Starting dynamic subtest: memory_region
[465.559482] Dynamic subtest memory_region: SUCCESS (2.909s)
[465.568641] Starting dynamic subtest: hangcheck
[492.656586] Dynamic subtest hangcheck: SUCCESS (27.096s)
[492.665702] Starting dynamic subtest: execlists
[493.987277] Dynamic subtest execlists: SUCCESS (1.329s)
[493.996384] Starting dynamic subtest: ring_submission
[495.303575] Dynamic subtest ring_submission: SUCCESS (1.315s)
[495.312719] Starting dynamic subtest: perf
[496.725201] Dynamic subtest perf: SUCCESS (1.420s)
[496.734692] Starting dynamic subtest: slpc
[502.552196] Dynamic subtest slpc: SUCCESS (5.826s)
[502.561237] Starting dynamic subtest: guc
[505.909378] Dynamic subtest guc: SUCCESS (3.356s)
[505.918749] Starting dynamic subtest: guc_multi_lrc
[507.260333] Dynamic subtest guc_multi_lrc: SUCCESS (1.350s)
[507.269994] Starting dynamic subtest: guc_hang
[509.353297] Dynamic subtest guc_hang: SUCCESS (2.092s)
[509.362731] Starting dynamic subtest: late_gt_pm
[510.686400] Dynamic subtest late_gt_pm: SUCCESS (1.331s)
[510.687986] Subtest live: SUCCESS (257.000s)
[510.731793] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[510.732922] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[510.736143] [050/132] (520s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[515.450254] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[515.453303] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[515.662375] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[515.665999] [FACT kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)] new: kernel.kmod_is_loaded.i915: true
[515.672976] [051/132] (515s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[515.724416] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[515.726123] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[515.830760] [052/132] (515s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[515.878906] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[515.880641] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[515.999710] [053/132] (515s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[517.493332] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[517.496924] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[517.693939] [054/132] (514s left) kms_vrr (flip-basic)
[519.181733] Starting subtest: flip-basic
[519.186815] Subtest flip-basic: SKIP (0.000s)
[519.340157] [055/132] (512s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[520.832966] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[520.835959] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[521.016759] [056/132] (511s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[522.504650] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[522.506139] Starting dynamic subtest: pipe-A-HDMI-A-1
[522.521156] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[522.531099] Starting dynamic subtest: pipe-B-HDMI-A-1
[522.546478] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[522.556182] Starting dynamic subtest: pipe-C-HDMI-A-1
[522.572107] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[522.581778] Starting dynamic subtest: pipe-D-HDMI-A-1
[522.598114] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[522.601350] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.013s)
[522.743965] [057/132] (509s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[524.233538] Starting subtest: pixel-format-linear-modifier-source-clamping
[524.259647] Starting dynamic subtest: pipe-A-plane-0
[529.942378] Dynamic subtest pipe-A-plane-0: SUCCESS (5.683s)
[529.952908] Starting dynamic subtest: pipe-A-plane-3
[535.576894] Dynamic subtest pipe-A-plane-3: SUCCESS (5.632s)
[535.616554] Starting dynamic subtest: pipe-A-plane-5
[538.792516] Dynamic subtest pipe-A-plane-5: SUCCESS (3.211s)
[538.952436] Starting dynamic subtest: pipe-B-plane-0
[544.309839] Dynamic subtest pipe-B-plane-0: SUCCESS (5.366s)
[544.348774] Starting dynamic subtest: pipe-B-plane-3
[549.692523] Dynamic subtest pipe-B-plane-3: SUCCESS (5.380s)
[549.703881] Starting dynamic subtest: pipe-B-plane-5
[552.609172] Dynamic subtest pipe-B-plane-5: SUCCESS (2.915s)
[552.667694] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (28.436s)
[552.924344] [058/132] (479s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[554.421803] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[554.444726] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.021s)
[554.574321] [059/132] (477s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[556.079744] Starting subtest: y-tiled-16bpp-rotate-180
[557.890076] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.810s)
[558.085346] [060/132] (474s left) kms_flip (basic-flip-vs-dpms)
[559.572752] Starting subtest: basic-flip-vs-dpms
[559.579847] Starting dynamic subtest: A-HDMI-A1
[560.274951] Dynamic subtest A-HDMI-A1: SUCCESS (0.696s)
[560.286122] Starting dynamic subtest: B-HDMI-A1
[560.980992] Dynamic subtest B-HDMI-A1: SUCCESS (0.705s)
[560.991608] Starting dynamic subtest: C-HDMI-A1
[561.678677] Dynamic subtest C-HDMI-A1: SUCCESS (0.696s)
[561.689498] Starting dynamic subtest: D-HDMI-A1
[562.403217] Dynamic subtest D-HDMI-A1: SUCCESS (0.722s)
[562.407268] Subtest basic-flip-vs-dpms: SUCCESS (2.833s)
[562.595545] [061/132] (469s left) kms_pm_rpm (pm-caching)
[567.022035] Starting subtest: pm-caching
[567.025058] Subtest pm-caching: SKIP (0.000s)
[567.950969] [062/132] (464s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[569.438573] Starting subtest: compare-crc-sanitycheck-nv12
[569.442275] Starting dynamic subtest: pipe-A-HDMI-A-1
[570.079398] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.637s)
[570.093508] Starting dynamic subtest: pipe-B-HDMI-A-1
[570.591862] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.508s)
[570.603079] Starting dynamic subtest: pipe-C-HDMI-A-1
[571.074708] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.481s)
[571.088694] Starting dynamic subtest: pipe-D-HDMI-A-1
[571.580850] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.500s)
[571.582629] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.140s)
[571.772569] [063/132] (460s left) kms_color (deep-color)
[573.262863] Starting subtest: deep-color
[573.279972] Subtest deep-color: SKIP (0.004s)
[573.395087] [064/132] (459s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[574.904135] Starting subtest: x-tiled-8bpp-rotate-0
[576.588976] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.684s)
[576.822165] [065/132] (456s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[578.313310] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[578.384563] [066/132] (454s left) gem_mmap (basic)
[578.444649] Subtest basic: SKIP (0.000s)
[578.541008] [067/132] (454s left) gen9_exec_parse (bb-secure)
[578.598629] Subtest bb-secure: SKIP (0.000s)
[578.683632] [068/132] (454s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[580.175849] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[580.179615] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[580.352035] [069/132] (452s left) i915_drm_fdinfo (virtual-busy-idle)
[580.409783] Starting subtest: virtual-busy-idle
[580.412687] Subtest virtual-busy-idle: SKIP (0.000s)
[580.590700] [070/132] (452s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[582.077308] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[582.079915] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[582.279801] [071/132] (451s left) drm_read (empty-block)
[583.833843] Starting subtest: empty-block
[584.826650] Subtest empty-block: SUCCESS (1.000s)
[585.006202] [072/132] (448s left) perf_pmu (busy-accuracy-98)
[585.060567] Starting subtest: busy-accuracy-98
[585.061993] Starting dynamic subtest: rcs0
[588.106049] Dynamic subtest rcs0: SUCCESS (3.045s)
[588.117998] Starting dynamic subtest: bcs0
[591.154887] Dynamic subtest bcs0: SUCCESS (3.047s)
[591.166741] Starting dynamic subtest: vcs0
[594.203830] Dynamic subtest vcs0: SUCCESS (3.047s)
[594.216163] Starting dynamic subtest: vcs1
[597.250738] Dynamic subtest vcs1: SUCCESS (3.045s)
[597.262644] Starting dynamic subtest: vecs0
[600.298799] Dynamic subtest vecs0: SUCCESS (3.046s)
[600.300379] Subtest busy-accuracy-98: SUCCESS (15.240s)
[600.462076] [073/132] (433s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[601.959131] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[601.962366] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[602.146438] [074/132] (431s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[603.849702] Starting subtest: cursor-rapid-movement-256x256
[603.855847] Starting dynamic subtest: pipe-A-HDMI-A-1
[604.293615] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.438s)
[604.328144] Starting dynamic subtest: pipe-D-HDMI-A-1
[604.635936] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.320s)
[604.637393] Subtest cursor-rapid-movement-256x256: SUCCESS (0.789s)
[605.015718] [075/132] (428s left) gem_ccs (block-copy-uncompressed)
[605.069104] Starting subtest: block-copy-uncompressed
[605.070604] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[605.103360] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.033s)
[605.115213] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[605.120488] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.016s)
[605.132053] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[605.182073] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.060s)
[605.193672] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[605.242728] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[605.256220] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[605.260275] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[605.272034] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-lmem0
[605.276263] Dynamic subtest ymajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[605.287955] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-smem
[605.338205] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.060s)
[605.349920] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-lmem0
[605.398558] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[605.400145] Subtest block-copy-uncompressed: SUCCESS (0.330s)
[605.564790] [076/132] (428s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[607.059381] Starting subtest: fbcpsr-shrfb-scaledprimary
[607.062927] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[607.220292] [077/132] (426s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[608.755718] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[608.873718] [078/132] (425s left) prime_vgem (fence-write-hang)
[608.962042] Subtest fence-write-hang: SKIP (0.000s)
[609.133849] [079/132] (424s left) kms_cursor_crc (cursor-offscreen-256x256)
[610.847669] Starting subtest: cursor-offscreen-256x256
[610.855867] Starting dynamic subtest: pipe-A-HDMI-A-1
[613.361036] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.506s)
[613.394884] Starting dynamic subtest: pipe-D-HDMI-A-1
[615.776026] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.390s)
[615.777767] Subtest cursor-offscreen-256x256: SUCCESS (4.927s)
[616.151801] [080/132] (418s left) kms_async_flips (invalid-async-flip-atomic)
[617.640340] Starting subtest: invalid-async-flip-atomic
[617.908514] Starting dynamic subtest: pipe-A-HDMI-A-1
[618.353058] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.445s)
[618.499152] Starting dynamic subtest: pipe-B-HDMI-A-1
[618.584899] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.096s)
[618.762133] Starting dynamic subtest: pipe-C-HDMI-A-1
[618.851220] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.099s)
[619.017204] Starting dynamic subtest: pipe-D-HDMI-A-1
[619.113385] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s)
[619.114939] Subtest invalid-async-flip-atomic: SUCCESS (1.475s)
[619.463011] [081/132] (414s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[621.678902] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[621.759765] [082/132] (412s left) kms_async_flips (async-flip-hang)
[623.247184] Starting subtest: async-flip-hang
[623.521251] Starting dynamic subtest: pipe-A-HDMI-A-1
[638.463864] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.942s)
[638.635789] Starting dynamic subtest: pipe-B-HDMI-A-1
[653.433573] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.809s)
[653.611595] Starting dynamic subtest: pipe-C-HDMI-A-1
[678.458079] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (24.856s)
[678.606331] Starting dynamic subtest: pipe-D-HDMI-A-1
[693.435611] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.839s)
[693.436990] Subtest async-flip-hang: SUCCESS (70.192s)
[693.961846] [083/132] (340s left) gem_exec_reloc (basic-cpu-active)
[694.118692] Subtest basic-cpu-active: SKIP (0.000s)
[694.478465] [084/132] (340s left) kms_force_connector_basic (prune-stale-modes)
[694.705124] Starting subtest: prune-stale-modes
[694.836215] Subtest prune-stale-modes: SUCCESS (0.133s)
[695.794139] [085/132] (338s left) gem_exec_suspend (basic)
[695.852648] Starting subtest: basic
[695.854141] Starting dynamic subtest: smem
[697.213193] Dynamic subtest smem: SUCCESS (1.360s)
[697.227471] Starting dynamic subtest: lmem0
[698.511427] Dynamic subtest lmem0: SUCCESS (1.297s)
[698.513051] Subtest basic: SUCCESS (2.660s)
[698.768730] [086/132] (335s left) gem_ctx_persistence (legacy-engines-persistence)
[698.821297] Starting subtest: legacy-engines-persistence
[698.822883] Starting dynamic subtest: render
[699.633969] Dynamic subtest render: SUCCESS (0.811s)
[699.649455] Starting dynamic subtest: bsd1
[700.390870] Dynamic subtest bsd1: SUCCESS (0.754s)
[700.406209] Starting dynamic subtest: bsd2
[701.163908] Dynamic subtest bsd2: SUCCESS (0.771s)
[701.179221] Starting dynamic subtest: blt
[701.927913] Dynamic subtest blt: SUCCESS (0.761s)
[701.943115] Starting dynamic subtest: vebox
[702.693922] Dynamic subtest vebox: SUCCESS (0.763s)
[702.695948] Subtest legacy-engines-persistence: SUCCESS (3.874s)
[702.882882] [087/132] (331s left) gem_exec_reloc (basic-concurrent0)
[702.937953] Subtest basic-concurrent0: SKIP (0.000s)
[703.068651] [088/132] (331s left) kms_psr (psr-sprite-plane-onoff)
[704.558428] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[704.652154] [089/132] (330s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[706.153625] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[706.156737] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[706.349308] [090/132] (328s left) syncobj_timeline (invalid-query-bad-pad)
[706.396858] Starting subtest: invalid-query-bad-pad
[706.398578] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[706.532637] [091/132] (328s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[708.025580] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[708.028920] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[708.226901] [092/132] (327s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[709.736652] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[710.994408] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.257s)
[711.221469] [093/132] (324s left) gem_exec_balancer (smoke)
[711.282624] Starting subtest: smoke
[735.297212] Subtest smoke: SUCCESS (24.012s)
[736.057357] [094/132] (299s left) gem_pread (self)
[736.118516] Subtest self: SKIP (0.000s)
[736.189967] [095/132] (299s left) kms_flip (2x-flip-vs-panning-vs-hang)
[737.675914] Starting subtest: 2x-flip-vs-panning-vs-hang
[737.698398] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.021s)
[737.868848] [096/132] (297s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[739.356821] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[739.360031] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[739.478638] [097/132] (296s left) drm_mm (drm_mm)
[739.605101] Starting subtest: drm_mm
[739.730953] Starting dynamic subtest: drm_test_mm_init
[739.795067] Dynamic subtest drm_test_mm_init: SUCCESS (0.064s)
[739.811008] Starting dynamic subtest: drm_test_mm_debug
[739.874907] Dynamic subtest drm_test_mm_debug: SUCCESS (0.076s)
[739.922322] Starting dynamic subtest: drm_test_mm_align32
[739.949945] Dynamic subtest drm_test_mm_align32: SUCCESS (0.072s)
[739.967549] Starting dynamic subtest: drm_test_mm_align64
[740.052052] Dynamic subtest drm_test_mm_align64: SUCCESS (0.085s)
[740.095567] Starting dynamic subtest: drm_test_mm_lowest
[740.118318] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.073s)
[740.135737] Starting dynamic subtest: drm_test_mm_highest
[740.201328] Dynamic subtest drm_test_mm_highest: SUCCESS (0.079s)
[740.203898] Subtest drm_mm: SUCCESS (0.666s)
[740.441927] [098/132] (295s left) gem_mmap_wc (set-cache-level)
[740.492428] Subtest set-cache-level: SKIP (0.000s)
[740.572675] [099/132] (295s left) i915_drm_fdinfo (busy-idle-check-all)
[740.624960] Starting subtest: busy-idle-check-all
[740.626543] Starting dynamic subtest: rcs0
[740.645932] Dynamic subtest rcs0: SKIP (0.019s)
[740.658221] Starting dynamic subtest: bcs0
[740.661326] Dynamic subtest bcs0: SKIP (0.000s)
[740.673175] Starting dynamic subtest: vcs0
[740.676387] Dynamic subtest vcs0: SKIP (0.000s)
[740.688202] Starting dynamic subtest: vcs1
[740.691649] Dynamic subtest vcs1: SKIP (0.000s)
[740.704457] Starting dynamic subtest: vecs0
[740.707877] Dynamic subtest vecs0: SKIP (0.000s)
[740.711219] Subtest busy-idle-check-all: SKIP (0.028s)
[740.779153] [100/132] (295s left) gem_create (hog-create)
[740.868064] Starting subtest: hog-create
[740.869814] Starting dynamic subtest: lmem0
[773.159861] Dynamic subtest lmem0: SUCCESS (32.294s)
[773.172058] Starting dynamic subtest: smem0
[805.420929] Dynamic subtest smem0: SUCCESS (32.260s)
[805.422952] Subtest hog-create: SUCCESS (64.558s)
[805.699792] [101/132] (230s left) api_intel_bb (full-batch)
[805.749216] Starting subtest: full-batch
[805.765886] Subtest full-batch: SUCCESS (0.018s)
[805.951661] [102/132] (230s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[807.437656] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[807.441625] Starting dynamic subtest: pipe-A-valid-mode
[808.670956] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.230s)
[808.672649] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.233s)
[808.858130] [103/132] (227s left) kms_cursor_legacy (forked-bo)
[810.345849] Starting subtest: forked-bo
[810.347470] Starting dynamic subtest: pipe-A
[815.779993] Dynamic subtest pipe-A: SUCCESS (5.430s)
[815.798575] Starting dynamic subtest: pipe-B
[821.221592] Dynamic subtest pipe-B: SUCCESS (5.439s)
[821.257937] Starting dynamic subtest: pipe-C
[826.669615] Dynamic subtest pipe-C: SUCCESS (5.445s)
[826.713970] Starting dynamic subtest: pipe-D
[832.120814] Dynamic subtest pipe-D: SUCCESS (5.447s)
[832.165973] Starting dynamic subtest: all-pipes
[837.583080] Dynamic subtest all-pipes: SUCCESS (5.460s)
[837.584864] Subtest forked-bo: SUCCESS (27.235s)
[837.702015] [104/132] (198s left) prime_mmap (test_correct)
[837.758169] Starting subtest: test_correct
[837.759562] Starting dynamic subtest: test_correct-smem
[837.849684] Dynamic subtest test_correct-smem: SUCCESS (0.100s)
[837.861737] Starting dynamic subtest: test_correct-lmem0
[837.950361] Dynamic subtest test_correct-lmem0: SUCCESS (0.099s)
[837.951884] Subtest test_correct: SUCCESS (0.202s)
[838.073726] [105/132] (198s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[839.565108] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[839.567738] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[839.792216] [106/132] (196s left) gem_exec_balancer (full-late-pulse)
[839.849371] Starting subtest: full-late-pulse
[842.291952] Subtest full-late-pulse: SUCCESS (2.443s)
[842.780133] [107/132] (193s left) kms_cdclk (plane-scaling)
[842.830510] Subtest plane-scaling: SKIP (0.000s)
[842.905347] [108/132] (193s left) gem_userptr_blits (input-checking)
[842.960515] Starting subtest: input-checking
[842.962105] Subtest input-checking: SUCCESS (0.000s)
[843.171602] [109/132] (193s left) gem_spin_batch (spin-each)
[843.232630] Starting subtest: spin-each
[846.513868] Subtest spin-each: SUCCESS (3.281s)
[846.854787] [110/132] (190s left) sw_sync (sync_multi_consumer)
[846.902166] Starting subtest: sync_multi_consumer
[847.334228] Subtest sync_multi_consumer: SUCCESS (0.431s)
[847.425609] [111/132] (189s left) gem_exec_reloc (basic-wc-gtt-active)
[847.484494] Subtest basic-wc-gtt-active: SKIP (0.000s)
[847.590269] [112/132] (189s left) gem_userptr_blits (nohangcheck)
[847.661580] Starting subtest: nohangcheck
[847.795340] Subtest nohangcheck: SUCCESS (0.136s)
[847.978932] [113/132] (189s left) kms_plane (plane-position-hole)
[849.486389] Starting subtest: plane-position-hole
[849.928993] Starting dynamic subtest: pipe-A-plane-1
[850.306519] Dynamic subtest pipe-A-plane-1: SUCCESS (0.376s)
[850.318787] Starting dynamic subtest: pipe-A-plane-2
[850.685790] Dynamic subtest pipe-A-plane-2: SUCCESS (0.377s)
[850.698027] Starting dynamic subtest: pipe-A-plane-3
[851.061299] Dynamic subtest pipe-A-plane-3: SUCCESS (0.375s)
[851.073706] Starting dynamic subtest: pipe-A-plane-4
[851.439214] Dynamic subtest pipe-A-plane-4: SUCCESS (0.375s)
[851.451860] Starting dynamic subtest: pipe-A-plane-5
[851.815218] Dynamic subtest pipe-A-plane-5: SUCCESS (0.376s)
[851.827346] Starting dynamic subtest: pipe-A-plane-6
[852.192447] Dynamic subtest pipe-A-plane-6: SUCCESS (0.375s)
[852.204747] Starting dynamic subtest: pipe-A-plane-7
[852.215509] Dynamic subtest pipe-A-plane-7: SUCCESS (0.021s)
[852.506772] Starting dynamic subtest: pipe-B-plane-1
[852.868066] Dynamic subtest pipe-B-plane-1: SUCCESS (0.375s)
[852.880475] Starting dynamic subtest: pipe-B-plane-2
[853.226425] Dynamic subtest pipe-B-plane-2: SUCCESS (0.356s)
[853.238743] Starting dynamic subtest: pipe-B-plane-3
[853.566793] Dynamic subtest pipe-B-plane-3: SUCCESS (0.338s)
[853.579585] Starting dynamic subtest: pipe-B-plane-4
[853.942872] Dynamic subtest pipe-B-plane-4: SUCCESS (0.376s)
[853.955150] Starting dynamic subtest: pipe-B-plane-5
[854.316093] Dynamic subtest pipe-B-plane-5: SUCCESS (0.371s)
[854.328442] Starting dynamic subtest: pipe-B-plane-6
[854.709444] Dynamic subtest pipe-B-plane-6: SUCCESS (0.391s)
[854.722051] Starting dynamic subtest: pipe-B-plane-7
[854.735151] Dynamic subtest pipe-B-plane-7: SUCCESS (0.023s)
[854.736727] Subtest plane-position-hole: SUCCESS (5.250s)
[854.965496] [114/132] (182s left) sw_sync (sync_expired_merge)
[855.023257] Starting subtest: sync_expired_merge
[856.100279] Subtest sync_expired_merge: SUCCESS (1.074s)
[856.187906] [115/132] (181s left) gem_ctx_persistence (engines-mixed-process)
[856.240865] Starting subtest: engines-mixed-process
[856.242315] Starting dynamic subtest: rcs0
[857.837428] Dynamic subtest rcs0: SUCCESS (1.596s)
[857.852764] Starting dynamic subtest: bcs0
[859.898599] Dynamic subtest bcs0: SUCCESS (2.059s)
[859.913851] Starting dynamic subtest: vcs0
[861.857577] Dynamic subtest vcs0: SUCCESS (1.957s)
[861.871183] Starting dynamic subtest: vcs1
[863.850541] Dynamic subtest vcs1: SUCCESS (1.991s)
[863.866110] Starting dynamic subtest: vecs0
[865.838771] Dynamic subtest vecs0: SUCCESS (1.986s)
[865.840677] Subtest engines-mixed-process: SUCCESS (9.599s)
[866.011257] [116/132] (171s left) kms_addfb_basic (bad-pitch-999)
[866.060983] Starting subtest: bad-pitch-999
[866.062358] Subtest bad-pitch-999: SUCCESS (0.000s)
[867.700223] [117/132] (169s left) gem_exec_fence (submit3)
[867.876050] Starting subtest: submit3
[867.879695] Subtest submit3: SKIP (0.000s)
[868.555871] [118/132] (169s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[868.606926] Starting subtest: single-wait-for-submit-available-signaled
[868.608686] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[868.730910] [119/132] (168s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[868.780203] Starting subtest: etime-single-wait-all-for-submit-submitted
[868.890257] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[869.022985] [120/132] (168s left) gem_exec_schedule (noreorder)
[869.248770] Starting subtest: noreorder
[869.250587] Starting dynamic subtest: rcs0
[869.339878] Dynamic subtest rcs0: SUCCESS (0.093s)
[869.359196] Starting dynamic subtest: bcs0
[869.389906] Dynamic subtest bcs0: SUCCESS (0.048s)
[869.413270] Starting dynamic subtest: vcs0
[869.447385] Dynamic subtest vcs0: SUCCESS (0.055s)
[869.484830] Starting dynamic subtest: vcs1
[869.525060] Dynamic subtest vcs1: SUCCESS (0.074s)
[869.553222] Starting dynamic subtest: vecs0
[869.588269] Dynamic subtest vecs0: SUCCESS (0.060s)
[869.590269] Subtest noreorder: SUCCESS (0.345s)
[869.926946] [121/132] (167s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[871.421108] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[871.424211] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[871.613429] [122/132] (166s left) gem_eio (wait-wedge-immediate)
[871.800514] Starting subtest: wait-wedge-immediate
[872.864296] Subtest wait-wedge-immediate: SUCCESS (1.063s)
[874.469789] [123/132] (163s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[874.522117] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[874.604018] [124/132] (163s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[876.110037] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[876.113068] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[876.293297] [125/132] (162s left) sysfs_heartbeat_interval (nopreempt)
[876.346841] Starting subtest: nopreempt
[876.348610] Starting dynamic subtest: vecs0
[880.409011] Dynamic subtest vecs0: SUCCESS (4.062s)
[880.421901] Starting dynamic subtest: vcs0
[884.401492] Dynamic subtest vcs0: SUCCESS (3.990s)
[884.415056] Starting dynamic subtest: bcs0
[888.396490] Dynamic subtest bcs0: SUCCESS (3.994s)
[888.419755] Starting dynamic subtest: rcs0
[892.438199] Dynamic subtest rcs0: SUCCESS (4.034s)
[892.451717] Starting dynamic subtest: vcs1
[896.441130] Dynamic subtest vcs1: SUCCESS (4.001s)
[896.442774] Subtest nopreempt: SUCCESS (20.097s)
[896.633268] [126/132] (141s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[898.123566] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[898.124989] Starting dynamic subtest: pipe-A-HDMI-A-1
[898.139409] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[898.152690] Starting dynamic subtest: pipe-B-HDMI-A-1
[898.167381] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[898.180405] Starting dynamic subtest: pipe-C-HDMI-A-1
[898.195537] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[898.208629] Starting dynamic subtest: pipe-D-HDMI-A-1
[898.224352] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[898.227494] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.011s)
[898.378628] [127/132] (140s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[899.867819] Starting subtest: flip-vs-cursor-busy-crc-atomic
[900.590278] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.722s)
[900.775755] [128/132] (137s left) kms_psr (fbc-psr-cursor-plane-onoff)
[902.264644] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[902.337481] [129/132] (136s left) gem_pxp (protected-raw-src-copy-not-readible)
[904.908253] Starting subtest: protected-raw-src-copy-not-readible
[904.912052] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[905.049229] [130/132] (133s left) perf (missing-sample-flags)
[905.292823] Starting subtest: missing-sample-flags
[905.294241] Subtest missing-sample-flags: SUCCESS (0.000s)
[905.372651] [131/132] (133s left) syncobj_wait (wait-all-delayed-signal)
[905.421717] Starting subtest: wait-all-delayed-signal
[905.528220] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[905.724320] [132/132] (133s left) template (b)
[905.771938] Starting subtest: B
[905.773498] Subtest B: SUCCESS (0.000s)
[905.893441] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_chamelium_frames
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_ringfill
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_prop_blob
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_dp_link_training
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_invalid_mode
results: parsing output: 27/ for test: kms_pm_rpm
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_mmap_offset
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: gem_busy
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: prime_mmap
results: parsing output: 47/ for test: gem_fence_thrash
results: parsing output: 48/ for test: i915_selftest
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: drm_read
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_tiled_display
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_force_connector_basic
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: gem_pread
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: drm_mm
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: gem_create
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: prime_mmap
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_cdclk
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: gem_spin_batch
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: sw_sync
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: sriov_basic
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: sysfs_heartbeat_interval
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: template
Done.