[71.394198] Initializing watchdogs
[71.394264]   /dev/watchdog0
[71.414756] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[71.425941] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[71.429947] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.432384] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[72.947968] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[72.949817] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[73.082808] [002/133] (958s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[74.622506] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[74.668631] [003/133] (957s left) gem_mmap (short-mmap)
[74.740014] Subtest short-mmap: SKIP (0.000s)
[74.813431] [004/133] (957s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[76.325330] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[76.384898] [005/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[77.899912] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[77.901569] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[78.029646] [006/133] (954s left) kms_frontbuffer_tracking (psr-slowdraw)
[79.565593] Starting subtest: psr-slowdraw
[79.567253] Subtest psr-slowdraw: SKIP (0.000s)
[79.696027] [007/133] (952s left) syncobj_wait (single-wait-for-submit-submitted)
[79.803366] Starting subtest: single-wait-for-submit-submitted
[79.905874] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[80.065940] [008/133] (952s left) kms_color (ctm-0-75)
[81.569006] Starting subtest: ctm-0-75
[81.569900] Starting dynamic subtest: pipe-A-HDMI-A-3
[83.706273] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.137s)
[83.713597] Starting dynamic subtest: pipe-B-HDMI-A-3
[85.561162] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.854s)
[85.568471] Starting dynamic subtest: pipe-C-HDMI-A-3
[87.397768] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.836s)
[87.405617] Starting dynamic subtest: pipe-D-HDMI-A-3
[89.243492] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.846s)
[89.244400] Subtest ctm-0-75: SUCCESS (7.675s)
[89.440976] [009/133] (942s left) i915_pm_freq_api (freq-reset)
[89.541812] Starting subtest: freq-reset
[89.542723] Starting dynamic subtest: gt0
[89.936460] Dynamic subtest gt0: SUCCESS (0.394s)
[89.937401] Subtest freq-reset: SUCCESS (0.395s)
[90.015884] [010/133] (942s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[90.690043] Starting subtest: syncobj-timeline-multiple-ext-nodes
[90.691162] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[90.955692] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[90.957410] [011/133] (941s left) kms_force_connector_basic (prune-stale-modes)
[91.117966] Starting subtest: prune-stale-modes
[91.142205] Subtest prune-stale-modes: SUCCESS (0.024s)
[92.789965] [012/133] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[94.330580] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[94.332273] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[94.454042] [013/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[95.995830] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[95.997485] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[96.184027] [014/133] (936s left) prime_self_import (basic-with_one_bo)
[96.241946] Starting subtest: basic-with_one_bo
[96.290604] Subtest basic-with_one_bo: SUCCESS (0.050s)
[96.449622] [015/133] (936s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[96.530102] Starting subtest: multi-wait-all-for-submit-available-signaled
[96.531197] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[96.662125] [016/133] (936s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[96.746474] Starting subtest: rel-constants-invalid-rel-gen5
[96.747410] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[96.864310] [017/133] (936s left) i915_pm_rps (reset)
[96.954400] Starting subtest: reset
[102.257913] Subtest reset: SUCCESS (5.303s)
[102.390909] [018/133] (930s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[103.903088] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[103.904916] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[103.989614] [019/133] (929s left) gem_mmap_wc (invalid-flags)
[104.082138] Subtest invalid-flags: SKIP (0.000s)
[104.150366] [020/133] (928s left) kms_joiner (basic-force-ultra-joiner)
[105.666300] Starting subtest: basic-force-ultra-joiner
[105.667950] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[105.760597] [021/133] (927s left) kms_lease (atomic-implicit-crtc)
[107.299012] Starting subtest: atomic-implicit-crtc
[107.299989] Starting dynamic subtest: pipe-A-HDMI-A-3
[107.304293] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.002s)
[107.312692] Starting dynamic subtest: pipe-B-HDMI-A-3
[107.317200] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.011s)
[107.325468] Starting dynamic subtest: pipe-C-HDMI-A-3
[107.329890] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.011s)
[107.338272] Starting dynamic subtest: pipe-D-HDMI-A-3
[107.342905] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.011s)
[107.343940] Subtest atomic-implicit-crtc: SUCCESS (0.041s)
[107.485267] [022/133] (925s left) gem_render_copy (y-tiled)
[107.601738] Starting subtest: y-tiled
[107.604045] Subtest y-tiled: SKIP (0.000s)
[107.817484] [023/133] (925s left) kms_feature_discovery (display-1x)
[109.331559] Starting subtest: display-1x
[109.332416] Subtest display-1x: SUCCESS (0.000s)
[109.483214] [024/133] (923s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[111.043569] Starting subtest: yf-tiled-64bpp-rotate-0
[111.045333] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[111.176775] [025/133] (922s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[112.720094] Starting subtest: fbc-indfb-scaledprimary
[114.492582] Subtest fbc-indfb-scaledprimary: SUCCESS (1.773s)
[114.700755] [026/133] (918s left) kms_busy (extended-modeset-hang-newfb)
[116.221434] Starting subtest: extended-modeset-hang-newfb
[116.222315] Starting dynamic subtest: pipe-A
[131.842943] Dynamic subtest pipe-A: SUCCESS (15.621s)
[131.852795] Starting dynamic subtest: pipe-D
[147.413430] Dynamic subtest pipe-D: SUCCESS (15.568s)
[147.414309] Subtest extended-modeset-hang-newfb: SUCCESS (31.193s)
[147.691523] [027/133] (885s left) kms_prop_blob (blob-prop-lifetime)
[147.769980] Starting subtest: blob-prop-lifetime
[147.785941] Subtest blob-prop-lifetime: SUCCESS (0.017s)
[147.919567] [028/133] (885s left) gem_pxp (reject-modify-context-protection-off-1)
[150.519941] Starting subtest: reject-modify-context-protection-off-1
[150.522492] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[150.618033] [029/133] (883s left) perf (invalid-open-flags)
[151.009818] Starting subtest: invalid-open-flags
[151.010608] Subtest invalid-open-flags: SUCCESS (0.000s)
[151.061518] [030/133] (882s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[152.591434] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[153.782474] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.191s)
[153.998112] [031/133] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[155.518994] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[158.350963] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.832s)
[158.558559] [032/133] (875s left) core_setmaster (master-drop-set-user)
[158.682978] Starting subtest: master-drop-set-user
[158.720047] Subtest master-drop-set-user: SUCCESS (0.037s)
[158.768195] [033/133] (875s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[158.853577] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[158.855513] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[159.088275] [034/133] (874s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[159.176581] Subtest writes-after-reads-snoop: SKIP (0.000s)
[159.242302] [035/133] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[160.765408] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[160.767163] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[160.992092] [036/133] (873s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[162.523512] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[162.525346] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[162.656119] [037/133] (871s left) gem_userptr_blits (dmabuf-unsync)
[162.773160] Subtest dmabuf-unsync: SKIP (0.000s)
[162.954730] [038/133] (871s left) kms_psr (psr2-sprite-blt)
[164.476194] Subtest psr2-sprite-blt: SKIP (0.000s)
[164.525978] [039/133] (869s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[166.041517] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[166.043241] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[166.137098] [040/133] (868s left) perf_pmu (enable-race)
[166.226783] Starting subtest: enable-race
[166.227643] Starting dynamic subtest: rcs0
[178.990563] Dynamic subtest rcs0: SUCCESS (12.763s)
[178.999376] Starting dynamic subtest: bcs0
[191.730272] Dynamic subtest bcs0: SUCCESS (12.739s)
[191.739118] Starting dynamic subtest: vcs0
[204.472567] Dynamic subtest vcs0: SUCCESS (12.742s)
[204.481169] Starting dynamic subtest: vcs1
[217.213299] Dynamic subtest vcs1: SUCCESS (12.740s)
[217.222167] Starting dynamic subtest: vecs0
[229.952469] Dynamic subtest vecs0: SUCCESS (12.739s)
[229.961211] Starting dynamic subtest: vecs1
[242.694239] Dynamic subtest vecs1: SUCCESS (12.741s)
[242.702929] Starting dynamic subtest: ccs0
[255.434215] Dynamic subtest ccs0: SUCCESS (12.739s)
[255.435139] Subtest enable-race: SUCCESS (89.206s)
[255.622451] [041/133] (778s left) kms_pm_rpm (drm-resources-equal)
[260.073687] Starting subtest: drm-resources-equal
[265.170125] Subtest drm-resources-equal: SUCCESS (5.097s)
[265.372155] [042/133] (769s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[266.891262] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[267.039609] [043/133] (767s left) prime_vgem (busy)
[267.162171] Starting subtest: busy
[267.163369] Starting dynamic subtest: rcs0
[267.240347] Dynamic subtest rcs0: SUCCESS (0.079s)
[267.249172] Starting dynamic subtest: bcs0
[267.295995] Dynamic subtest bcs0: SUCCESS (0.055s)
[267.308482] Starting dynamic subtest: vcs0
[267.342935] Dynamic subtest vcs0: SUCCESS (0.046s)
[267.360933] Starting dynamic subtest: vcs1
[267.389228] Dynamic subtest vcs1: SUCCESS (0.045s)
[267.407178] Starting dynamic subtest: vecs0
[267.434832] Dynamic subtest vecs0: SUCCESS (0.045s)
[267.452781] Starting dynamic subtest: vecs1
[267.478149] Dynamic subtest vecs1: SUCCESS (0.042s)
[267.496172] Starting dynamic subtest: ccs0
[267.522023] Dynamic subtest ccs0: SUCCESS (0.043s)
[267.523217] Subtest busy: SUCCESS (0.361s)
[267.701503] [044/133] (767s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[269.215479] Starting subtest: nonblocking-crc-frame-sequence
[269.216433] Starting dynamic subtest: pipe-A-HDMI-A-3
[269.951255] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.735s)
[269.962926] Starting dynamic subtest: pipe-B-HDMI-A-3
[270.503238] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.550s)
[270.512463] Starting dynamic subtest: pipe-C-HDMI-A-3
[271.023267] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.518s)
[271.034256] Starting dynamic subtest: pipe-D-HDMI-A-3
[271.587471] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.563s)
[271.588422] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.373s)
[271.757546] [045/133] (763s left) kms_psr (fbc-pr-cursor-plane-move)
[273.276658] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[273.340900] [046/133] (761s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[274.855678] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[275.073225] Starting dynamic subtest: pipe-A-HDMI-A-3
[277.346537] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.273s)
[277.512188] Starting dynamic subtest: pipe-B-HDMI-A-3
[279.574112] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.068s)
[279.734124] Starting dynamic subtest: pipe-C-HDMI-A-3
[281.795818] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.069s)
[281.951613] Starting dynamic subtest: pipe-D-HDMI-A-3
[284.016633] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.072s)
[284.017970] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.162s)
[284.320936] [047/133] (750s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[284.406417] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[284.513071] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[284.642488] [048/133] (750s left) kms_vrr (max-min)
[286.158428] Starting subtest: max-min
[286.161026] Subtest max-min: SKIP (0.000s)
[286.275208] [049/133] (748s left) gem_spin_batch (spin-each)
[286.386962] Starting subtest: spin-each
[289.816652] Subtest spin-each: SUCCESS (3.429s)
[290.111966] [050/133] (745s left) kms_chamelium_color (ctm-0-50)
[291.627482] Subtest ctm-0-50: SKIP (0.000s)
[291.687700] [051/133] (743s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[293.202469] Starting subtest: basic-flip-after-cursor-legacy
[294.186565] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.984s)
[294.460721] [052/133] (740s left) gem_pwrite (basic-exhaustion)
[294.544018] Subtest basic-exhaustion: SKIP (0.000s)
[294.623403] [053/133] (740s left) kms_pm_rpm (modeset-non-lpsp)
[299.077758] Starting subtest: modeset-non-lpsp
[300.329026] Subtest modeset-non-lpsp: SUCCESS (1.250s)
[301.186212] [054/133] (734s left) i915_selftest (live)
[302.200062] Starting subtest: live
[302.201073] Starting dynamic subtest: sanitycheck
[303.868986] Dynamic subtest sanitycheck: SUCCESS (1.669s)
[303.876529] Starting dynamic subtest: uncore
[305.538761] Dynamic subtest uncore: SUCCESS (1.669s)
[305.546236] Starting dynamic subtest: workarounds
[321.860789] Dynamic subtest workarounds: FAIL (16.123s)
[321.867231] Starting dynamic subtest: gt_engines
[324.123083] Dynamic subtest gt_engines: SUCCESS (2.459s)
[324.130540] Starting dynamic subtest: gt_timelines
[343.651166] Dynamic subtest gt_timelines: SUCCESS (19.527s)
[343.658551] Starting dynamic subtest: gt_contexts
[345.366059] Dynamic subtest gt_contexts: SUCCESS (1.714s)
[345.373565] Starting dynamic subtest: gt_lrc
[351.676991] Dynamic subtest gt_lrc: SUCCESS (6.310s)
[351.684389] Starting dynamic subtest: gt_mocs
[354.956981] Dynamic subtest gt_mocs: SUCCESS (3.279s)
[354.964400] Starting dynamic subtest: gt_pm
[359.228901] Dynamic subtest gt_pm: SUCCESS (4.271s)
[359.236493] Starting dynamic subtest: gt_heartbeat
[360.950994] Dynamic subtest gt_heartbeat: SUCCESS (1.721s)
[360.958525] Starting dynamic subtest: gt_tlb
[373.601915] Dynamic subtest gt_tlb: SUCCESS (12.650s)
[373.609380] Starting dynamic subtest: requests
[387.238010] Dynamic subtest requests: SUCCESS (13.635s)
[387.245468] Starting dynamic subtest: migrate
[392.161088] Dynamic subtest migrate: SUCCESS (4.922s)
[392.168570] Starting dynamic subtest: active
[393.858921] Dynamic subtest active: SUCCESS (1.697s)
[393.866399] Starting dynamic subtest: objects
[396.278167] Dynamic subtest objects: SUCCESS (2.418s)
[396.285690] Starting dynamic subtest: mman
[402.981912] Dynamic subtest mman: SUCCESS (6.703s)
[402.989520] Starting dynamic subtest: dmabuf
[404.726573] Dynamic subtest dmabuf: SUCCESS (1.743s)
[404.734159] Starting dynamic subtest: vma
[406.395102] Dynamic subtest vma: SUCCESS (1.668s)
[406.402769] Starting dynamic subtest: coherency
[410.298049] Dynamic subtest coherency: SUCCESS (3.902s)
[410.305658] Starting dynamic subtest: gtt
[420.431970] Dynamic subtest gtt: SUCCESS (10.133s)
[420.439390] Starting dynamic subtest: gem
[422.253981] Dynamic subtest gem: SUCCESS (1.821s)
[422.261494] Starting dynamic subtest: evict
[425.335932] Dynamic subtest evict: SUCCESS (3.081s)
[425.343448] Starting dynamic subtest: hugepages
[443.329052] Dynamic subtest hugepages: SUCCESS (17.992s)
[443.336509] Starting dynamic subtest: gem_contexts
[476.648919] Dynamic subtest gem_contexts: SUCCESS (33.318s)
[476.656343] Starting dynamic subtest: client
[478.353250] Dynamic subtest client: SUCCESS (1.703s)
[478.360758] Starting dynamic subtest: gem_migrate
[482.348159] Dynamic subtest gem_migrate: SUCCESS (3.994s)
[482.355629] Starting dynamic subtest: reset
[484.102899] Dynamic subtest reset: SUCCESS (1.754s)
[484.110322] Starting dynamic subtest: memory_region
[487.405057] Dynamic subtest memory_region: SUCCESS (3.301s)
[487.412599] Starting dynamic subtest: hangcheck
[519.991269] Dynamic subtest hangcheck: SUCCESS (32.577s)
[519.999706] Starting dynamic subtest: execlists
[521.651889] Dynamic subtest execlists: SUCCESS (1.667s)
[521.659366] Starting dynamic subtest: ring_submission
[523.359240] Dynamic subtest ring_submission: SUCCESS (1.706s)
[523.366686] Starting dynamic subtest: perf
[525.202899] Dynamic subtest perf: SUCCESS (1.842s)
[525.210388] Starting dynamic subtest: slpc
[532.470874] Dynamic subtest slpc: SUCCESS (7.267s)
[532.478682] Starting dynamic subtest: guc
[535.530049] Dynamic subtest guc: SUCCESS (3.058s)
[535.538348] Starting dynamic subtest: guc_multi_lrc
[537.242868] Dynamic subtest guc_multi_lrc: SUCCESS (1.711s)
[537.250538] Starting dynamic subtest: guc_hang
[539.729324] Dynamic subtest guc_hang: SUCCESS (2.484s)
[539.755786] Starting dynamic subtest: late_gt_pm
[541.476866] Dynamic subtest late_gt_pm: SUCCESS (1.745s)
[541.477728] Subtest live: FAIL (239.273s)
[541.509522] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[541.511244] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[541.513430] [055/133] (493s left) sysfs_preempt_timeout (timeout)
[545.140786] Starting subtest: timeout
[545.141583] Starting dynamic subtest: vecs0
[546.856655] Dynamic subtest vecs0: SUCCESS (1.716s)
[546.870717] Starting dynamic subtest: ccs0
[548.517116] Dynamic subtest ccs0: SUCCESS (1.658s)
[548.525990] Starting dynamic subtest: vcs0
[550.179136] Dynamic subtest vcs0: SUCCESS (1.661s)
[550.188166] Starting dynamic subtest: bcs0
[551.853298] Dynamic subtest bcs0: SUCCESS (1.673s)
[551.861894] Starting dynamic subtest: vecs1
[553.551249] Dynamic subtest vecs1: SUCCESS (1.697s)
[553.559795] Starting dynamic subtest: rcs0
[555.235244] Dynamic subtest rcs0: SUCCESS (1.683s)
[555.245219] Starting dynamic subtest: vcs1
[556.925161] Dynamic subtest vcs1: SUCCESS (1.688s)
[556.926230] Subtest timeout: SUCCESS (11.785s)
[557.010597] [FACT sysfs_preempt_timeout (timeout)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[557.013340] [FACT sysfs_preempt_timeout (timeout)] new: kernel.kmod_is_loaded.i915: true
[557.015902] [056/133] (478s left) kms_psr (fbc-psr2-primary-render)
[558.535314] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[558.592489] [057/133] (477s left) gem_exec_fence (basic-busy)
[558.804378] Starting subtest: basic-busy
[558.805568] Starting dynamic subtest: rcs0
[558.921398] Dynamic subtest rcs0: SUCCESS (0.118s)
[558.942022] Starting dynamic subtest: bcs0
[558.978492] Dynamic subtest bcs0: SUCCESS (0.055s)
[559.011187] Starting dynamic subtest: vcs0
[559.035888] Dynamic subtest vcs0: SUCCESS (0.054s)
[559.055687] Starting dynamic subtest: vcs1
[559.092040] Dynamic subtest vcs1: SUCCESS (0.054s)
[559.119886] Starting dynamic subtest: vecs0
[559.149318] Dynamic subtest vecs0: SUCCESS (0.055s)
[559.170457] Starting dynamic subtest: vecs1
[559.205203] Dynamic subtest vecs1: SUCCESS (0.053s)
[559.235174] Starting dynamic subtest: ccs0
[559.264759] Dynamic subtest ccs0: SUCCESS (0.057s)
[559.265952] Subtest basic-busy: SUCCESS (0.464s)
[559.978337] [058/133] (475s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[561.495650] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[561.531375] Starting dynamic subtest: pipe-A-plane-0
[562.614519] Dynamic subtest pipe-A-plane-0: SUCCESS (1.083s)
[562.648958] Starting dynamic subtest: pipe-A-plane-3
[563.280869] Dynamic subtest pipe-A-plane-3: SUCCESS (0.664s)
[563.443150] Starting dynamic subtest: pipe-B-plane-0
[564.401866] Dynamic subtest pipe-B-plane-0: SUCCESS (0.966s)
[564.417055] Starting dynamic subtest: pipe-B-plane-3
[565.118167] Dynamic subtest pipe-B-plane-3: SUCCESS (0.714s)
[565.175952] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.680s)
[565.432744] [059/133] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[566.961037] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[566.962703] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[567.081908] [060/133] (468s left) syncobj_timeline (single-wait-available-signaled)
[567.185557] Starting subtest: single-wait-available-signaled
[567.186474] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[567.346413] [061/133] (468s left) gem_exec_schedule (preempt-engines)
[567.440821] Starting subtest: preempt-engines
[567.441774] Starting dynamic subtest: rcs0
[569.696890] Dynamic subtest rcs0: SUCCESS (2.254s)
[569.713028] Starting dynamic subtest: bcs0
[571.895143] Dynamic subtest bcs0: SUCCESS (2.193s)
[571.912370] Starting dynamic subtest: vcs0
[574.250043] Dynamic subtest vcs0: SUCCESS (2.350s)
[574.267456] Starting dynamic subtest: vcs1
[576.601089] Dynamic subtest vcs1: SUCCESS (2.347s)
[576.618441] Starting dynamic subtest: vecs0
[578.947605] Dynamic subtest vecs0: SUCCESS (2.343s)
[578.959090] Starting dynamic subtest: vecs1
[581.351857] Dynamic subtest vecs1: SUCCESS (2.402s)
[581.386402] Starting dynamic subtest: ccs0
[583.609019] Dynamic subtest ccs0: SUCCESS (2.253s)
[583.614528] Subtest preempt-engines: SUCCESS (16.169s)
[583.969131] [062/133] (451s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[584.050038] Starting subtest: multi-wait-all-for-submit-unsubmitted
[584.153057] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[584.295038] [063/133] (451s left) perf (non-system-wide-paranoid)
[584.687164] Starting subtest: non-system-wide-paranoid
[584.724352] Subtest non-system-wide-paranoid: SUCCESS (0.037s)
[584.783443] [064/133] (451s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[586.401375] Starting subtest: cursor-rapid-movement-32x32
[586.456700] Subtest cursor-rapid-movement-32x32: SKIP (0.053s)
[586.875825] [065/133] (449s left) gem_exec_reloc (basic-range)
[586.960623] Subtest basic-range: SKIP (0.000s)
[587.054740] [066/133] (449s left) gen7_exec_parse (basic-offset)
[587.141481] Subtest basic-offset: SKIP (0.000s)
[587.196210] [067/133] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[588.716141] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[588.717883] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[588.862219] [068/133] (447s left) gem_exec_schedule (timeslicing)
[588.981283] Starting subtest: timeslicing
[588.982174] Starting dynamic subtest: rcs0
[589.003056] Dynamic subtest rcs0: SUCCESS (0.021s)
[589.013644] Starting dynamic subtest: bcs0
[589.024768] Dynamic subtest bcs0: SUCCESS (0.021s)
[589.036930] Starting dynamic subtest: vcs0
[589.050388] Dynamic subtest vcs0: SUCCESS (0.024s)
[589.064833] Starting dynamic subtest: vcs1
[589.074513] Dynamic subtest vcs1: SUCCESS (0.023s)
[589.089144] Starting dynamic subtest: vecs0
[589.099687] Dynamic subtest vecs0: SUCCESS (0.024s)
[589.114183] Starting dynamic subtest: vecs1
[589.124768] Dynamic subtest vecs1: SUCCESS (0.023s)
[589.139252] Starting dynamic subtest: ccs0
[589.151196] Dynamic subtest ccs0: SUCCESS (0.025s)
[589.152264] Subtest timeslicing: SUCCESS (0.171s)
[589.579230] [069/133] (446s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[591.096286] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[591.097192] Starting dynamic subtest: pipe-A-HDMI-A-3
[591.118581] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[591.127504] Starting dynamic subtest: pipe-B-HDMI-A-3
[591.149118] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[591.158243] Starting dynamic subtest: pipe-C-HDMI-A-3
[591.181923] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[591.190770] Starting dynamic subtest: pipe-D-HDMI-A-3
[591.212886] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[591.214468] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.015s)
[591.374659] [070/133] (445s left) gem_ctx_shared (q-independent)
[591.469962] Starting subtest: Q-independent
[591.470984] Starting dynamic subtest: rcs0
[591.707950] Dynamic subtest rcs0: SUCCESS (0.237s)
[591.717209] Starting dynamic subtest: bcs0
[591.866501] Dynamic subtest bcs0: SUCCESS (0.157s)
[591.877268] Starting dynamic subtest: vcs0
[592.034684] Dynamic subtest vcs0: SUCCESS (0.167s)
[592.043900] Starting dynamic subtest: vcs1
[592.205367] Dynamic subtest vcs1: SUCCESS (0.169s)
[592.214433] Starting dynamic subtest: vecs0
[592.375920] Dynamic subtest vecs0: SUCCESS (0.169s)
[592.385182] Starting dynamic subtest: vecs1
[592.545236] Dynamic subtest vecs1: SUCCESS (0.168s)
[592.554563] Starting dynamic subtest: ccs0
[592.711146] Dynamic subtest ccs0: SUCCESS (0.165s)
[592.712128] Subtest Q-independent: SUCCESS (1.242s)
[593.038128] [071/133] (443s left) gem_mmap_offset (blt-coherency)
[593.125496] Starting subtest: blt-coherency
[593.159371] Subtest blt-coherency: SUCCESS (0.034s)
[593.315259] [072/133] (443s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[594.833126] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[594.833978] Starting dynamic subtest: pipe-A-HDMI-A-3
[594.842332] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[594.852061] Starting dynamic subtest: pipe-B-HDMI-A-3
[594.860903] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[594.870194] Starting dynamic subtest: pipe-C-HDMI-A-3
[594.878851] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[594.887876] Starting dynamic subtest: pipe-D-HDMI-A-3
[594.898569] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[594.900570] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[595.104520] [073/133] (441s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[596.617171] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[596.618085] Starting dynamic subtest: pipe-A-HDMI-A-3
[596.626533] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[596.636051] Starting dynamic subtest: pipe-B-HDMI-A-3
[596.644814] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[596.654109] Starting dynamic subtest: pipe-C-HDMI-A-3
[596.662586] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[596.671465] Starting dynamic subtest: pipe-D-HDMI-A-3
[596.683353] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[596.685568] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[596.907250] [074/133] (439s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[598.424205] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[598.425097] Starting dynamic subtest: pipe-A-HDMI-A-3
[598.428596] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[598.438103] Starting dynamic subtest: pipe-B-HDMI-A-3
[598.441779] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[598.450942] Starting dynamic subtest: pipe-C-HDMI-A-3
[598.454293] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[598.463374] Starting dynamic subtest: pipe-D-HDMI-A-3
[598.466929] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[598.468611] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[598.700888] [075/133] (438s left) kms_flip (flip-vs-panning-vs-hang)
[600.217288] Starting subtest: flip-vs-panning-vs-hang
[600.220665] Starting dynamic subtest: A-HDMI-A3
[651.544863] Dynamic subtest A-HDMI-A3: SUCCESS (51.323s)
[651.555637] Starting dynamic subtest: D-HDMI-A3
[701.500571] Dynamic subtest D-HDMI-A3: SUCCESS (49.953s)
[701.501485] Subtest flip-vs-panning-vs-hang: SUCCESS (101.282s)
[701.704368] [076/133] (335s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[703.221048] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[703.222842] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[703.379954] [077/133] (333s left) kms_hdr (invalid-metadata-sizes)
[704.927221] Starting subtest: invalid-metadata-sizes
[704.929994] Subtest invalid-metadata-sizes: SKIP (0.000s)
[705.036141] [078/133] (331s left) kms_async_flips (invalid-async-flip)
[706.571322] Starting subtest: invalid-async-flip
[706.801302] Starting dynamic subtest: pipe-A-HDMI-A-3
[707.158052] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.357s)
[707.327047] Starting dynamic subtest: pipe-B-HDMI-A-3
[707.426116] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.108s)
[707.591367] Starting dynamic subtest: pipe-C-HDMI-A-3
[707.700297] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.117s)
[707.861990] Starting dynamic subtest: pipe-D-HDMI-A-3
[707.963135] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.109s)
[707.964053] Subtest invalid-async-flip: SUCCESS (1.393s)
[708.266391] [079/133] (328s left) kms_rotation_crc (primary-rotation-90)
[709.783147] Starting subtest: primary-rotation-90
[709.784927] Subtest primary-rotation-90: SKIP (0.001s)
[709.878614] [080/133] (327s left) kms_cursor_edge_walk (256x256-top-edge)
[711.412961] Starting subtest: 256x256-top-edge
[711.413847] Starting dynamic subtest: pipe-A-HDMI-A-3
[714.770571] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.356s)
[714.781290] Starting dynamic subtest: pipe-D-HDMI-A-3
[718.010343] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.238s)
[718.011256] Subtest 256x256-top-edge: SUCCESS (6.598s)
[718.180983] [081/133] (319s left) gem_exec_flush (basic-wb-ro-default)
[718.271374] Subtest basic-wb-ro-default: SKIP (0.000s)
[718.351726] [082/133] (318s left) kms_psr (psr2-basic)
[719.868447] Subtest psr2-basic: SKIP (0.000s)
[719.934168] [083/133] (317s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[721.452220] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[721.453133] Starting dynamic subtest: pipe-A-valid-mode
[722.391019] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.937s)
[722.391997] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.939s)
[722.664711] [084/133] (314s left) gem_workarounds (suspend-resume-fd)
[722.763473] Starting subtest: suspend-resume-fd
[742.210749] Subtest suspend-resume-fd: SUCCESS (3.957s)
[753.379889] [085/133] (295s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[754.952696] Starting subtest: y-tiled-8bpp-rotate-90
[754.954626] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[755.122926] [086/133] (293s left) kms_pipe_crc_basic (bad-source)
[756.693452] Starting subtest: bad-source
[756.694391] Subtest bad-source: SUCCESS (0.000s)
[756.786251] [087/133] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[758.351295] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[758.352959] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[758.523592] [088/133] (290s left) gem_lmem_swapping (verify-random-ccs)
[763.092045] Starting subtest: verify-random-ccs
[763.092967] Starting dynamic subtest: lmem0
[767.447021] Dynamic subtest lmem0: SUCCESS (4.324s)
[767.448047] Subtest verify-random-ccs: SUCCESS (4.326s)
[768.433111] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[768.434063] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[768.436579] [089/133] (280s left) kms_flip (wf_vblank-ts-check-interruptible)
[773.479330] Starting subtest: wf_vblank-ts-check-interruptible
[773.484502] Starting dynamic subtest: A-HDMI-A3
[781.540234] Dynamic subtest A-HDMI-A3: SUCCESS (8.040s)
[781.554823] Starting dynamic subtest: B-HDMI-A3
[789.498173] Dynamic subtest B-HDMI-A3: SUCCESS (7.949s)
[789.511814] Starting dynamic subtest: C-HDMI-A3
[797.453500] Dynamic subtest C-HDMI-A3: SUCCESS (7.953s)
[797.466054] Starting dynamic subtest: D-HDMI-A3
[805.409883] Dynamic subtest D-HDMI-A3: SUCCESS (7.953s)
[805.410698] Subtest wf_vblank-ts-check-interruptible: SUCCESS (31.910s)
[805.667164] [FACT kms_flip (wf_vblank-ts-check-interruptible)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[805.669775] [FACT kms_flip (wf_vblank-ts-check-interruptible)] new: kernel.kmod_is_loaded.i915: true
[805.672508] [090/133] (243s left) gem_partial_pwrite_pread (writes-after-reads)
[805.765435] Subtest writes-after-reads: SKIP (0.000s)
[805.848020] [091/133] (243s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[807.364115] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[807.365902] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[807.528710] [092/133] (241s left) gem_exec_params (invalid-batch-start-offset)
[807.634443] Starting subtest: invalid-batch-start-offset
[807.638365] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[807.814637] [093/133] (241s left) gem_lmem_swapping (basic)
[812.306046] Starting subtest: basic
[812.307036] Starting dynamic subtest: lmem0
[832.784440] Dynamic subtest lmem0: SUCCESS (20.470s)
[832.785439] Subtest basic: SUCCESS (20.471s)
[834.778423] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[834.779392] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[834.781777] [094/133] (214s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[839.786273] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[839.788031] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[839.996497] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[840.000708] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[840.004559] [095/133] (209s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[841.538486] Starting subtest: 4-tiled-64bpp-rotate-180
[843.421943] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.883s)
[843.579889] [096/133] (205s left) kms_sequence (queue-busy)
[845.095742] Starting subtest: queue-busy
[845.098360] Starting dynamic subtest: pipe-A-HDMI-A-3
[847.665258] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.566s)
[847.675957] Starting dynamic subtest: pipe-B-HDMI-A-3
[850.066164] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.399s)
[850.078337] Starting dynamic subtest: pipe-C-HDMI-A-3
[852.469022] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.402s)
[852.480798] Starting dynamic subtest: pipe-D-HDMI-A-3
[854.891464] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.422s)
[854.892341] Subtest queue-busy: SUCCESS (9.797s)
[855.139496] [097/133] (194s left) gem_pread (uncached)
[855.220225] Subtest uncached: SKIP (0.000s)
[855.297986] [098/133] (194s left) kms_cursor_legacy (single-move)
[856.814239] Starting subtest: single-move
[856.815237] Starting dynamic subtest: pipe-A
[862.195203] Dynamic subtest pipe-A: SUCCESS (5.382s)
[862.205838] Starting dynamic subtest: pipe-B
[867.574563] Dynamic subtest pipe-B: SUCCESS (5.379s)
[867.585267] Starting dynamic subtest: pipe-C
[872.954581] Dynamic subtest pipe-C: SUCCESS (5.380s)
[872.964924] Starting dynamic subtest: pipe-D
[878.334561] Dynamic subtest pipe-D: SUCCESS (5.379s)
[878.345365] Starting dynamic subtest: all-pipes
[883.716044] Dynamic subtest all-pipes: SUCCESS (5.380s)
[883.717234] Subtest single-move: SUCCESS (26.906s)
[883.814452] [099/133] (165s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[885.342672] Starting subtest: psr-rgb565-draw-mmap-cpu
[885.346732] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[885.464839] [100/133] (164s left) api_intel_bb (object-noreloc-purge-cache-simple)
[885.569602] Starting subtest: object-noreloc-purge-cache-simple
[885.603039] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.033s)
[885.764218] [101/133] (163s left) kms_scaling_modes (scaling-mode-center)
[887.280214] Starting subtest: scaling-mode-center
[887.285217] Subtest scaling-mode-center: SKIP (0.001s)
[887.387380] [102/133] (162s left) gem_busy (extended)
[887.671027] Starting subtest: extended
[887.672017] Starting dynamic subtest: rcs0
[887.762841] Dynamic subtest rcs0: SUCCESS (0.091s)
[887.783227] Starting dynamic subtest: bcs0
[887.806556] Dynamic subtest bcs0: SUCCESS (0.042s)
[887.834219] Starting dynamic subtest: vcs0
[887.855657] Dynamic subtest vcs0: SUCCESS (0.047s)
[887.874521] Starting dynamic subtest: vcs1
[887.900636] Dynamic subtest vcs1: SUCCESS (0.043s)
[887.921860] Starting dynamic subtest: vecs0
[887.947066] Dynamic subtest vecs0: SUCCESS (0.044s)
[887.971562] Starting dynamic subtest: vecs1
[887.993882] Dynamic subtest vecs1: SUCCESS (0.044s)
[888.014220] Starting dynamic subtest: ccs0
[888.037536] Dynamic subtest ccs0: SUCCESS (0.042s)
[888.038576] Subtest extended: SUCCESS (0.367s)
[888.343137] [103/133] (161s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[889.925499] Starting subtest: dp-mst-lic-type-0-hdcp14
[889.928285] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[890.114983] [104/133] (159s left) gem_exec_nop (basic-parallel)
[890.206628] Starting subtest: basic-parallel
[894.590737] Subtest basic-parallel: SUCCESS (4.384s)
[894.876003] [105/133] (155s left) kms_cursor_crc (cursor-offscreen-256x85)
[896.655291] Starting subtest: cursor-offscreen-256x85
[896.660387] Starting dynamic subtest: pipe-A-HDMI-A-3
[899.145416] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.483s)
[899.190066] Starting dynamic subtest: pipe-D-HDMI-A-3
[901.586272] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.406s)
[901.587300] Subtest cursor-offscreen-256x85: SUCCESS (4.930s)
[901.845421] [106/133] (148s left) kms_chamelium_frames (hdmi-frame-dump)
[903.412329] Subtest hdmi-frame-dump: SKIP (0.000s)
[903.521985] [107/133] (146s left) kms_vblank (wait-forked-busy-hang)
[905.051107] Starting subtest: wait-forked-busy-hang
[905.051984] Starting dynamic subtest: pipe-A-HDMI-A-3
[933.031011] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (27.973s)
[933.044761] Starting dynamic subtest: pipe-D-HDMI-A-3
[958.030252] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.988s)
[958.031230] Subtest wait-forked-busy-hang: SUCCESS (52.968s)
[958.205646] [108/133] ( 91s left) gem_exec_balancer (nohangcheck)
[958.567478] Starting subtest: nohangcheck
[960.214964] Subtest nohangcheck: SUCCESS (1.647s)
[960.428706] [109/133] ( 89s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[961.953251] Starting subtest: cursorA-vs-flipB-toggle
[961.955065] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[962.056003] [110/133] ( 88s left) gem_exec_params (rsvd2-dirt)
[962.158817] Starting subtest: rsvd2-dirt
[962.160620] Subtest rsvd2-dirt: SKIP (0.000s)
[962.357946] [111/133] ( 88s left) i915_drm_fdinfo (busy-check-all)
[962.430490] Starting subtest: busy-check-all
[962.431409] Starting dynamic subtest: rcs0
[962.461432] Dynamic subtest rcs0: SKIP (0.030s)
[962.472542] Starting dynamic subtest: bcs0
[962.474468] Dynamic subtest bcs0: SKIP (0.001s)
[962.485125] Starting dynamic subtest: vcs0
[962.487293] Dynamic subtest vcs0: SKIP (0.000s)
[962.497946] Starting dynamic subtest: vcs1
[962.499653] Dynamic subtest vcs1: SKIP (0.001s)
[962.510512] Starting dynamic subtest: vecs0
[962.512814] Dynamic subtest vecs0: SKIP (0.000s)
[962.524307] Starting dynamic subtest: vecs1
[962.526464] Dynamic subtest vecs1: SKIP (0.000s)
[962.536590] Starting dynamic subtest: ccs0
[962.538890] Dynamic subtest ccs0: SKIP (0.000s)
[962.541142] Subtest busy-check-all: SKIP (0.040s)
[962.589077] [112/133] ( 87s left) gem_mmap_wc (copy)
[962.691601] Subtest copy: SKIP (0.000s)
[962.790849] [113/133] ( 87s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[964.306252] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[964.307210] Starting dynamic subtest: pipe-A
[964.400423] Dynamic subtest pipe-A: SUCCESS (0.095s)
[964.416431] Starting dynamic subtest: pipe-B
[964.545902] Dynamic subtest pipe-B: SUCCESS (0.144s)
[964.563994] Starting dynamic subtest: pipe-C
[964.689269] Dynamic subtest pipe-C: SUCCESS (0.142s)
[964.701380] Starting dynamic subtest: pipe-D
[964.831186] Dynamic subtest pipe-D: SUCCESS (0.141s)
[964.832086] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.527s)
[965.047622] [114/133] ( 85s left) gem_ctx_param (invalid-get-engines)
[965.127829] Starting subtest: invalid-get-engines
[965.130239] Subtest invalid-get-engines: SUCCESS (0.001s)
[965.276175] [115/133] ( 85s left) gem_mmap_wc (read)
[965.353324] Subtest read: SKIP (0.000s)
[965.418412] [116/133] ( 85s left) gem_userptr_blits (mmap-offset-banned)
[965.511540] Starting subtest: mmap-offset-banned
[965.512498] Starting dynamic subtest: fixed
[965.513407] Dynamic subtest fixed: SUCCESS (0.000s)
[965.514318] Subtest mmap-offset-banned: SUCCESS (0.001s)
[965.701804] [117/133] ( 85s left) gem_fence_thrash (bo-write-verify-x)
[965.750973] Starting subtest: bo-write-verify-x
[965.786258] Subtest bo-write-verify-x: SKIP (0.036s)
[965.851452] [118/133] ( 85s left) drm_read (fault-buffer)
[967.439717] Starting subtest: fault-buffer
[967.440597] Subtest fault-buffer: SUCCESS (0.001s)
[967.656114] [119/133] ( 83s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[969.215260] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[969.321212] [120/133] ( 81s left) gem_userptr_blits (unsync-overlap)
[969.415637] Subtest unsync-overlap: SKIP (0.000s)
[969.630620] [121/133] ( 81s left) kms_big_fb (linear-64bpp-rotate-90)
[971.159321] Starting subtest: linear-64bpp-rotate-90
[971.220602] Subtest linear-64bpp-rotate-90: SKIP (0.060s)
[971.429437] [122/133] ( 79s left) syncobj_wait (wait-all-for-submit-complex)
[971.511487] Starting subtest: wait-all-for-submit-complex
[971.731393] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[971.872290] [123/133] ( 79s left) api_intel_allocator (execbuf-with-allocator)
[971.950624] Starting subtest: execbuf-with-allocator
[971.982321] Subtest execbuf-with-allocator: SUCCESS (0.032s)
[972.155886] [124/133] ( 79s left) gem_flink_race (flink_close)
[972.205004] Starting subtest: flink_close
[977.297389] Subtest flink_close: SUCCESS (5.090s)
[977.469698] [125/133] ( 73s left) gem_ctx_persistence (legacy-engines-mixed)
[977.558418] Starting subtest: legacy-engines-mixed
[977.559463] Starting dynamic subtest: render
[977.672440] Dynamic subtest render: SUCCESS (0.113s)
[977.689422] Starting dynamic subtest: bsd1
[977.726802] Dynamic subtest bsd1: SUCCESS (0.052s)
[977.759522] Starting dynamic subtest: bsd2
[977.793305] Dynamic subtest bsd2: SUCCESS (0.064s)
[977.809748] Starting dynamic subtest: blt
[977.852609] Dynamic subtest blt: SUCCESS (0.057s)
[977.874485] Starting dynamic subtest: vebox
[977.911995] Dynamic subtest vebox: SUCCESS (0.057s)
[977.916716] Subtest legacy-engines-mixed: SUCCESS (0.355s)
[978.098141] [126/133] ( 73s left) gem_cs_tlb (engines)
[978.184844] Starting subtest: engines
[978.185721] Starting dynamic subtest: rcs0
[980.339527] Dynamic subtest rcs0: SUCCESS (2.154s)
[980.350647] Starting dynamic subtest: bcs0
[982.492634] Dynamic subtest bcs0: SUCCESS (2.153s)
[982.503386] Starting dynamic subtest: vcs0
[984.645239] Dynamic subtest vcs0: SUCCESS (2.152s)
[984.656218] Starting dynamic subtest: vcs1
[986.798376] Dynamic subtest vcs1: SUCCESS (2.153s)
[986.809417] Starting dynamic subtest: vecs0
[988.951324] Dynamic subtest vecs0: SUCCESS (2.152s)
[988.962432] Starting dynamic subtest: vecs1
[991.104726] Dynamic subtest vecs1: SUCCESS (2.153s)
[991.115699] Starting dynamic subtest: ccs0
[993.257770] Dynamic subtest ccs0: SUCCESS (2.152s)
[993.258656] Subtest engines: SUCCESS (15.077s)
[993.428900] [127/133] ( 58s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[994.949278] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[994.951106] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[995.174012] [128/133] ( 56s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[996.689271] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[996.691052] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[996.787253] [129/133] ( 54s left) sw_sync (alloc_fence_invalid_timeline)
[996.845713] Starting subtest: alloc_fence_invalid_timeline
[996.846661] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[996.928367] [130/133] ( 54s left) vgem_basic (dmabuf-fence-before)
[996.984233] Starting subtest: dmabuf-fence-before
[996.985152] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[997.067668] [131/133] ( 54s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[997.147637] Starting subtest: etime-multi-wait-for-submit-submitted
[997.255723] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[997.428047] [132/133] ( 54s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[997.509515] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[997.510400] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[997.679166] [133/133] ( 54s left) gem_exec_whisper (basic-forked)
[997.767450] Starting subtest: basic-forked
[1002.138512] Subtest basic-forked: SUCCESS (4.371s)
[1002.397047] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_color
results: parsing output: 8/ for test: i915_pm_freq_api
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_force_connector_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_feature_discovery
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_partial_pwrite_pread
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_pipe_crc_basic
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_chamelium_color
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_pwrite
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: i915_selftest
results: parsing output: 54/ for test: sysfs_preempt_timeout
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_ctx_shared
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_sequence
results: parsing output: 96/ for test: gem_pread
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: gem_busy
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_exec_nop
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: i915_drm_fdinfo
results: parsing output: 111/ for test: gem_mmap_wc
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: gem_fence_thrash
results: parsing output: 117/ for test: drm_read
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: gem_flink_race
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: gem_cs_tlb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_exec_whisper
Done.