[65.892700] Initializing watchdogs
[65.892778]   /dev/watchdog0
[65.923531] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[65.938705] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[65.943397] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.946760] [001/131] (960s left) gem_userptr_blits (create-destroy-unsync)
[66.012896] Subtest create-destroy-unsync: SKIP (0.000s)
[66.226637] [002/131] (960s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[66.278493] Starting subtest: x-tiled-to-vebox-y-tiled
[66.280325] Starting dynamic subtest: smem
[66.369206] Dynamic subtest smem: SUCCESS (0.091s)
[66.377895] Starting dynamic subtest: lmem0
[67.128391] Dynamic subtest lmem0: SUCCESS (0.756s)
[67.130243] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.847s)
[67.408931] [003/131] (959s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[69.421742] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[69.425755] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[69.612448] [004/131] (957s left) perf_pmu (rc6-suspend)
[69.663931] Starting subtest: rc6-suspend
[97.117620] Subtest rc6-suspend: SUCCESS (16.020s)
[98.089771] [005/131] (928s left) kms_getfb (getfb2-handle-closed)
[100.081153] Starting subtest: getfb2-handle-closed
[100.082577] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[100.326000] [006/131] (926s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[102.310001] Starting subtest: fb-8bpc-vs-panel-8bpc
[102.325028] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[102.491958] [007/131] (924s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[104.488539] Starting subtest: cursorA-vs-flipA-atomic
[115.452138] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.965s)
[115.640252] [008/131] (911s left) gen9_exec_parse (shadow-peek)
[115.692914] Subtest shadow-peek: SKIP (0.000s)
[115.766551] [009/131] (911s left) gem_exec_fence (syncobj-unused-fence)
[116.198757] Starting subtest: syncobj-unused-fence
[116.220067] Subtest syncobj-unused-fence: SUCCESS (0.021s)
[116.703864] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[116.706729] [010/131] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[118.703058] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[118.706415] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[118.966756] [011/131] (908s left) perf (stress-open-close)
[119.139425] Starting subtest: stress-open-close
[119.141113] Starting dynamic subtest: 0-rcs0
[121.361554] Dynamic subtest 0-rcs0: SUCCESS (2.223s)
[121.363404] Subtest stress-open-close: SUCCESS (2.223s)
[121.456755] [012/131] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[123.451464] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[123.454689] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[123.683944] [013/131] (904s left) kms_plane (planar-pixel-format-settings)
[125.671197] Starting subtest: planar-pixel-format-settings
[125.719202] Subtest planar-pixel-format-settings: SUCCESS (0.047s)
[125.952637] [014/131] (901s left) gem_mmap_wc (copy)
[126.021277] Subtest copy: SKIP (0.000s)
[126.118196] [015/131] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[128.113840] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[128.117254] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[128.371030] [016/131] (899s left) gem_mmap_wc (write-wc-read-gtt)
[128.418842] Subtest write-wc-read-gtt: SKIP (0.000s)
[128.488289] [017/131] (899s left) kms_pm_rpm (modeset-pc8-residency-stress)
[133.564899] Starting subtest: modeset-pc8-residency-stress
[133.570371] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[134.803507] [018/131] (893s left) gem_mmap_gtt (hang-busy)
[134.859621] Subtest hang-busy: SKIP (0.000s)
[134.929453] [019/131] (893s left) gem_exec_schedule (submit-early-slice)
[134.990756] Starting subtest: submit-early-slice
[134.992401] Starting dynamic subtest: rcs0
[135.053427] Dynamic subtest rcs0: SUCCESS (0.062s)
[135.065387] Starting dynamic subtest: bcs0
[135.096491] Dynamic subtest bcs0: SUCCESS (0.043s)
[135.108235] Starting dynamic subtest: vcs0
[135.141080] Dynamic subtest vcs0: SUCCESS (0.044s)
[135.153226] Starting dynamic subtest: vcs1
[135.185674] Dynamic subtest vcs1: SUCCESS (0.044s)
[135.197487] Starting dynamic subtest: vecs0
[135.227738] Dynamic subtest vecs0: SUCCESS (0.042s)
[135.229654] Subtest submit-early-slice: SUCCESS (0.237s)
[135.691801] [020/131] (892s left) gem_exec_params (invalid-ring)
[135.744600] Starting subtest: invalid-ring
[135.746277] Subtest invalid-ring: SUCCESS (0.000s)
[135.959598] [021/131] (892s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[137.947372] Starting subtest: cursorA-vs-flipB-toggle
[137.950502] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[138.132025] [022/131] (890s left) sw_sync (sync_expired_merge)
[138.179656] Starting subtest: sync_expired_merge
[139.256781] Subtest sync_expired_merge: SUCCESS (1.074s)
[139.368954] [023/131] (889s left) gem_mmap_gtt (big-copy-xy)
[139.416974] Subtest big-copy-XY: SKIP (0.000s)
[139.502795] [024/131] (889s left) kms_addfb_basic (bad-pitch-0)
[139.549952] Starting subtest: bad-pitch-0
[139.551658] Subtest bad-pitch-0: SUCCESS (0.000s)
[141.761516] [025/131] (887s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[143.755985] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[143.758919] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[143.977687] [026/131] (885s left) kms_big_fb (linear-64bpp-rotate-270)
[145.986470] Starting subtest: linear-64bpp-rotate-270
[146.061266] Subtest linear-64bpp-rotate-270: SKIP (0.073s)
[146.270197] [027/131] (882s left) kms_sequence (get-idle)
[148.257145] Starting subtest: get-idle
[148.258700] Starting dynamic subtest: pipe-A-HDMI-A-4
[150.645771] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.386s)
[150.657452] Starting dynamic subtest: pipe-B-HDMI-A-4
[152.874708] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.226s)
[152.886660] Starting dynamic subtest: pipe-C-HDMI-A-4
[155.103394] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.229s)
[155.115400] Starting dynamic subtest: pipe-D-HDMI-A-4
[157.340926] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.236s)
[157.342532] Subtest get-idle: SUCCESS (9.082s)
[157.560642] [028/131] (871s left) gem_mmap_wc (read-write)
[157.620397] Subtest read-write: SKIP (0.000s)
[157.698519] [029/131] (871s left) gem_caching (read-writes)
[157.748678] Starting subtest: read-writes
[168.802184] Subtest read-writes: SUCCESS (11.053s)
[169.007546] [030/131] (860s left) syncobj_timeline (host-signal-ordered)
[169.059417] Starting subtest: host-signal-ordered
[169.060979] Subtest host-signal-ordered: SUCCESS (0.001s)
[169.245054] [031/131] (860s left) prime_mmap_coherency (write)
[169.292770] Starting subtest: write
[174.703387] Subtest write: SUCCESS (5.406s)
[174.868620] [032/131] (854s left) kms_writeback (writeback-invalid-parameters)
[176.858141] Subtest writeback-invalid-parameters: SKIP (0.000s)
[176.929243] [033/131] (852s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[178.924327] Starting subtest: plane-upscale-20x20-with-pixel-format
[178.925799] Starting dynamic subtest: pipe-A
[181.149855] Dynamic subtest pipe-A: SUCCESS (2.236s)
[181.162671] Starting dynamic subtest: pipe-B
[183.374330] Dynamic subtest pipe-B: SUCCESS (2.224s)
[183.388039] Starting dynamic subtest: pipe-C
[183.664664] Dynamic subtest pipe-C: SUCCESS (0.290s)
[183.677494] Starting dynamic subtest: pipe-D
[183.955993] Dynamic subtest pipe-D: SUCCESS (0.290s)
[183.958207] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.042s)
[184.205344] [034/131] (845s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[186.195600] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[186.197218] Starting dynamic subtest: pipe-A-valid-mode
[187.435315] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.238s)
[187.436672] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.239s)
[187.677070] [035/131] (842s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[189.662272] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[189.663747] Starting dynamic subtest: pipe-A-HDMI-A-4
[189.676901] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[189.688989] Starting dynamic subtest: pipe-B-HDMI-A-4
[189.702470] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[189.714217] Starting dynamic subtest: pipe-C-HDMI-A-4
[189.727991] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[189.739841] Starting dynamic subtest: pipe-D-HDMI-A-4
[189.753506] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[189.755047] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.013s)
[189.953476] [036/131] (839s left) gem_lmem_evict (dontneed-evict-race)
[195.297780] Starting subtest: dontneed-evict-race
[197.390847] Subtest dontneed-evict-race: SUCCESS (2.091s)
[198.747855] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[198.749325] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[198.752043] [037/131] (831s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[204.707971] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[204.811428] [FACT kms_psr (fbc-psr-cursor-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[204.815709] [FACT kms_psr (fbc-psr-cursor-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[204.819759] [038/131] (825s left) i915_selftest (live)
[206.209835] Starting subtest: live
[206.211619] Starting dynamic subtest: sanitycheck
[207.704313] Dynamic subtest sanitycheck: SUCCESS (1.494s)
[207.716684] Starting dynamic subtest: uncore
[209.186586] Dynamic subtest uncore: SUCCESS (1.481s)
[209.197266] Starting dynamic subtest: workarounds
[212.671236] Dynamic subtest workarounds: SUCCESS (3.484s)
[212.683915] Starting dynamic subtest: gt_engines
[214.703301] Dynamic subtest gt_engines: SUCCESS (2.031s)
[214.713877] Starting dynamic subtest: gt_timelines
[274.870376] Dynamic subtest gt_timelines: SUCCESS (60.166s)
[274.880797] Starting dynamic subtest: gt_contexts
[276.382970] Dynamic subtest gt_contexts: SUCCESS (1.511s)
[276.393331] Starting dynamic subtest: gt_lrc
[282.468151] Dynamic subtest gt_lrc: SUCCESS (6.084s)
[282.478765] Starting dynamic subtest: gt_mocs
[284.901382] Dynamic subtest gt_mocs: SUCCESS (2.432s)
[284.911756] Starting dynamic subtest: gt_pm
[289.053577] Dynamic subtest gt_pm: SUCCESS (4.151s)
[289.064362] Starting dynamic subtest: gt_heartbeat
[290.557144] Dynamic subtest gt_heartbeat: SUCCESS (1.502s)
[290.568725] Starting dynamic subtest: gt_tlb
[304.184793] Dynamic subtest gt_tlb: SUCCESS (13.626s)
[304.200402] Starting dynamic subtest: requests
[315.093564] Dynamic subtest requests: SUCCESS (10.907s)
[315.105238] Starting dynamic subtest: migrate
[319.854542] Dynamic subtest migrate: SUCCESS (4.760s)
[319.865462] Starting dynamic subtest: active
[321.378424] Dynamic subtest active: SUCCESS (1.522s)
[321.388744] Starting dynamic subtest: objects
[323.751117] Dynamic subtest objects: SUCCESS (2.369s)
[323.761739] Starting dynamic subtest: mman
[327.393070] Dynamic subtest mman: SUCCESS (3.641s)
[327.403692] Starting dynamic subtest: dmabuf
[328.958440] Dynamic subtest dmabuf: SUCCESS (1.564s)
[328.969156] Starting dynamic subtest: vma
[330.477335] Dynamic subtest vma: SUCCESS (1.518s)
[330.488131] Starting dynamic subtest: coherency
[340.411362] Dynamic subtest coherency: SUCCESS (9.933s)
[340.421783] Starting dynamic subtest: gtt
[349.622767] Dynamic subtest gtt: SUCCESS (9.210s)
[349.633175] Starting dynamic subtest: gem
[351.247355] Dynamic subtest gem: SUCCESS (1.623s)
[351.259763] Starting dynamic subtest: evict
[362.938259] Dynamic subtest evict: SUCCESS (11.690s)
[362.948973] Starting dynamic subtest: hugepages
[380.285907] Dynamic subtest hugepages: SUCCESS (17.347s)
[380.296513] Starting dynamic subtest: gem_contexts
[408.534624] Dynamic subtest gem_contexts: SUCCESS (28.247s)
[408.547332] Starting dynamic subtest: client
[410.101323] Dynamic subtest client: SUCCESS (1.565s)
[410.111861] Starting dynamic subtest: gem_migrate
[412.934544] Dynamic subtest gem_migrate: SUCCESS (2.832s)
[412.945065] Starting dynamic subtest: reset
[414.480324] Dynamic subtest reset: SUCCESS (1.544s)
[414.491086] Starting dynamic subtest: memory_region
[417.592464] Dynamic subtest memory_region: SUCCESS (3.110s)
[417.603161] Starting dynamic subtest: hangcheck
[446.530247] Dynamic subtest hangcheck: SUCCESS (28.936s)
[446.542033] Starting dynamic subtest: execlists
[447.993365] Dynamic subtest execlists: SUCCESS (1.461s)
[448.004268] Starting dynamic subtest: ring_submission
[449.484947] Dynamic subtest ring_submission: SUCCESS (1.490s)
[449.495608] Starting dynamic subtest: perf
[451.106251] Dynamic subtest perf: SUCCESS (1.619s)
[451.116745] Starting dynamic subtest: slpc
[457.159406] Dynamic subtest slpc: SUCCESS (6.051s)
[457.170340] Starting dynamic subtest: guc
[460.723429] Dynamic subtest guc: SUCCESS (3.562s)
[460.734317] Starting dynamic subtest: guc_multi_lrc
[462.184994] Dynamic subtest guc_multi_lrc: SUCCESS (1.460s)
[462.195702] Starting dynamic subtest: guc_hang
[464.476127] Dynamic subtest guc_hang: SUCCESS (2.290s)
[464.490595] Starting dynamic subtest: late_gt_pm
[466.006250] Dynamic subtest late_gt_pm: SUCCESS (1.528s)
[466.007931] Subtest live: SUCCESS (259.800s)
[466.049681] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[466.050856] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[466.054225] [039/131] (564s left) kms_psr (psr2-cursor-blt)
[471.979644] Subtest psr2-cursor-blt: SKIP (0.000s)
[472.072579] [FACT kms_psr (psr2-cursor-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[472.076136] [FACT kms_psr (psr2-cursor-blt)] new: kernel.kmod_is_loaded.i915: true
[472.080239] [040/131] (558s left) api_intel_bb (purge-bb)
[472.133616] Starting subtest: purge-bb
[472.156411] Subtest purge-bb: SUCCESS (0.025s)
[472.391357] [041/131] (557s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[474.403619] Starting subtest: fbcpsr-slowdraw
[474.406848] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[474.656068] [042/131] (555s left) kms_frontbuffer_tracking (fbc-2p-rte)
[476.650768] Starting subtest: fbc-2p-rte
[476.653845] Subtest fbc-2p-rte: SKIP (0.000s)
[476.858110] [043/131] (553s left) gen9_exec_parse (bb-secure)
[476.916050] Subtest bb-secure: SKIP (0.000s)
[476.995254] [044/131] (553s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[478.978988] Starting subtest: basic-busy-flip-before-cursor-legacy
[478.981924] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[479.163405] [045/131] (551s left) i915_pm_rc6_residency (rc6-accuracy)
[479.212709] Starting subtest: rc6-accuracy
[479.214515] Starting dynamic subtest: gt0
[482.387085] Dynamic subtest gt0: SUCCESS (3.170s)
[482.388829] Subtest rc6-accuracy: SUCCESS (3.175s)
[482.534386] [046/131] (548s left) kms_invalid_mode (bad-vsync-end)
[484.522896] Starting subtest: bad-vsync-end
[484.524347] Starting dynamic subtest: pipe-A-HDMI-A-4
[484.571776] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.046s)
[484.583946] Starting dynamic subtest: pipe-B-HDMI-A-4
[484.585657] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[484.597320] Starting dynamic subtest: pipe-C-HDMI-A-4
[484.598789] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[484.611157] Starting dynamic subtest: pipe-D-HDMI-A-4
[484.612630] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[484.614126] Subtest bad-vsync-end: SUCCESS (0.059s)
[484.802717] [047/131] (546s left) kms_dsc (dsc-with-output-formats)
[486.791060] Starting subtest: dsc-with-output-formats
[486.806621] Subtest dsc-with-output-formats: SKIP (0.001s)
[486.987792] [048/131] (544s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[488.995164] Starting subtest: y-tiled-8bpp-rotate-0
[490.684859] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.686s)
[490.904219] [049/131] (540s left) kms_flip (flip-vs-dpms-on-nop)
[492.889089] Starting subtest: flip-vs-dpms-on-nop
[492.896626] Starting dynamic subtest: A-HDMI-A4
[493.908452] Dynamic subtest A-HDMI-A4: SUCCESS (1.012s)
[493.927307] Starting dynamic subtest: B-HDMI-A4
[494.870381] Dynamic subtest B-HDMI-A4: SUCCESS (0.960s)
[494.883318] Starting dynamic subtest: C-HDMI-A4
[495.837280] Dynamic subtest C-HDMI-A4: SUCCESS (0.965s)
[495.852231] Starting dynamic subtest: D-HDMI-A4
[496.803609] Dynamic subtest D-HDMI-A4: SUCCESS (0.964s)
[496.805139] Subtest flip-vs-dpms-on-nop: SUCCESS (3.916s)
[497.081734] [050/131] (534s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[499.068829] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[499.073008] Starting dynamic subtest: pipe-A-HDMI-A-4
[499.088364] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[499.100967] Starting dynamic subtest: pipe-B-HDMI-A-4
[499.116938] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[499.129109] Starting dynamic subtest: pipe-C-HDMI-A-4
[499.145484] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[499.158235] Starting dynamic subtest: pipe-D-HDMI-A-4
[499.175271] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[499.178641] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[499.324703] [051/131] (531s left) gem_madvise (dontneed-before-pwrite)
[499.368850] Starting subtest: dontneed-before-pwrite
[499.372939] Subtest dontneed-before-pwrite: SKIP (0.003s)
[499.475265] [052/131] (531s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[499.530591] Starting subtest: yf-tiled-to-vebox-x-tiled
[499.532004] Starting dynamic subtest: smem
[499.611234] Dynamic subtest smem: SUCCESS (0.082s)
[499.623649] Starting dynamic subtest: lmem0
[500.368708] Dynamic subtest lmem0: SUCCESS (0.753s)
[500.370435] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.838s)
[500.670591] [053/131] (530s left) gem_exec_schedule (implicit-read-write)
[500.728411] Starting subtest: implicit-read-write
[500.729934] Starting dynamic subtest: rcs0
[500.929085] Dynamic subtest rcs0: SUCCESS (0.197s)
[500.941865] Starting dynamic subtest: bcs0
[501.067528] Dynamic subtest bcs0: SUCCESS (0.140s)
[501.080141] Starting dynamic subtest: vcs0
[501.204833] Dynamic subtest vcs0: SUCCESS (0.136s)
[501.217720] Starting dynamic subtest: vcs1
[501.341634] Dynamic subtest vcs1: SUCCESS (0.136s)
[501.353592] Starting dynamic subtest: vecs0
[501.491500] Dynamic subtest vecs0: SUCCESS (0.148s)
[501.493041] Subtest implicit-read-write: SUCCESS (0.764s)
[501.962479] [054/131] (529s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[503.949710] Starting subtest: async-flip-with-page-flip-events-tiled
[504.169513] Starting dynamic subtest: pipe-A-HDMI-A-4-y-rc-ccs
[506.460515] Dynamic subtest pipe-A-HDMI-A-4-y-rc-ccs: SUCCESS (2.287s)
[506.480788] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[508.675334] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.207s)
[508.699208] Starting dynamic subtest: pipe-A-HDMI-A-4-y
[510.692560] Dynamic subtest pipe-A-HDMI-A-4-y: SUCCESS (2.010s)
[510.714649] Starting dynamic subtest: pipe-A-HDMI-A-4-x
[512.924121] Dynamic subtest pipe-A-HDMI-A-4-x: SUCCESS (2.225s)
[513.097624] Starting dynamic subtest: pipe-B-HDMI-A-4-y-rc-ccs
[515.329518] Dynamic subtest pipe-B-HDMI-A-4-y-rc-ccs: SUCCESS (2.239s)
[515.353039] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[517.528755] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.192s)
[517.541674] Starting dynamic subtest: pipe-B-HDMI-A-4-y
[519.545917] Dynamic subtest pipe-B-HDMI-A-4-y: SUCCESS (2.015s)
[519.563054] Starting dynamic subtest: pipe-B-HDMI-A-4-x
[521.744773] Dynamic subtest pipe-B-HDMI-A-4-x: SUCCESS (2.194s)
[521.928217] Starting dynamic subtest: pipe-C-HDMI-A-4-y-rc-ccs
[524.159947] Dynamic subtest pipe-C-HDMI-A-4-y-rc-ccs: SUCCESS (2.239s)
[524.198996] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[526.375314] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.208s)
[526.425382] Starting dynamic subtest: pipe-C-HDMI-A-4-y
[528.392393] Dynamic subtest pipe-C-HDMI-A-4-y: SUCCESS (2.010s)
[528.413032] Starting dynamic subtest: pipe-C-HDMI-A-4-x
[530.606801] Dynamic subtest pipe-C-HDMI-A-4-x: SUCCESS (2.208s)
[530.804989] Starting dynamic subtest: pipe-D-HDMI-A-4-y-rc-ccs
[533.049651] Dynamic subtest pipe-D-HDMI-A-4-y-rc-ccs: SUCCESS (2.251s)
[533.066978] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[535.256963] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.191s)
[535.273282] Starting dynamic subtest: pipe-D-HDMI-A-4-y
[537.263149] Dynamic subtest pipe-D-HDMI-A-4-y: SUCCESS (2.009s)
[537.285674] Starting dynamic subtest: pipe-D-HDMI-A-4-x
[539.478158] Dynamic subtest pipe-D-HDMI-A-4-x: SUCCESS (2.208s)
[539.479964] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (35.529s)
[539.931340] [055/131] (491s left) sysfs_heartbeat_interval (mixed)
[539.986172] Starting subtest: mixed
[539.988127] Starting dynamic subtest: vecs0
[545.291052] Dynamic subtest vecs0: SUCCESS (5.304s)
[545.306631] Starting dynamic subtest: vcs0
[550.603949] Dynamic subtest vcs0: SUCCESS (5.311s)
[550.616771] Starting dynamic subtest: bcs0
[555.707525] Dynamic subtest bcs0: SUCCESS (5.101s)
[555.753323] Starting dynamic subtest: rcs0
[561.042352] Dynamic subtest rcs0: SUCCESS (5.327s)
[561.057931] Starting dynamic subtest: vcs1
[566.114369] Dynamic subtest vcs1: SUCCESS (5.069s)
[566.116228] Subtest mixed: SUCCESS (26.129s)
[566.337873] [056/131] (465s left) gem_ctx_persistence (heartbeat-close)
[566.410727] Starting subtest: heartbeat-close
[566.413556] Subtest heartbeat-close: SKIP (0.000s)
[566.616683] [057/131] (465s left) kms_psr (fbc-psr-sprite-blt)
[568.606288] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[568.692125] [058/131] (463s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[568.739537] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[568.741460] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[568.917464] [059/131] (463s left) kms_setmode (basic)
[568.963788] Starting subtest: basic
[569.051930] Starting dynamic subtest: pipe-A-HDMI-A-4
[571.167477] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.110s)
[571.253121] Starting dynamic subtest: pipe-B-HDMI-A-4
[573.354550] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.107s)
[573.389851] Subtest basic: SUCCESS (4.424s)
[573.598398] [060/131] (458s left) gem_eio (wait-10ms)
[573.789754] Starting subtest: wait-10ms
[574.218228] Subtest wait-10ms: SUCCESS (0.430s)
[576.380941] [061/131] (455s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[578.366950] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[581.132648] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.767s)
[581.426930] [062/131] (450s left) sw_sync (sync_merge)
[581.469991] Starting subtest: sync_merge
[581.471498] Subtest sync_merge: SUCCESS (0.000s)
[581.625423] [063/131] (450s left) syncobj_basic (bad-create-flags)
[581.672390] Starting subtest: bad-create-flags
[581.673944] Subtest bad-create-flags: SUCCESS (0.000s)
[581.876145] [064/131] (450s left) kms_addfb_basic (unused-handle)
[581.920962] Starting subtest: unused-handle
[581.922582] Subtest unused-handle: SUCCESS (0.000s)
[584.119315] [065/131] (448s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[586.113759] Starting subtest: psr-rgb565-draw-pwrite
[586.116426] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[586.374374] [066/131] (446s left) kms_async_flips (test-cursor)
[588.362597] Starting subtest: test-cursor
[588.581118] Starting dynamic subtest: pipe-A-HDMI-A-4
[588.933128] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.352s)
[589.111276] Starting dynamic subtest: pipe-B-HDMI-A-4
[589.162969] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.063s)
[589.356280] Starting dynamic subtest: pipe-C-HDMI-A-4
[589.418637] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.074s)
[589.604059] Starting dynamic subtest: pipe-D-HDMI-A-4
[589.666524] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.074s)
[589.668090] Subtest test-cursor: SUCCESS (1.307s)
[590.094292] [067/131] (442s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[592.081472] Starting subtest: disable-crc-after-crtc
[592.083076] Starting dynamic subtest: pipe-A-HDMI-A-4
[592.692432] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.611s)
[592.708703] Starting dynamic subtest: pipe-B-HDMI-A-4
[593.149691] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.454s)
[593.168160] Starting dynamic subtest: pipe-C-HDMI-A-4
[593.610197] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.456s)
[593.628465] Starting dynamic subtest: pipe-D-HDMI-A-4
[594.061453] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.446s)
[594.073443] Subtest disable-crc-after-crtc: SUCCESS (1.981s)
[594.289109] [068/131] (438s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[594.338628] Starting subtest: invalid-single-wait-all-unsubmitted
[594.340399] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[594.499105] [069/131] (438s left) core_getstats (basic)
[594.545922] Starting subtest: basic
[594.547756] Subtest basic: SUCCESS (0.000s)
[594.704153] [070/131] (438s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[596.690894] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[596.692421] Starting dynamic subtest: pipe-A
[597.451305] Dynamic subtest pipe-A: SUCCESS (0.762s)
[597.471147] Starting dynamic subtest: pipe-B
[598.207796] Dynamic subtest pipe-B: SUCCESS (0.755s)
[598.230058] Starting dynamic subtest: pipe-C
[598.966212] Dynamic subtest pipe-C: SUCCESS (0.756s)
[598.984369] Starting dynamic subtest: pipe-D
[599.723112] Dynamic subtest pipe-D: SUCCESS (0.755s)
[599.724917] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (3.035s)
[599.997381] [071/131] (433s left) kms_getfb (getfb-repeated-different-handles)
[601.987529] Starting subtest: getfb-repeated-different-handles
[601.989167] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[602.258777] [072/131] (431s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[604.246417] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[604.249501] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[604.479569] [073/131] (429s left) syncobj_timeline (single-wait-signaled)
[604.525745] Starting subtest: single-wait-signaled
[604.527426] Subtest single-wait-signaled: SUCCESS (0.000s)
[604.727540] [074/131] (428s left) gem_exec_whisper (basic-fds)
[604.786482] Starting subtest: basic-fds
[609.004569] Subtest basic-fds: SUCCESS (4.214s)
[609.321335] [075/131] (424s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[611.327740] Starting subtest: yf-tiled-64bpp-rotate-180
[611.341034] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[611.572729] [076/131] (422s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[613.569167] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[613.640229] [077/131] (420s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[615.649085] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[615.652564] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[615.873848] [078/131] (418s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[615.926056] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[616.068856] [079/131] (418s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[618.076449] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[618.643439] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.567s)
[618.971921] [080/131] (415s left) syncobj_wait (wait-for-submit-delayed-submit)
[619.020928] Starting subtest: wait-for-submit-delayed-submit
[619.127415] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[619.266402] [081/131] (415s left) gem_mmap_gtt (medium-copy)
[619.315022] Subtest medium-copy: SKIP (0.000s)
[619.390721] [082/131] (415s left) kms_pm_dc (dc9-dpms)
[622.383256] Starting subtest: dc9-dpms
[622.718235] Subtest dc9-dpms: SUCCESS (0.335s)
[623.801960] [083/131] (410s left) gem_ppgtt (blt-vs-render-ctx0)
[623.855170] Starting subtest: blt-vs-render-ctx0
[656.888119] Subtest blt-vs-render-ctx0: SUCCESS (33.029s)
[657.131444] [084/131] (377s left) kms_cursor_crc (cursor-suspend)
[659.258590] Starting subtest: cursor-suspend
[659.272433] Starting dynamic subtest: pipe-A-HDMI-A-4
[701.251963] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (19.731s)
[701.269022] Starting dynamic subtest: pipe-D-HDMI-A-4
[744.242644] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (19.259s)
[744.244600] Subtest cursor-suspend: SUCCESS (38.996s)
[750.877647] [085/131] (289s left) kms_chamelium_frames (dp-crc-fast)
[753.590228] Subtest dp-crc-fast: SKIP (0.000s)
[753.708503] [086/131] (287s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[755.699127] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[755.716738] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.018s)
[755.940738] [087/131] (285s left) kms_cursor_crc (cursor-onscreen-64x64)
[758.081184] Starting subtest: cursor-onscreen-64x64
[758.088730] Starting dynamic subtest: pipe-A-HDMI-A-4
[760.860442] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.772s)
[760.897306] Starting dynamic subtest: pipe-D-HDMI-A-4
[763.470209] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.584s)
[763.472039] Subtest cursor-onscreen-64x64: SUCCESS (5.388s)
[764.021369] [088/131] (277s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[766.017997] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[766.088806] [089/131] (275s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[768.084881] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[768.088376] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[768.359820] [090/131] (272s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[770.349333] Starting subtest: extended-pageflip-modeset-hang-oldfb
[770.353643] Starting dynamic subtest: pipe-A
[778.093560] Dynamic subtest pipe-A: SUCCESS (7.741s)
[778.111464] Starting dynamic subtest: pipe-D
[785.809965] Dynamic subtest pipe-D: SUCCESS (7.712s)
[785.811502] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.462s)
[786.105849] [091/131] (255s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[788.099952] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[788.102916] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[788.365786] [092/131] (253s left) gem_flink_race (flink_close)
[788.411289] Starting subtest: flink_close
[793.444213] Subtest flink_close: SUCCESS (5.033s)
[793.648011] [093/131] (248s left) gem_exec_balancer (parallel-keep-submit-fence)
[794.055117] Starting subtest: parallel-keep-submit-fence
[796.278543] Subtest parallel-keep-submit-fence: SUCCESS (2.223s)
[796.413497] [094/131] (245s left) gem_lmem_swapping (verify-ccs)
[801.984682] Starting subtest: verify-ccs
[801.986791] Starting dynamic subtest: lmem0
[801.990074] Dynamic subtest lmem0: SKIP (0.002s)
[801.993284] Subtest verify-ccs: SKIP (0.003s)
[803.197595] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[803.199139] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[803.204056] [095/131] (238s left) kms_content_protection (lic-type-1)
[809.222540] Starting subtest: lic-type-1
[809.233566] Subtest lic-type-1: SKIP (0.005s)
[809.346071] [FACT kms_content_protection (lic-type-1)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[809.349243] [FACT kms_content_protection (lic-type-1)] new: kernel.kmod_is_loaded.i915: true
[809.353452] [096/131] (232s left) gem_flink_basic (basic)
[809.404212] Starting subtest: basic
[809.405746] Subtest basic: SUCCESS (0.000s)
[809.612802] [097/131] (232s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[812.501367] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[812.504150] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[812.677732] [098/131] (229s left) gem_create (create-ext-cpu-access-sanity-check)
[812.835081] Starting subtest: create-ext-cpu-access-sanity-check
[812.841311] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.008s)
[813.011499] [099/131] (229s left) gem_exec_fence (syncobj-channel)
[813.351461] Starting subtest: syncobj-channel
[814.377070] Subtest syncobj-channel: SUCCESS (1.025s)
[814.881642] [100/131] (227s left) api_intel_allocator (open-vm)
[814.928761] Starting subtest: open-vm
[814.946011] Subtest open-vm: SUCCESS (0.019s)
[815.186765] [101/131] (227s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[817.177473] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[817.180604] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[817.430186] [102/131] (225s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[819.419979] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[819.422921] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[819.683501] [103/131] (223s left) dumb_buffer (map-valid)
[819.731579] Starting subtest: map-valid
[819.733364] Subtest map-valid: SUCCESS (0.000s)
[819.927160] [104/131] (222s left) kms_cursor_crc (cursor-onscreen-32x10)
[822.020433] Starting subtest: cursor-onscreen-32x10
[822.074116] Subtest cursor-onscreen-32x10: SKIP (0.049s)
[822.567479] [105/131] (220s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[822.616067] Starting subtest: etime-multi-wait-all-submitted-signaled
[822.726550] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[822.919894] [106/131] (220s left) kms_vblank (wait-forked)
[824.905665] Starting subtest: wait-forked
[824.910157] Starting dynamic subtest: pipe-A-HDMI-A-4
[827.333118] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.424s)
[827.349136] Starting dynamic subtest: pipe-D-HDMI-A-4
[829.572614] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.236s)
[829.574136] Subtest wait-forked: SUCCESS (4.668s)
[829.811174] [107/131] (213s left) kms_scaling_modes (scaling-mode-full)
[831.793494] Starting subtest: scaling-mode-full
[831.801654] Subtest scaling-mode-full: SKIP (0.002s)
[831.992158] [108/131] (211s left) gem_wait (await)
[832.053485] Starting subtest: await
[832.055077] Starting dynamic subtest: all-engines
[833.151958] Dynamic subtest all-engines: SUCCESS (1.097s)
[833.172440] Starting dynamic subtest: rcs0
[834.215700] Dynamic subtest rcs0: SUCCESS (1.061s)
[834.234168] Starting dynamic subtest: bcs0
[835.276829] Dynamic subtest bcs0: SUCCESS (1.058s)
[835.301309] Starting dynamic subtest: vcs0
[836.344958] Dynamic subtest vcs0: SUCCESS (1.061s)
[836.370451] Starting dynamic subtest: vcs1
[837.414960] Dynamic subtest vcs1: SUCCESS (1.062s)
[837.464261] Starting dynamic subtest: vecs0
[838.490871] Dynamic subtest vecs0: SUCCESS (1.068s)
[838.500195] Subtest await: SUCCESS (6.440s)
[838.851878] [109/131] (204s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[840.883488] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[840.997702] [110/131] (202s left) i915_pm_freq_api (freq-reset-multiple)
[841.053668] Starting subtest: freq-reset-multiple
[841.055523] Starting dynamic subtest: gt0
[852.921911] Dynamic subtest gt0: SUCCESS (11.858s)
[852.923493] Subtest freq-reset-multiple: SUCCESS (11.860s)
[853.050462] [111/131] (190s left) kms_addfb_basic (invalid-set-prop)
[853.097617] Starting subtest: invalid-set-prop
[853.099114] Subtest invalid-set-prop: SUCCESS (0.000s)
[855.298062] [112/131] (188s left) gem_ctx_isolation (clean)
[855.355857] Starting subtest: clean
[855.357255] Starting dynamic subtest: rcs0
[855.465290] Dynamic subtest rcs0: SUCCESS (0.111s)
[855.479453] Starting dynamic subtest: bcs0
[855.617505] Dynamic subtest bcs0: SUCCESS (0.151s)
[855.631908] Starting dynamic subtest: vcs0
[855.746268] Dynamic subtest vcs0: SUCCESS (0.127s)
[855.760484] Starting dynamic subtest: vcs1
[855.872767] Dynamic subtest vcs1: SUCCESS (0.125s)
[855.886808] Starting dynamic subtest: vecs0
[856.003615] Dynamic subtest vecs0: SUCCESS (0.129s)
[856.005240] Subtest clean: SUCCESS (0.650s)
[856.301471] [113/131] (187s left) gem_spin_batch (legacy-resubmit-new)
[856.358804] Starting subtest: legacy-resubmit-new
[856.360347] Starting dynamic subtest: default
[856.380087] Dynamic subtest default: SUCCESS (0.020s)
[856.395111] Starting dynamic subtest: render
[856.396605] Dynamic subtest render: SUCCESS (0.004s)
[856.410909] Starting dynamic subtest: bsd
[856.412418] Dynamic subtest bsd: SUCCESS (0.004s)
[856.426787] Starting dynamic subtest: bsd1
[856.428439] Dynamic subtest bsd1: SUCCESS (0.005s)
[856.442428] Starting dynamic subtest: bsd2
[856.444200] Dynamic subtest bsd2: SUCCESS (0.004s)
[856.457898] Starting dynamic subtest: blt
[856.459639] Dynamic subtest blt: SUCCESS (0.005s)
[856.473355] Starting dynamic subtest: vebox
[856.475103] Dynamic subtest vebox: SUCCESS (0.004s)
[856.476713] Subtest legacy-resubmit-new: SUCCESS (0.058s)
[856.788401] [114/131] (187s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[858.780548] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[858.783678] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[859.020194] [115/131] (184s left) prime_mmap (test_invalid_sync_flags)
[859.067237] Starting subtest: test_invalid_sync_flags
[859.068783] Starting dynamic subtest: test_invalid_sync_flags-smem
[859.070420] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[859.084906] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[859.086723] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[859.088469] Subtest test_invalid_sync_flags: SUCCESS (0.003s)
[859.259468] [116/131] (184s left) kms_chamelium_audio (dp-audio)
[861.288381] Subtest dp-audio: SKIP (0.000s)
[861.403297] [117/131] (182s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[863.398659] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[863.401735] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[863.650605] [118/131] (180s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[865.641215] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[865.644088] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[865.911233] [119/131] (178s left) kms_psr (fbc-pr-primary-render)
[867.897188] Subtest fbc-pr-primary-render: SKIP (0.000s)
[867.980495] [120/131] (176s left) kms_psr (psr-primary-render)
[869.966542] Subtest psr-primary-render: SKIP (0.000s)
[870.047459] [121/131] (174s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[872.033630] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[872.038327] Starting dynamic subtest: pipe-A-HDMI-A-4
[872.044909] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[872.059256] Starting dynamic subtest: pipe-B-HDMI-A-4
[872.066075] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[872.079869] Starting dynamic subtest: pipe-C-HDMI-A-4
[872.086623] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[872.100754] Starting dynamic subtest: pipe-D-HDMI-A-4
[872.107550] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[872.111007] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.011s)
[872.327871] [122/131] (172s left) kms_properties (get_properties-sanity-atomic)
[874.312209] Starting subtest: get_properties-sanity-atomic
[874.318620] Subtest get_properties-sanity-atomic: SUCCESS (0.006s)
[874.526878] [123/131] (170s left) kms_lease (lease-unleased-connector)
[876.513818] Starting subtest: lease-unleased-connector
[876.515495] Starting dynamic subtest: pipe-A-HDMI-A-4
[876.571628] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.055s)
[876.586091] Starting dynamic subtest: pipe-B-HDMI-A-4
[876.628548] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.055s)
[876.642759] Starting dynamic subtest: pipe-C-HDMI-A-4
[876.685560] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.054s)
[876.702633] Starting dynamic subtest: pipe-D-HDMI-A-4
[876.742020] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.055s)
[876.743473] Subtest lease-unleased-connector: SUCCESS (0.230s)
[876.933849] [124/131] (168s left) gem_ctx_sseu (invalid-args)
[876.987773] Subtest invalid-args: SKIP (0.000s)
[877.084443] [125/131] (167s left) tools_test (sysfs_l3_parity)
[877.142612] Starting subtest: sysfs_l3_parity
[877.216017] Subtest sysfs_l3_parity: SKIP (0.086s)
[877.362901] [126/131] (167s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[879.353957] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[879.356866] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[879.622897] [127/131] (165s left) prime_self_import (basic-llseek-size)
[879.667353] Starting subtest: basic-llseek-size
[879.670386] Subtest basic-llseek-size: SUCCESS (0.004s)
[879.888182] [128/131] (165s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[881.879790] Starting subtest: fbc-rgb101010-draw-render
[884.862801] Subtest fbc-rgb101010-draw-render: SUCCESS (2.983s)
[885.069686] [129/131] (160s left) gem_exec_balancer (invalid-bonds)
[885.127107] Starting subtest: invalid-bonds
[885.130444] Subtest invalid-bonds: SKIP (0.000s)
[885.574233] [130/131] (159s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[887.562424] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[887.565250] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[887.819432] [131/131] (157s left) syncobj_wait (invalid-reset-illegal-handle)
[887.866100] Starting subtest: invalid-reset-illegal-handle
[887.867706] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[888.069389] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_getfb
results: parsing output: 5/ for test: kms_dither
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_mmap_wc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_sequence
results: parsing output: 27/ for test: gem_mmap_wc
results: parsing output: 28/ for test: gem_caching
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: prime_mmap_coherency
results: parsing output: 31/ for test: kms_writeback
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_lmem_evict
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: i915_selftest
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: i915_pm_rc6_residency
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_dsc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_madvise
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: sysfs_heartbeat_interval
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_setmode
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: sw_sync
results: parsing output: 62/ for test: syncobj_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_async_flips
results: parsing output: 66/ for test: kms_pipe_crc_basic
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: core_getstats
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_pm_dc
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_chamelium_frames
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_busy
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_flink_race
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: gem_flink_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_create
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: dumb_buffer
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_scaling_modes
results: parsing output: 107/ for test: gem_wait
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: i915_pm_freq_api
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: gem_ctx_isolation
results: parsing output: 112/ for test: gem_spin_batch
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: prime_mmap
results: parsing output: 115/ for test: kms_chamelium_audio
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_properties
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: gem_ctx_sseu
results: parsing output: 124/ for test: tools_test
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: prime_self_import
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_wait
Done.