[67.354437] Initializing watchdogs
[67.354519]   /dev/watchdog0
[67.385372] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.400291] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.405290] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.408891] [001/133] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[68.921481] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[69.540819] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.623s)
[69.721251] [002/133] (958s left) kms_psr (fbc-psr-primary-mmap-gtt)
[71.210173] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[71.374208] [003/133] (956s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[72.976631] Starting subtest: plane-lut1d-ctm3x4
[73.180279] Starting dynamic subtest: pipe-A-plane-0
[73.445235] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s)
[73.460340] Starting dynamic subtest: pipe-A-plane-1
[73.612912] Dynamic subtest pipe-A-plane-1: SUCCESS (0.167s)
[73.644139] Starting dynamic subtest: pipe-A-plane-2
[73.829115] Dynamic subtest pipe-A-plane-2: SUCCESS (0.215s)
[74.108121] Starting dynamic subtest: pipe-B-plane-0
[74.278212] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[74.308270] Starting dynamic subtest: pipe-B-plane-1
[74.494473] Dynamic subtest pipe-B-plane-1: SUCCESS (0.215s)
[74.517520] Starting dynamic subtest: pipe-B-plane-2
[74.679757] Dynamic subtest pipe-B-plane-2: SUCCESS (0.182s)
[74.973191] Starting dynamic subtest: pipe-C-plane-0
[75.146337] Dynamic subtest pipe-C-plane-0: SUCCESS (0.184s)
[75.179324] Starting dynamic subtest: pipe-C-plane-1
[75.362689] Dynamic subtest pipe-C-plane-1: SUCCESS (0.215s)
[75.388941] Starting dynamic subtest: pipe-C-plane-2
[75.579240] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[75.863420] Starting dynamic subtest: pipe-D-plane-0
[76.040980] Dynamic subtest pipe-D-plane-0: SUCCESS (0.184s)
[76.054590] Starting dynamic subtest: pipe-D-plane-1
[76.240525] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s)
[76.270273] Starting dynamic subtest: pipe-D-plane-2
[76.456617] Dynamic subtest pipe-D-plane-2: SUCCESS (0.215s)
[76.513114] Subtest plane-lut1d-ctm3x4: SUCCESS (3.545s)
[76.681964] [004/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[78.176907] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[78.179813] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[78.323198] [005/133] (949s left) prime_vgem (wait)
[78.473188] Starting subtest: wait
[78.474911] Starting dynamic subtest: rcs0
[78.519743] Dynamic subtest rcs0: SUCCESS (0.046s)
[78.529191] Starting dynamic subtest: bcs0
[78.559708] Dynamic subtest bcs0: SUCCESS (0.040s)
[78.570559] Starting dynamic subtest: vcs0
[78.602432] Dynamic subtest vcs0: SUCCESS (0.042s)
[78.622783] Starting dynamic subtest: vcs1
[78.646808] Dynamic subtest vcs1: SUCCESS (0.044s)
[78.667139] Starting dynamic subtest: vecs0
[78.691180] Dynamic subtest vecs0: SUCCESS (0.044s)
[78.693248] Subtest wait: SUCCESS (0.218s)
[78.933626] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[78.936353] [006/133] (949s left) gem_exec_fence (syncobj-timeline-unused-fence)
[79.502163] Starting subtest: syncobj-timeline-unused-fence
[79.531976] Subtest syncobj-timeline-unused-fence: SUCCESS (0.036s)
[79.803490] [007/133] (948s left) gem_pxp (create-valid-protected-context)
[82.366558] Starting subtest: create-valid-protected-context
[82.370232] Subtest create-valid-protected-context: SKIP (0.000s)
[82.485050] [008/133] (946s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[83.991602] Starting subtest: y-tiled-addfb-size-offset-overflow
[83.993204] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[84.168712] [009/133] (944s left) prime_self_import (basic-with_one_bo_two_files)
[84.216148] Starting subtest: basic-with_one_bo_two_files
[84.219707] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[84.383033] [010/133] (944s left) gem_create (busy-create)
[84.435774] Starting subtest: busy-create
[84.437033] Starting dynamic subtest: lmem0
[116.697844] Dynamic subtest lmem0: SUCCESS (32.260s)
[116.706840] Starting dynamic subtest: smem0
[148.968772] Dynamic subtest smem0: SUCCESS (32.270s)
[148.970198] Subtest busy-create: SUCCESS (64.530s)
[149.238696] [011/133] (879s left) gem_ctx_param (set-priority-invalid-size)
[149.285496] Starting subtest: set-priority-invalid-size
[149.286964] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[149.403698] [012/133] (879s left) kms_psr (psr-primary-render)
[150.892527] Subtest psr-primary-render: SKIP (0.000s)
[150.961125] [013/133] (877s left) syncobj_basic (create-signaled)
[151.008622] Starting subtest: create-signaled
[151.010126] Subtest create-signaled: SUCCESS (0.000s)
[151.123931] [014/133] (877s left) gem_exec_schedule (u-semaphore-codependency)
[151.187156] Starting subtest: u-semaphore-codependency
[151.217651] Subtest u-semaphore-codependency: SUCCESS (0.030s)
[151.679874] [015/133] (877s left) fbdev (write)
[151.735491] Starting subtest: write
[152.459354] Subtest write: SUCCESS (0.721s)
[152.548141] [016/133] (876s left) syncobj_wait (single-wait-all-submitted)
[152.594288] Starting subtest: single-wait-all-submitted
[152.695203] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[152.818687] [017/133] (876s left) gem_ctx_param (get-priority-new-ctx)
[152.865415] Starting subtest: get-priority-new-ctx
[152.866720] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[153.038487] [018/133] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[154.533566] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[154.537053] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[154.673071] [019/133] (874s left) i915_pm_freq_api (freq-basic-api)
[154.743347] Starting subtest: freq-basic-api
[154.745045] Starting dynamic subtest: gt0
[154.758580] Dynamic subtest gt0: SUCCESS (0.004s)
[154.762561] Subtest freq-basic-api: SUCCESS (0.005s)
[154.873483] [020/133] (874s left) gem_ctx_isolation (clean)
[154.929529] Starting subtest: clean
[154.930930] Starting dynamic subtest: rcs0
[155.035616] Dynamic subtest rcs0: SUCCESS (0.105s)
[155.045439] Starting dynamic subtest: bcs0
[155.161163] Dynamic subtest bcs0: SUCCESS (0.126s)
[155.170428] Starting dynamic subtest: vcs0
[155.287235] Dynamic subtest vcs0: SUCCESS (0.125s)
[155.296626] Starting dynamic subtest: vcs1
[155.412137] Dynamic subtest vcs1: SUCCESS (0.125s)
[155.421566] Starting dynamic subtest: vecs0
[155.542148] Dynamic subtest vecs0: SUCCESS (0.130s)
[155.543661] Subtest clean: SUCCESS (0.613s)
[155.856054] [021/133] (873s left) kms_vblank (ts-continuation-idle-hang)
[157.364080] Starting subtest: ts-continuation-idle-hang
[157.367895] Starting dynamic subtest: pipe-A-HDMI-A-4
[183.457728] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.093s)
[183.469932] Starting dynamic subtest: pipe-D-HDMI-A-4
[208.468743] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.006s)
[208.470292] Subtest ts-continuation-idle-hang: SUCCESS (51.106s)
[208.645427] [022/133] (820s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[210.151373] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[210.154802] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[210.316223] [023/133] (819s left) kms_properties (get_properties-sanity-atomic)
[211.802801] Starting subtest: get_properties-sanity-atomic
[211.808981] Subtest get_properties-sanity-atomic: SUCCESS (0.006s)
[211.916767] [024/133] (817s left) kms_cursor_crc (cursor-offscreen-max-size)
[213.721876] Starting subtest: cursor-offscreen-max-size
[213.726043] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[213.923817] [025/133] (815s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[213.971384] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[213.972870] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[214.092118] [026/133] (815s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[214.146110] Starting subtest: mixed-tiled-to-y-tiled-ccs
[214.147632] Starting dynamic subtest: smem
[214.254235] Dynamic subtest smem: SUCCESS (0.106s)
[214.263611] Starting dynamic subtest: lmem0
[215.206226] Dynamic subtest lmem0: SUCCESS (0.951s)
[215.207924] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.058s)
[215.482960] [027/133] (814s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[217.022777] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[217.137278] [028/133] (813s left) gem_mmap_gtt (big-bo)
[217.185709] Subtest big-bo: SKIP (0.000s)
[217.266818] [029/133] (812s left) gem_partial_pwrite_pread (reads-snoop)
[217.318847] Subtest reads-snoop: SKIP (0.000s)
[217.418774] [030/133] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[218.913401] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[218.916817] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[219.094672] [031/133] (811s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[219.168900] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[219.170334] Starting dynamic subtest: smem
[219.265998] Dynamic subtest smem: SUCCESS (0.099s)
[219.275316] Starting dynamic subtest: lmem0
[220.385890] Dynamic subtest lmem0: SUCCESS (1.116s)
[220.387697] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.216s)
[220.696741] [032/133] (809s left) kms_plane (plane-panning-top-left)
[222.201972] Starting subtest: plane-panning-top-left
[222.203264] Starting dynamic subtest: pipe-A
[222.921962] Dynamic subtest pipe-A: SUCCESS (0.718s)
[222.931591] Starting dynamic subtest: pipe-B
[223.454900] Dynamic subtest pipe-B: SUCCESS (0.531s)
[223.456474] Subtest plane-panning-top-left: SUCCESS (1.252s)
[223.654931] [033/133] (806s left) perf_pmu (most-busy-check-all)
[223.728099] Starting subtest: most-busy-check-all
[223.729972] Starting dynamic subtest: rcs0
[224.296128] Dynamic subtest rcs0: SUCCESS (0.568s)
[224.309893] Starting dynamic subtest: bcs0
[224.846452] Dynamic subtest bcs0: SUCCESS (0.550s)
[224.858187] Starting dynamic subtest: vcs0
[225.394550] Dynamic subtest vcs0: SUCCESS (0.548s)
[225.406243] Starting dynamic subtest: vcs1
[225.942017] Dynamic subtest vcs1: SUCCESS (0.547s)
[225.953877] Starting dynamic subtest: vecs0
[226.489288] Dynamic subtest vecs0: SUCCESS (0.547s)
[226.490590] Subtest most-busy-check-all: SUCCESS (2.762s)
[226.634157] [034/133] (804s left) kms_psr (fbc-pr-primary-page-flip)
[228.123357] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[228.200267] [035/133] (802s left) tools_test (sysfs_l3_parity)
[228.265971] Starting subtest: sysfs_l3_parity
[228.325033] Subtest sysfs_l3_parity: SKIP (0.077s)
[228.437073] [036/133] (802s left) gem_render_copy_redux (normal)
[228.489851] Starting subtest: normal
[229.329285] Subtest normal: SUCCESS (0.839s)
[229.492456] [037/133] (801s left) kms_cdclk (mode-transition-all-outputs)
[229.540877] Subtest mode-transition-all-outputs: SKIP (0.000s)
[229.615149] [038/133] (801s left) kms_content_protection (content-type-change)
[231.161931] Starting subtest: content-type-change
[231.167220] Subtest content-type-change: SKIP (0.002s)
[231.363698] [039/133] (799s left) gem_userptr_blits (userfault)
[231.429920] Starting subtest: userfault
[231.431388] Subtest userfault: SUCCESS (0.005s)
[231.637633] [040/133] (799s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[233.122707] Starting subtest: basic-busy-flip-before-cursor-varying-size
[233.125264] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[233.254447] [041/133] (798s left) i915_selftest (live)
[234.289443] Starting subtest: live
[234.290992] Starting dynamic subtest: sanitycheck
[235.685455] Dynamic subtest sanitycheck: SUCCESS (1.396s)
[235.694727] Starting dynamic subtest: uncore
[237.105357] Dynamic subtest uncore: SUCCESS (1.419s)
[237.115080] Starting dynamic subtest: workarounds
[240.434436] Dynamic subtest workarounds: SUCCESS (3.329s)
[240.443816] Starting dynamic subtest: gt_engines
[242.367387] Dynamic subtest gt_engines: SUCCESS (1.933s)
[242.376236] Starting dynamic subtest: gt_timelines
[308.661560] Dynamic subtest gt_timelines: SUCCESS (66.295s)
[308.670624] Starting dynamic subtest: gt_contexts
[310.095346] Dynamic subtest gt_contexts: SUCCESS (1.436s)
[310.104424] Starting dynamic subtest: gt_lrc
[316.150748] Dynamic subtest gt_lrc: SUCCESS (6.052s)
[316.160027] Starting dynamic subtest: gt_mocs
[318.443032] Dynamic subtest gt_mocs: SUCCESS (2.291s)
[318.452435] Starting dynamic subtest: gt_pm
[322.467589] Dynamic subtest gt_pm: SUCCESS (4.024s)
[322.477211] Starting dynamic subtest: gt_heartbeat
[323.884112] Dynamic subtest gt_heartbeat: SUCCESS (1.416s)
[323.893490] Starting dynamic subtest: gt_tlb
[337.718656] Dynamic subtest gt_tlb: SUCCESS (13.834s)
[337.728036] Starting dynamic subtest: requests
[348.801992] Dynamic subtest requests: SUCCESS (11.083s)
[348.811188] Starting dynamic subtest: migrate
[353.415291] Dynamic subtest migrate: SUCCESS (4.616s)
[353.424392] Starting dynamic subtest: active
[354.828452] Dynamic subtest active: SUCCESS (1.409s)
[354.838225] Starting dynamic subtest: objects
[357.146654] Dynamic subtest objects: SUCCESS (2.317s)
[357.155861] Starting dynamic subtest: mman
[360.635500] Dynamic subtest mman: SUCCESS (3.488s)
[360.644715] Starting dynamic subtest: dmabuf
[362.099555] Dynamic subtest dmabuf: SUCCESS (1.463s)
[362.108687] Starting dynamic subtest: vma
[363.498332] Dynamic subtest vma: SUCCESS (1.398s)
[363.507881] Starting dynamic subtest: coherency
[373.518645] Dynamic subtest coherency: SUCCESS (10.019s)
[373.528140] Starting dynamic subtest: gtt
[382.523012] Dynamic subtest gtt: SUCCESS (9.003s)
[382.532777] Starting dynamic subtest: gem
[384.073771] Dynamic subtest gem: SUCCESS (1.550s)
[384.083618] Starting dynamic subtest: evict
[395.515910] Dynamic subtest evict: SUCCESS (11.441s)
[395.525185] Starting dynamic subtest: hugepages
[412.690175] Dynamic subtest hugepages: SUCCESS (17.173s)
[412.699133] Starting dynamic subtest: gem_contexts
[440.647541] Dynamic subtest gem_contexts: SUCCESS (27.956s)
[440.656853] Starting dynamic subtest: client
[442.113547] Dynamic subtest client: SUCCESS (1.465s)
[442.123101] Starting dynamic subtest: gem_migrate
[444.711690] Dynamic subtest gem_migrate: SUCCESS (2.597s)
[444.720902] Starting dynamic subtest: reset
[446.156334] Dynamic subtest reset: SUCCESS (1.444s)
[446.165331] Starting dynamic subtest: memory_region
[449.185688] Dynamic subtest memory_region: SUCCESS (3.028s)
[449.195102] Starting dynamic subtest: hangcheck
[476.437780] Dynamic subtest hangcheck: SUCCESS (27.251s)
[476.447627] Starting dynamic subtest: execlists
[477.866269] Dynamic subtest execlists: SUCCESS (1.428s)
[477.875371] Starting dynamic subtest: ring_submission
[479.261628] Dynamic subtest ring_submission: SUCCESS (1.394s)
[479.271442] Starting dynamic subtest: perf
[480.802663] Dynamic subtest perf: SUCCESS (1.540s)
[480.812510] Starting dynamic subtest: slpc
[486.714568] Dynamic subtest slpc: SUCCESS (5.911s)
[486.724376] Starting dynamic subtest: guc
[490.204582] Dynamic subtest guc: SUCCESS (3.489s)
[490.214042] Starting dynamic subtest: guc_multi_lrc
[491.615718] Dynamic subtest guc_multi_lrc: SUCCESS (1.410s)
[491.625242] Starting dynamic subtest: guc_hang
[493.787940] Dynamic subtest guc_hang: SUCCESS (2.171s)
[493.797293] Starting dynamic subtest: late_gt_pm
[495.220609] Dynamic subtest late_gt_pm: SUCCESS (1.431s)
[495.222138] Subtest live: SUCCESS (260.933s)
[495.262442] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[495.263597] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[495.269857] [042/133] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[500.056930] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[500.059994] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[500.294729] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[500.297762] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[500.305375] [043/133] (531s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[501.808740] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[501.811604] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[501.997314] [044/133] (529s left) api_intel_allocator (standalone)
[502.045999] Starting subtest: standalone
[502.088575] Subtest standalone: SUCCESS (0.042s)
[502.295469] [045/133] (529s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[503.783109] Starting subtest: sprite-rotation-90-pos-100-0
[514.085657] Subtest sprite-rotation-90-pos-100-0: SUCCESS (10.304s)
[514.285997] [046/133] (517s left) api_intel_bb (render)
[514.349030] Starting subtest: render
[514.351194] Starting dynamic subtest: render-none-512
[514.398463] Dynamic subtest render-none-512: SUCCESS (0.050s)
[514.409704] Starting dynamic subtest: render-none-1024
[514.464422] Dynamic subtest render-none-1024: SUCCESS (0.064s)
[514.475245] Starting dynamic subtest: render-x-512
[514.484971] Dynamic subtest render-x-512: SUCCESS (0.019s)
[514.496224] Starting dynamic subtest: render-x-1024
[514.554064] Dynamic subtest render-x-1024: SUCCESS (0.067s)
[514.574663] Starting dynamic subtest: render-y-512
[514.576878] Dynamic subtest render-y-512: SUCCESS (0.020s)
[514.587674] Starting dynamic subtest: render-y-1024
[514.632136] Dynamic subtest render-y-1024: SUCCESS (0.056s)
[514.633728] Subtest render: SUCCESS (0.287s)
[514.836770] [047/133] (517s left) gem_exec_whisper (basic-normal-all)
[514.936126] Starting subtest: basic-normal-all
[516.522245] Subtest basic-normal-all: SUCCESS (1.587s)
[516.876701] [048/133] (515s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[518.381315] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[518.384131] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[518.523481] [049/133] (513s left) gem_exec_whisper (basic-sync-all)
[518.592473] Starting subtest: basic-sync-all
[522.025846] Subtest basic-sync-all: SUCCESS (3.432s)
[522.324304] [050/133] (509s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[523.812295] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[523.813829] Starting dynamic subtest: pipe-A-HDMI-A-4
[523.829197] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[523.840520] Starting dynamic subtest: pipe-B-HDMI-A-4
[523.855818] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[523.866458] Starting dynamic subtest: pipe-C-HDMI-A-4
[523.884350] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[523.895205] Starting dynamic subtest: pipe-D-HDMI-A-4
[523.912778] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[523.916103] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.014s)
[524.081684] [051/133] (508s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[525.571981] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[525.575192] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[525.702249] [052/133] (506s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[527.200467] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[527.218363] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.017s)
[527.345839] [053/133] (505s left) perf (gen12-invalid-class-instance)
[527.483095] Starting subtest: gen12-invalid-class-instance
[527.505641] Subtest gen12-invalid-class-instance: SUCCESS (0.022s)
[527.583942] [054/133] (504s left) gen9_exec_parse (allowed-all)
[527.636827] Subtest allowed-all: SKIP (0.000s)
[527.712178] [055/133] (504s left) vgem_basic (second-client)
[527.767610] Starting subtest: second-client
[527.800975] Subtest second-client: SUCCESS (0.033s)
[527.926926] [056/133] (504s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[529.414898] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[529.416932] Starting dynamic subtest: pipe-A
[531.599503] Dynamic subtest pipe-A: SUCCESS (2.186s)
[531.617169] Starting dynamic subtest: pipe-B
[533.822490] Dynamic subtest pipe-B: SUCCESS (2.221s)
[533.842661] Starting dynamic subtest: pipe-C
[534.130911] Dynamic subtest pipe-C: SUCCESS (0.306s)
[534.149956] Starting dynamic subtest: pipe-D
[534.437529] Dynamic subtest pipe-D: SUCCESS (0.304s)
[534.439325] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.026s)
[534.665851] [057/133] (498s left) gem_exec_fence (keep-in-fence)
[534.893358] Starting subtest: keep-in-fence
[534.895130] Starting dynamic subtest: rcs0
[534.967500] Dynamic subtest rcs0: SUCCESS (0.076s)
[534.979707] Starting dynamic subtest: bcs0
[535.020691] Dynamic subtest bcs0: SUCCESS (0.051s)
[535.046063] Starting dynamic subtest: vcs0
[535.085458] Dynamic subtest vcs0: SUCCESS (0.062s)
[535.123477] Starting dynamic subtest: vcs1
[535.162579] Dynamic subtest vcs1: SUCCESS (0.073s)
[535.183724] Starting dynamic subtest: vecs0
[535.222045] Dynamic subtest vecs0: SUCCESS (0.057s)
[535.224245] Subtest keep-in-fence: SUCCESS (0.334s)
[535.907035] [058/133] (496s left) prime_vgem (basic-write)
[535.987804] Starting subtest: basic-write
[535.995606] Subtest basic-write: SKIP (0.006s)
[536.152786] [059/133] (496s left) gem_exec_parallel (fds)
[536.212295] Starting subtest: fds
[536.214027] Starting dynamic subtest: rcs0
[539.641315] Dynamic subtest rcs0: SUCCESS (3.424s)
[539.652822] Starting dynamic subtest: bcs0
[542.827233] Dynamic subtest bcs0: SUCCESS (3.185s)
[542.838455] Starting dynamic subtest: vcs0
[546.435221] Dynamic subtest vcs0: SUCCESS (3.607s)
[546.447193] Starting dynamic subtest: vcs1
[549.660707] Dynamic subtest vcs1: SUCCESS (3.224s)
[549.672521] Starting dynamic subtest: vecs0
[552.671250] Dynamic subtest vecs0: SUCCESS (3.013s)
[552.672844] Subtest fds: SUCCESS (16.461s)
[553.053282] [060/133] (479s left) perf (blocking)
[553.171479] Starting subtest: blocking
[553.172920] Starting dynamic subtest: 0-rcs0
[563.222075] Dynamic subtest 0-rcs0: SUCCESS (10.047s)
[563.223574] Subtest blocking: SUCCESS (10.048s)
[563.293914] [061/133] (469s left) core_setmaster (master-drop-set-root)
[563.385163] Starting subtest: master-drop-set-root
[563.409994] Subtest master-drop-set-root: SUCCESS (0.025s)
[563.496327] [062/133] (469s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[564.986074] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[565.073080] [063/133] (468s left) gem_ctx_shared (detached-shared-gtt)
[565.134754] Starting subtest: detached-shared-gtt
[567.286587] Subtest detached-shared-gtt: SUCCESS (2.151s)
[568.499618] [064/133] (464s left) kms_flip (2x-flip-vs-expired-vblank)
[569.987026] Starting subtest: 2x-flip-vs-expired-vblank
[570.005410] Subtest 2x-flip-vs-expired-vblank: SKIP (0.017s)
[570.150783] [065/133] (463s left) i915_pm_rpm (debugfs-forcewake-user)
[574.080209] Starting subtest: debugfs-forcewake-user
[585.337284] Subtest debugfs-forcewake-user: SUCCESS (11.261s)
[586.269341] [066/133] (447s left) gem_softpin (allocator-basic)
[586.327335] Starting subtest: allocator-basic
[586.603096] Subtest allocator-basic: SUCCESS (0.272s)
[586.828978] [067/133] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[588.321752] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[588.324405] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[588.518915] [068/133] (445s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[590.008192] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[590.105567] [069/133] (443s left) kms_addfb_basic (size-max)
[591.596853] Starting subtest: size-max
[591.598835] Subtest size-max: SUCCESS (0.000s)
[591.778842] [070/133] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[593.273098] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[593.276208] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[593.465359] [071/133] (440s left) kms_chamelium_frames (hdmi-crc-single)
[595.007895] Subtest hdmi-crc-single: SKIP (0.000s)
[595.125826] [072/133] (439s left) gem_mmap_gtt (basic-write-gtt)
[595.175908] Subtest basic-write-gtt: SKIP (0.000s)
[595.262834] [073/133] (438s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[596.752705] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[596.838951] [074/133] (437s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[598.334357] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[598.337582] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[598.520353] [075/133] (435s left) kms_vblank (query-busy-hang)
[600.010422] Starting subtest: query-busy-hang
[600.011900] Starting dynamic subtest: pipe-A-HDMI-A-4
[626.464492] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.455s)
[626.481348] Starting dynamic subtest: pipe-D-HDMI-A-4
[651.477550] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (25.008s)
[651.479263] Subtest query-busy-hang: SUCCESS (51.471s)
[651.638267] [076/133] (382s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[653.134847] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[653.137494] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[653.319308] [077/133] (381s left) kms_psr (pr-sprite-mmap-gtt)
[654.808495] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[654.901931] [078/133] (379s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[656.401063] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[656.404100] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[656.595492] [079/133] (378s left) kms_flip (dpms-off-confusion)
[658.083103] Starting subtest: dpms-off-confusion
[658.090499] Starting dynamic subtest: A-HDMI-A4
[665.818644] Dynamic subtest A-HDMI-A4: SUCCESS (7.728s)
[665.834583] Starting dynamic subtest: B-HDMI-A4
[673.498821] Dynamic subtest B-HDMI-A4: SUCCESS (7.678s)
[673.511270] Starting dynamic subtest: C-HDMI-A4
[681.183700] Dynamic subtest C-HDMI-A4: SUCCESS (7.683s)
[681.198420] Starting dynamic subtest: D-HDMI-A4
[688.869029] Dynamic subtest D-HDMI-A4: SUCCESS (7.683s)
[688.870651] Subtest dpms-off-confusion: SUCCESS (30.788s)
[689.076663] [080/133] (345s left) kms_psr (psr2-suspend)
[690.567146] Subtest psr2-suspend: SKIP (0.000s)
[690.640698] [081/133] (344s left) gem_flink_race (flink_name)
[690.687125] Starting subtest: flink_name
[696.062593] Subtest flink_name: SUCCESS (5.372s)
[696.224509] [082/133] (338s left) kms_cursor_crc (cursor-random-64x64)
[697.866218] Starting subtest: cursor-random-64x64
[697.874827] Starting dynamic subtest: pipe-A-HDMI-A-4
[702.414483] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.541s)
[702.452299] Starting dynamic subtest: pipe-D-HDMI-A-4
[706.881526] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.441s)
[706.883218] Subtest cursor-random-64x64: SUCCESS (9.016s)
[707.417315] [083/133] (327s left) kms_rotation_crc (bad-pixel-format)
[708.938963] Starting subtest: bad-pixel-format
[711.073851] Subtest bad-pixel-format: SUCCESS (2.137s)
[711.315624] [084/133] (323s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[712.820811] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[712.823718] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[713.026918] [085/133] (322s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[714.558040] Starting subtest: stress-xrgb8888-xtiled
[728.344543] Subtest stress-xrgb8888-xtiled: SUCCESS (13.792s)
[728.480102] [086/133] (306s left) gem_ctx_persistence (heartbeat-hang)
[728.531991] Starting subtest: heartbeat-hang
[728.535122] Subtest heartbeat-hang: SKIP (0.000s)
[728.653285] [087/133] (306s left) kms_joiner (basic-force-big-joiner)
[730.144717] Starting subtest: basic-force-big-joiner
[730.147606] Subtest basic-force-big-joiner: SKIP (0.000s)
[730.254604] [088/133] (305s left) kms_dsc (dsc-with-bpc-formats)
[731.774920] Starting subtest: dsc-with-bpc-formats
[731.870615] Subtest dsc-with-bpc-formats: SKIP (0.005s)
[731.989256] [089/133] (303s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[733.476201] Starting subtest: cursorB-vs-flipB-atomic-transitions
[733.479130] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s)
[733.618792] [090/133] (302s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[735.121231] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[735.122931] Starting dynamic subtest: pipe-A-HDMI-A-4
[735.151074] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[735.162759] Starting dynamic subtest: pipe-B-HDMI-A-4
[735.176472] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[735.187841] Starting dynamic subtest: pipe-C-HDMI-A-4
[735.201901] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[735.213701] Starting dynamic subtest: pipe-D-HDMI-A-4
[735.228537] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[735.231497] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[735.379068] [091/133] (300s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[736.884714] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[737.997838] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.109s)
[738.201638] [092/133] (297s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[739.687876] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[739.689383] Starting dynamic subtest: pipe-A-HDMI-A-4
[739.704186] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[739.716231] Starting dynamic subtest: pipe-B-HDMI-A-4
[739.733799] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[739.745204] Starting dynamic subtest: pipe-C-HDMI-A-4
[739.760714] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[739.772255] Starting dynamic subtest: pipe-D-HDMI-A-4
[739.789166] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[739.792563] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[739.959107] [093/133] (296s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[741.446514] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[741.449612] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.000s)
[741.566385] [094/133] (294s left) kms_hdmi_inject (inject-4k)
[741.663167] Starting subtest: inject-4k
[741.819365] Subtest inject-4k: SUCCESS (0.158s)
[742.733635] [095/133] (293s left) gem_exec_schedule (preempt-other-chain)
[742.804069] Starting subtest: preempt-other-chain
[742.805899] Starting dynamic subtest: rcs0
[742.965509] Dynamic subtest rcs0: SUCCESS (0.159s)
[742.977770] Starting dynamic subtest: bcs0
[743.107143] Dynamic subtest bcs0: SUCCESS (0.140s)
[743.118928] Starting dynamic subtest: vcs0
[743.247587] Dynamic subtest vcs0: SUCCESS (0.139s)
[743.259345] Starting dynamic subtest: vcs1
[743.392231] Dynamic subtest vcs1: SUCCESS (0.143s)
[743.404052] Starting dynamic subtest: vecs0
[743.535059] Dynamic subtest vecs0: SUCCESS (0.141s)
[743.536611] Subtest preempt-other-chain: SUCCESS (0.730s)
[744.000241] [096/133] (292s left) syncobj_timeline (multi-wait-available-submitted)
[744.048932] Starting subtest: multi-wait-available-submitted
[744.050377] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[744.168965] [097/133] (292s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[745.675908] Starting subtest: 4-tiled-8bpp-rotate-90
[745.689223] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[745.850553] [098/133] (290s left) kms_pm_backlight (fade-with-dpms)
[747.342163] Subtest fade-with-dpms: SKIP (0.000s)
[747.425152] [099/133] (289s left) syncobj_wait (reset-signaled)
[747.473039] Starting subtest: reset-signaled
[747.474595] Subtest reset-signaled: SUCCESS (0.000s)
[747.581963] [100/133] (289s left) gem_eio (in-flight-1us)
[747.770265] Starting subtest: in-flight-1us
[752.033559] Subtest in-flight-1us: SUCCESS (4.263s)
[753.659683] [101/133] (283s left) kms_fbcon_fbt (psr-suspend)
[753.711635] Starting subtest: psr-suspend
[753.714540] Subtest psr-suspend: SKIP (0.000s)
[753.949551] [102/133] (282s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[755.436889] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[755.438602] Starting dynamic subtest: pipe-A-valid-mode
[756.676465] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.240s)
[756.678176] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.243s)
[756.866265] [103/133] (280s left) syncobj_timeline (device-submit-unordered)
[756.913888] Starting subtest: device-submit-unordered
[756.915695] Subtest device-submit-unordered: SUCCESS (0.001s)
[757.041409] [104/133] (279s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[757.088121] Starting subtest: multi-wait-all-for-submit-available-submitted
[757.089529] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[757.222393] [105/133] (279s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[758.715708] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[758.718337] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[758.953891] [106/133] (278s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[760.439311] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[760.441089] Starting dynamic subtest: pipe-A-valid-mode
[762.932603] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.489s)
[762.934168] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.492s)
[763.114646] [107/133] (274s left) syncobj_basic (bad-flags-handle-to-fd)
[763.164854] Starting subtest: bad-flags-handle-to-fd
[763.166678] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[763.280517] [108/133] (274s left) gem_exec_create (forked)
[763.336028] Starting subtest: forked
[763.337498] Starting dynamic subtest: smem
[783.469702] Dynamic subtest smem: SUCCESS (20.133s)
[783.489290] Starting dynamic subtest: lmem0
[803.625581] Dynamic subtest lmem0: SUCCESS (20.154s)
[803.627259] Subtest forked: SUCCESS (40.291s)
[803.911432] [109/133] (233s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[803.963869] Starting subtest: invalid-bsd2-flag-on-vebox
[803.965480] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[804.114423] [110/133] (233s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[804.167404] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[804.241760] [111/133] (233s left) gem_exec_balancer (bonded-true-hang)
[804.622640] Starting subtest: bonded-true-hang
[804.626169] Subtest bonded-true-hang: SKIP (0.000s)
[804.745541] [112/133] (232s left) kms_atomic (plane-cursor-legacy)
[806.235600] Starting subtest: plane-cursor-legacy
[806.237141] Starting dynamic subtest: pipe-A-HDMI-A-4
[806.569716] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.331s)
[806.571283] Subtest plane-cursor-legacy: SUCCESS (0.334s)
[806.760815] [113/133] (231s left) kms_flip (basic-plain-flip)
[808.248355] Starting subtest: basic-plain-flip
[808.254254] Starting dynamic subtest: A-HDMI-A4
[808.986649] Dynamic subtest A-HDMI-A4: SUCCESS (0.732s)
[809.009353] Starting dynamic subtest: B-HDMI-A4
[809.683636] Dynamic subtest B-HDMI-A4: SUCCESS (0.695s)
[809.698790] Starting dynamic subtest: C-HDMI-A4
[810.369206] Dynamic subtest C-HDMI-A4: SUCCESS (0.684s)
[810.384802] Starting dynamic subtest: D-HDMI-A4
[811.053927] Dynamic subtest D-HDMI-A4: SUCCESS (0.683s)
[811.055529] Subtest basic-plain-flip: SUCCESS (2.809s)
[811.281304] [114/133] (226s left) prime_mmap (test_correct_cpu_write)
[811.333113] Starting subtest: test_correct_cpu_write
[811.334886] Starting dynamic subtest: test_correct_cpu_write-smem
[811.336559] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[811.349907] Starting dynamic subtest: test_correct_cpu_write-lmem0
[811.351842] Dynamic subtest test_correct_cpu_write-lmem0: SUCCESS (0.000s)
[811.353739] Subtest test_correct_cpu_write: SUCCESS (0.004s)
[811.489303] [115/133] (226s left) gem_mmap_offset (isolation)
[811.536232] Starting subtest: isolation
[811.548882] Subtest isolation: SUCCESS (0.005s)
[811.718463] [116/133] (226s left) kms_plane_multiple (tiling-4)
[813.204531] Starting subtest: tiling-4
[813.207101] Subtest tiling-4: SKIP (0.000s)
[813.315320] [117/133] (224s left) kms_async_flips (async-flip-suspend-resume)
[814.806978] Starting subtest: async-flip-suspend-resume
[815.034356] Starting dynamic subtest: pipe-A-HDMI-A-4
[837.433066] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (11.519s)
[837.610554] Starting dynamic subtest: pipe-B-HDMI-A-4
[860.395968] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (11.022s)
[860.572448] Starting dynamic subtest: pipe-C-HDMI-A-4
[883.388469] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (11.201s)
[883.555826] Starting dynamic subtest: pipe-D-HDMI-A-4
[906.418569] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (11.024s)
[906.422381] Subtest async-flip-suspend-resume: SUCCESS (45.486s)
[912.795818] [118/133] (131s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[914.946123] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[914.947938] Starting dynamic subtest: pipe-A-HDMI-A-4
[914.964064] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[914.979801] Starting dynamic subtest: pipe-B-HDMI-A-4
[914.999078] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[915.014236] Starting dynamic subtest: pipe-C-HDMI-A-4
[915.039538] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[915.054594] Starting dynamic subtest: pipe-D-HDMI-A-4
[915.068159] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[915.069704] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.019s)
[915.220603] [119/133] (129s left) gem_eio (execbuf)
[915.417147] Starting subtest: execbuf
[915.720806] Subtest execbuf: SUCCESS (0.303s)
[917.304578] [120/133] (127s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[918.802915] Starting subtest: fbcpsr-1p-rte
[918.805976] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[919.015240] [121/133] (125s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[920.508593] Starting subtest: psr-shrfb-scaledprimary
[920.511200] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[920.710360] [122/133] (123s left) i915_drm_fdinfo (all-busy-idle-check-all)
[920.760516] Starting subtest: all-busy-idle-check-all
[920.778209] Subtest all-busy-idle-check-all: SKIP (0.016s)
[920.885481] [123/133] (123s left) gen3_render_mixed_blits
[921.055800] [124/133] (123s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[925.185534] Starting subtest: modeset-non-lpsp-stress-no-wait
[926.733688] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (1.553s)
[926.892077] [125/133] (118s left) syncobj_timeline (wait-for-submit-snapshot)
[926.942236] Starting subtest: wait-for-submit-snapshot
[927.026007] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[927.164580] [126/133] (117s left) kms_cursor_legacy (torture-move)
[928.653330] Starting subtest: torture-move
[928.654987] Starting dynamic subtest: pipe-A
[934.195789] Dynamic subtest pipe-A: SUCCESS (5.542s)
[934.217548] Starting dynamic subtest: pipe-B
[939.841052] Dynamic subtest pipe-B: SUCCESS (5.644s)
[939.861486] Starting dynamic subtest: pipe-C
[945.332758] Dynamic subtest pipe-C: SUCCESS (5.490s)
[945.348123] Starting dynamic subtest: pipe-D
[950.807058] Dynamic subtest pipe-D: SUCCESS (5.473s)
[950.823990] Starting dynamic subtest: all-pipes
[956.298637] Dynamic subtest all-pipes: SUCCESS (5.489s)
[956.300262] Subtest torture-move: SUCCESS (27.646s)
[956.466563] [127/133] ( 88s left) gem_mmap_gtt (fault-concurrent)
[956.518547] Subtest fault-concurrent: SKIP (0.000s)
[956.606604] [128/133] ( 88s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[958.099107] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[958.102553] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[958.207053] [129/133] ( 87s left) gem_exec_endless (dispatch)
[958.286134] Starting subtest: dispatch
[958.287828] Starting dynamic subtest: rcs0
[958.293678] Dynamic subtest rcs0: SUCCESS (0.008s)
[958.309046] Starting dynamic subtest: bcs0
[958.311753] Dynamic subtest bcs0: SUCCESS (0.007s)
[958.326969] Starting dynamic subtest: vcs0
[958.329768] Dynamic subtest vcs0: SUCCESS (0.007s)
[958.347219] Starting dynamic subtest: vcs1
[958.350050] Dynamic subtest vcs1: SUCCESS (0.007s)
[958.364853] Starting dynamic subtest: vecs0
[958.367965] Dynamic subtest vecs0: SUCCESS (0.009s)
[958.369589] Subtest dispatch: SUCCESS (0.046s)
[958.504027] [130/133] ( 86s left) gem_mmap_gtt (basic-copy)
[958.553576] Subtest basic-copy: SKIP (0.000s)
[958.637049] [131/133] ( 86s left) syncobj_timeline (single-wait-available-signaled)
[958.684692] Starting subtest: single-wait-available-signaled
[958.686244] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[958.807640] [132/133] ( 86s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[960.303605] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[960.306423] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[960.479686] [133/133] ( 85s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[961.976001] Starting subtest: fbc-rgb565-draw-render
[964.834428] Subtest fbc-rgb565-draw-render: SUCCESS (2.860s)
[965.031880] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_color_pipeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: prime_vgem
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: prime_self_import
results: parsing output: 9/ for test: gem_create
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: fbdev
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: i915_pm_freq_api
results: parsing output: 19/ for test: gem_ctx_isolation
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_properties
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: perf_pmu
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: tools_test
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: kms_cdclk
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: i915_selftest
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: api_intel_allocator
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: core_setmaster
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: i915_pm_rpm
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_frames
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_flink_race
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_pipe_stress
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_hdmi_inject
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_pm_backlight
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_fbcon_fbt
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: gem_exec_create
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_atomic
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: prime_mmap
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: kms_plane_multiple
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: gen3_render_mixed_blits
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_joiner
results: parsing output: 128/ for test: gem_exec_endless
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.