[59.135241] Initializing watchdogs [59.135362] /dev/watchdog0 [59.153716] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [59.163368] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [59.166763] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.169409] [001/130] (960s left) kms_draw_crc (draw-method-pwrite) [59.472444] Starting subtest: draw-method-pwrite [59.473305] Starting dynamic subtest: xrgb8888-untiled [59.911526] Dynamic subtest xrgb8888-untiled: SUCCESS (0.439s) [59.919639] Starting dynamic subtest: rgb565-untiled [60.331217] Dynamic subtest rgb565-untiled: SUCCESS (0.416s) [60.345272] Starting dynamic subtest: xrgb2101010-untiled [60.729745] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.400s) [60.757800] Starting dynamic subtest: xbgr16161616f-untiled [61.178332] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.449s) [61.186607] Starting dynamic subtest: xrgb8888-xtiled [61.731872] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.552s) [61.760997] Starting dynamic subtest: rgb565-xtiled [62.347223] Dynamic subtest rgb565-xtiled: SUCCESS (0.615s) [62.356826] Starting dynamic subtest: xrgb2101010-xtiled [62.878975] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.532s) [62.886988] Starting dynamic subtest: xbgr16161616f-xtiled [63.513659] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.633s) [63.523159] Starting dynamic subtest: xrgb8888-4tiled [63.946487] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.433s) [63.955396] Starting dynamic subtest: rgb565-4tiled [64.279972] Dynamic subtest rgb565-4tiled: SUCCESS (0.333s) [64.308238] Starting dynamic subtest: xrgb2101010-4tiled [64.730493] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.450s) [64.755959] Starting dynamic subtest: xbgr16161616f-4tiled [65.397943] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.666s) [65.400042] Subtest draw-method-pwrite: SUCCESS (5.924s) [65.578534] [002/130] (954s left) kms_frontbuffer_tracking (fbc-stridechange) [65.782579] Starting subtest: fbc-stridechange [68.331102] Subtest fbc-stridechange: SUCCESS (2.549s) [68.542409] [003/130] (951s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [68.628472] Starting subtest: x-tiled-to-vebox-y-tiled [68.630403] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [68.893256] [004/130] (951s left) kms_psr (fbc-pr-sprite-blt) [69.093850] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [69.147600] [005/130] (950s left) gem_ctx_persistence (smoketest) [69.232758] Starting subtest: smoketest [107.959602] Subtest smoketest: SUCCESS (38.724s) [108.099602] [006/130] (911s left) kms_psr (fbc-psr-primary-mmap-gtt) [108.303218] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [108.351678] [007/130] (911s left) kms_color (deep-color) [108.551542] Starting subtest: deep-color [111.893202] Starting dynamic subtest: pipe-A-DP-4-gamma [117.481216] Dynamic subtest pipe-A-DP-4-gamma: SUCCESS (5.588s) [117.490055] Starting dynamic subtest: pipe-A-DP-4-degamma [123.312446] Dynamic subtest pipe-A-DP-4-degamma: SUCCESS (5.831s) [123.320332] Starting dynamic subtest: pipe-A-DP-4-ctm [129.161071] Dynamic subtest pipe-A-DP-4-ctm: SUCCESS (5.848s) [132.439744] Starting dynamic subtest: pipe-B-DP-4-gamma [138.304335] Dynamic subtest pipe-B-DP-4-gamma: SUCCESS (5.874s) [138.314543] Starting dynamic subtest: pipe-B-DP-4-degamma [144.088604] Dynamic subtest pipe-B-DP-4-degamma: SUCCESS (5.784s) [144.096385] Starting dynamic subtest: pipe-B-DP-4-ctm [149.904886] Dynamic subtest pipe-B-DP-4-ctm: SUCCESS (5.816s) [153.154544] Starting dynamic subtest: pipe-C-DP-4-gamma [158.983171] Dynamic subtest pipe-C-DP-4-gamma: SUCCESS (5.838s) [158.992130] Starting dynamic subtest: pipe-C-DP-4-degamma [164.805492] Dynamic subtest pipe-C-DP-4-degamma: SUCCESS (5.822s) [164.814221] Starting dynamic subtest: pipe-C-DP-4-ctm [170.630473] Dynamic subtest pipe-C-DP-4-ctm: SUCCESS (5.824s) [173.888614] Starting dynamic subtest: pipe-D-DP-4-gamma [179.734423] Dynamic subtest pipe-D-DP-4-gamma: SUCCESS (5.855s) [179.742622] Starting dynamic subtest: pipe-D-DP-4-degamma [185.557914] Dynamic subtest pipe-D-DP-4-degamma: SUCCESS (5.823s) [185.567194] Starting dynamic subtest: pipe-D-DP-4-ctm [191.384568] Dynamic subtest pipe-D-DP-4-ctm: SUCCESS (5.826s) [191.385526] Subtest deep-color: SUCCESS (82.835s) [191.645875] [008/130] (828s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [191.847181] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [191.848163] Starting dynamic subtest: pipe-A-valid-mode [191.922064] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s) [191.924076] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.075s) [192.131262] [009/130] (828s left) gem_exec_params (invalid-fence-in) [192.206454] Starting subtest: invalid-fence-in [192.207440] Subtest invalid-fence-in: SUCCESS (0.000s) [192.367382] [010/130] (827s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [192.574949] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [192.576743] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [192.703395] [011/130] (827s left) kms_cursor_legacy (forked-bo) [192.904991] Starting subtest: forked-bo [192.905918] Starting dynamic subtest: pipe-A [198.325730] Dynamic subtest pipe-A: SUCCESS (5.419s) [198.338383] Starting dynamic subtest: pipe-B [203.761986] Dynamic subtest pipe-B: SUCCESS (5.436s) [203.777753] Starting dynamic subtest: pipe-C [209.200429] Dynamic subtest pipe-C: SUCCESS (5.437s) [209.218343] Starting dynamic subtest: pipe-D [214.647876] Dynamic subtest pipe-D: SUCCESS (5.446s) [214.664071] Starting dynamic subtest: all-pipes [220.080748] Dynamic subtest all-pipes: SUCCESS (5.432s) [220.081615] Subtest forked-bo: SUCCESS (27.176s) [220.195648] [012/130] (800s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [220.395936] Starting subtest: psr-indfb-scaledprimary [220.397703] Subtest psr-indfb-scaledprimary: SKIP (0.000s) [220.520575] [013/130] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [220.726920] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [220.728684] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [220.823315] [014/130] (799s left) drm_fdinfo (virtual-busy-hang-all) [220.887628] Starting subtest: virtual-busy-hang-all [220.889449] Subtest virtual-busy-hang-all: SKIP (0.000s) [220.979906] [015/130] (799s left) kms_plane_cursor (viewport) [221.177220] Starting subtest: viewport [221.179030] Starting dynamic subtest: pipe-A-DP-4-size-64 [224.676995] Dynamic subtest pipe-A-DP-4-size-64: SUCCESS (3.499s) [224.752552] Starting dynamic subtest: pipe-A-DP-4-size-128 [228.243528] Dynamic subtest pipe-A-DP-4-size-128: SUCCESS (3.500s) [228.319762] Starting dynamic subtest: pipe-A-DP-4-size-256 [231.810435] Dynamic subtest pipe-A-DP-4-size-256: SUCCESS (3.499s) [231.953872] Starting dynamic subtest: pipe-B-DP-4-size-64 [235.569388] Dynamic subtest pipe-B-DP-4-size-64: SUCCESS (3.628s) [235.631742] Starting dynamic subtest: pipe-B-DP-4-size-128 [239.102613] Dynamic subtest pipe-B-DP-4-size-128: SUCCESS (3.483s) [239.162080] Starting dynamic subtest: pipe-B-DP-4-size-256 [242.636281] Dynamic subtest pipe-B-DP-4-size-256: SUCCESS (3.483s) [242.757579] Starting dynamic subtest: pipe-C-DP-4-size-64 [246.314283] Dynamic subtest pipe-C-DP-4-size-64: SUCCESS (3.566s) [246.400958] Starting dynamic subtest: pipe-C-DP-4-size-128 [249.864904] Dynamic subtest pipe-C-DP-4-size-128: SUCCESS (3.499s) [249.925600] Starting dynamic subtest: pipe-C-DP-4-size-256 [253.348767] Dynamic subtest pipe-C-DP-4-size-256: SUCCESS (3.432s) [253.469023] Starting dynamic subtest: pipe-D-DP-4-size-64 [256.975398] Dynamic subtest pipe-D-DP-4-size-64: SUCCESS (3.516s) [257.052955] Starting dynamic subtest: pipe-D-DP-4-size-128 [260.492385] Dynamic subtest pipe-D-DP-4-size-128: SUCCESS (3.465s) [260.553681] Starting dynamic subtest: pipe-D-DP-4-size-256 [264.042754] Dynamic subtest pipe-D-DP-4-size-256: SUCCESS (3.498s) [264.151839] Subtest viewport: SUCCESS (42.972s) [264.436439] [016/130] (756s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [264.646404] Starting subtest: bad-rotation-90-yf-tiled-ccs [264.647310] Starting dynamic subtest: pipe-A-DP-4 [264.656032] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [264.663543] Starting dynamic subtest: pipe-B-DP-4 [264.672288] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [264.679752] Starting dynamic subtest: pipe-C-DP-4 [264.688265] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [264.695567] Starting dynamic subtest: pipe-D-DP-4 [264.704245] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [264.705999] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.006s) [265.091701] [017/130] (755s left) kms_pm_backlight (fade-with-dpms) [265.289174] Subtest fade-with-dpms: SKIP (0.000s) [265.345204] [018/130] (755s left) gem_set_tiling_vs_blt (tiled-to-untiled) [265.421678] Subtest tiled-to-untiled: SKIP (0.000s) [265.499738] [019/130] (755s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [265.701491] Starting subtest: basic-flip-before-cursor-varying-size [266.731246] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.029s) [267.017019] [020/130] (753s left) gem_softpin (evict-prime-sanity-check) [267.097909] Starting subtest: evict-prime-sanity-check [267.098921] Starting dynamic subtest: rcs0 [268.264529] Dynamic subtest rcs0: SUCCESS (1.166s) [268.272869] Starting dynamic subtest: bcs0 [269.380427] Dynamic subtest bcs0: SUCCESS (1.115s) [269.388477] Starting dynamic subtest: vcs0 [270.499397] Dynamic subtest vcs0: SUCCESS (1.118s) [270.507848] Starting dynamic subtest: vcs1 [271.620417] Dynamic subtest vcs1: SUCCESS (1.120s) [271.629304] Starting dynamic subtest: vecs0 [272.734401] Dynamic subtest vecs0: SUCCESS (1.113s) [272.742322] Starting dynamic subtest: vecs1 [273.825532] Dynamic subtest vecs1: SUCCESS (1.090s) [273.833504] Starting dynamic subtest: ccs0 [274.974519] Dynamic subtest ccs0: SUCCESS (1.148s) [274.983849] Starting dynamic subtest: all [276.104395] Dynamic subtest all: SUCCESS (1.129s) [276.105582] Subtest evict-prime-sanity-check: SUCCESS (9.007s) [276.255480] [021/130] (744s left) gem_userptr_blits (sync-unmap-after-close) [276.338528] Starting subtest: sync-unmap-after-close [276.356215] Subtest sync-unmap-after-close: SUCCESS (0.018s) [276.550938] [022/130] (744s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [276.623310] Subtest invalidate-primary-flip-overlay: SKIP (0.000s) [276.684891] [023/130] (744s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [276.890431] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [279.611289] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.721s) [279.795696] [024/130] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [279.999577] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [280.001353] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [280.115394] [025/130] (741s left) gem_mmap_wc (fault-concurrent) [280.187934] Subtest fault-concurrent: SKIP (0.000s) [280.250909] [026/130] (740s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [280.456266] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [280.458037] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [280.592514] [027/130] (740s left) gem_mmap (short-mmap) [280.664577] Subtest short-mmap: SKIP (0.000s) [280.732721] [028/130] (740s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [280.804966] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [280.805915] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [280.908633] [029/130] (740s left) gen9_exec_parse (batch-zero-length) [280.999901] Subtest batch-zero-length: SKIP (0.000s) [281.102906] [030/130] (740s left) kms_psr (psr2-primary-page-flip) [281.303221] Subtest psr2-primary-page-flip: SKIP (0.000s) [281.366383] [031/130] (740s left) gem_exec_schedule (preemptive-hang) [281.583262] Starting subtest: preemptive-hang [281.584552] Starting dynamic subtest: rcs0 [291.155225] Dynamic subtest rcs0: SUCCESS (9.582s) [291.163198] Starting dynamic subtest: bcs0 [300.173360] Dynamic subtest bcs0: SUCCESS (9.017s) [300.181576] Starting dynamic subtest: vcs0 [309.149880] Dynamic subtest vcs0: SUCCESS (8.975s) [309.158173] Starting dynamic subtest: vcs1 [318.175801] Dynamic subtest vcs1: SUCCESS (9.024s) [318.183970] Starting dynamic subtest: vecs0 [327.195734] Dynamic subtest vecs0: SUCCESS (9.019s) [327.203901] Starting dynamic subtest: vecs1 [336.151078] Dynamic subtest vecs1: SUCCESS (8.953s) [336.159276] Starting dynamic subtest: ccs0 [345.164574] Dynamic subtest ccs0: SUCCESS (9.013s) [345.165494] Subtest preemptive-hang: SUCCESS (63.591s) [345.460101] [032/130] (676s left) kms_psr2_su (frontbuffer-xrgb8888) [345.534140] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [345.616364] [033/130] (676s left) kms_big_fb (4-tiled-8bpp-rotate-180) [345.829955] Starting subtest: 4-tiled-8bpp-rotate-180 [347.299238] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.468s) [347.447814] [034/130] (674s left) gem_tiled_pread_basic [347.583318] [035/130] (674s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [347.781510] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [347.782419] Starting dynamic subtest: pipe-A-DP-4 [347.804510] Dynamic subtest pipe-A-DP-4: SKIP (0.002s) [347.812590] Starting dynamic subtest: pipe-B-DP-4 [347.835024] Dynamic subtest pipe-B-DP-4: SKIP (0.002s) [347.843206] Starting dynamic subtest: pipe-C-DP-4 [347.868964] Dynamic subtest pipe-C-DP-4: SKIP (0.002s) [347.876812] Starting dynamic subtest: pipe-D-DP-4 [347.897647] Dynamic subtest pipe-D-DP-4: SKIP (0.002s) [347.899115] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s) [348.270404] [036/130] (673s left) sriov_basic (enable-vfs-autoprobe-on) [348.345439] Subtest enable-vfs-autoprobe-on: SKIP (0.000s) [348.424080] [037/130] (673s left) kms_cursor_crc (cursor-size-hints) [348.665282] Starting subtest: cursor-size-hints [348.667448] Starting dynamic subtest: pipe-A-DP-4 [349.193910] Dynamic subtest pipe-A-DP-4: SUCCESS (0.527s) [349.203486] Starting dynamic subtest: pipe-D-DP-4 [349.674494] Dynamic subtest pipe-D-DP-4: SUCCESS (0.479s) [349.675467] Subtest cursor-size-hints: SUCCESS (1.010s) [350.165342] [038/130] (671s left) gem_mmap_offset (basic-uaf) [350.236409] Starting subtest: basic-uaf [350.237327] Subtest basic-uaf: SUCCESS (0.000s) [350.333941] [039/130] (671s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [350.409376] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [350.511517] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [350.631954] [040/130] (671s left) gem_pxp (create-valid-protected-context) [353.235505] Starting subtest: create-valid-protected-context [353.237548] Subtest create-valid-protected-context: SKIP (0.000s) [353.330289] [041/130] (668s left) gem_exec_reloc (basic-write-wc-active) [353.412414] Subtest basic-write-wc-active: SKIP (0.000s) [353.525300] [042/130] (668s left) gem_exec_reloc (basic-gtt-cpu-active) [353.603308] Subtest basic-gtt-cpu-active: SKIP (0.000s) [353.675600] [043/130] (668s left) gem_workarounds (reset-context) [353.763534] Starting subtest: reset-context [353.993566] Subtest reset-context: SUCCESS (0.230s) [354.132055] [044/130] (668s left) kms_properties (get_properties-sanity-non-atomic) [354.330709] Starting subtest: get_properties-sanity-non-atomic [354.331926] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [354.438181] [045/130] (667s left) gem_exec_reloc (basic-write-cpu-noreloc) [354.515155] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [354.589944] [046/130] (667s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [354.789735] Starting subtest: sprite-rotation-90-pos-100-0 [354.791466] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [354.875864] [047/130] (667s left) gem_fenced_exec_thrash (too-many-fences) [354.955884] Subtest too-many-fences: SKIP (0.000s) [355.020382] [048/130] (667s left) gem_ctx_persistence (engines-cleanup) [355.097963] Starting subtest: engines-cleanup [355.098986] Starting dynamic subtest: rcs0 [355.222408] Dynamic subtest rcs0: SUCCESS (0.124s) [355.238812] Starting dynamic subtest: bcs0 [355.270635] Dynamic subtest bcs0: SUCCESS (0.046s) [355.283586] Starting dynamic subtest: vcs0 [355.294145] Dynamic subtest vcs0: SUCCESS (0.020s) [355.304346] Starting dynamic subtest: vcs1 [355.383526] Dynamic subtest vcs1: SUCCESS (0.087s) [355.396041] Starting dynamic subtest: vecs0 [355.432409] Dynamic subtest vecs0: SUCCESS (0.045s) [355.449072] Starting dynamic subtest: vecs1 [355.473662] Dynamic subtest vecs1: SUCCESS (0.039s) [355.508626] Starting dynamic subtest: ccs0 [355.527820] Dynamic subtest ccs0: SUCCESS (0.051s) [355.529295] Subtest engines-cleanup: SUCCESS (0.431s) [355.665706] [049/130] (666s left) kms_plane (plane-position-hole) [355.866597] Starting subtest: plane-position-hole [356.312176] Starting dynamic subtest: pipe-A-plane-1 [356.755977] Dynamic subtest pipe-A-plane-1: SUCCESS (0.444s) [356.766034] Starting dynamic subtest: pipe-A-plane-2 [357.209286] Dynamic subtest pipe-A-plane-2: SUCCESS (0.452s) [357.218370] Starting dynamic subtest: pipe-A-plane-3 [357.660969] Dynamic subtest pipe-A-plane-3: SUCCESS (0.451s) [357.670286] Starting dynamic subtest: pipe-A-plane-4 [358.099207] Dynamic subtest pipe-A-plane-4: SUCCESS (0.437s) [358.108267] Starting dynamic subtest: pipe-A-plane-5 [358.115902] Dynamic subtest pipe-A-plane-5: SUCCESS (0.016s) [358.475697] Starting dynamic subtest: pipe-B-plane-1 [358.889239] Dynamic subtest pipe-B-plane-1: SUCCESS (0.422s) [358.898526] Starting dynamic subtest: pipe-B-plane-2 [359.323183] Dynamic subtest pipe-B-plane-2: SUCCESS (0.433s) [359.332194] Starting dynamic subtest: pipe-B-plane-3 [359.756788] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s) [359.765408] Starting dynamic subtest: pipe-B-plane-4 [360.177999] Dynamic subtest pipe-B-plane-4: SUCCESS (0.420s) [360.187282] Starting dynamic subtest: pipe-B-plane-5 [360.196658] Dynamic subtest pipe-B-plane-5: SUCCESS (0.018s) [360.197553] Subtest plane-position-hole: SUCCESS (4.331s) [360.433969] [050/130] (662s left) kms_addfb_basic (basic-x-tiled-legacy) [360.508448] Starting subtest: basic-x-tiled-legacy [360.510240] Subtest basic-x-tiled-legacy: SKIP (0.000s) [360.756835] [051/130] (661s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [360.958264] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [360.960058] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [361.099912] [052/130] (661s left) perf_pmu (busy-idle-check-all) [361.163960] Starting subtest: busy-idle-check-all [361.164974] Starting dynamic subtest: rcs0 [361.865618] Dynamic subtest rcs0: SUCCESS (0.701s) [361.880155] Starting dynamic subtest: bcs0 [362.522960] Dynamic subtest bcs0: SUCCESS (0.655s) [362.538509] Starting dynamic subtest: vcs0 [363.181993] Dynamic subtest vcs0: SUCCESS (0.654s) [363.197507] Starting dynamic subtest: vcs1 [363.842951] Dynamic subtest vcs1: SUCCESS (0.656s) [363.858582] Starting dynamic subtest: vecs0 [364.501947] Dynamic subtest vecs0: SUCCESS (0.654s) [364.517819] Starting dynamic subtest: vecs1 [365.161114] Dynamic subtest vecs1: SUCCESS (0.654s) [365.176848] Starting dynamic subtest: ccs0 [365.821973] Dynamic subtest ccs0: SUCCESS (0.656s) [365.828677] Subtest busy-idle-check-all: SUCCESS (4.660s) [365.948626] [053/130] (656s left) gem_userptr_blits (vma-merge) [366.041404] Starting subtest: vma-merge [366.122938] Subtest vma-merge: SUCCESS (0.081s) [366.263963] [054/130] (656s left) gem_exec_gttfill (multigpu-basic) [366.461439] Starting subtest: multigpu-basic [381.223165] Subtest multigpu-basic: SUCCESS (14.761s) [381.294053] [055/130] (641s left) i915_pm_rps (min-max-config-loaded) [381.413500] Starting subtest: min-max-config-loaded [381.415282] Subtest min-max-config-loaded: SKIP (0.001s) [381.559473] [056/130] (641s left) api_intel_allocator (fork-simple-once) [381.633438] Starting subtest: fork-simple-once [381.669458] Subtest fork-simple-once: SUCCESS (0.036s) [381.840721] [057/130] (641s left) gem_exec_balancer (invalid-balancer) [381.924652] Starting subtest: invalid-balancer [383.194219] Subtest invalid-balancer: SUCCESS (1.269s) [383.560494] [058/130] (639s left) perf_pmu (init-wait) [383.626931] Starting subtest: init-wait [383.627929] Starting dynamic subtest: rcs0 [383.630248] Dynamic subtest rcs0: SUCCESS (0.002s) [383.639804] Starting dynamic subtest: bcs0 [383.640729] Dynamic subtest bcs0: SUCCESS (0.001s) [383.650409] Starting dynamic subtest: vcs0 [383.651442] Dynamic subtest vcs0: SUCCESS (0.000s) [383.661362] Starting dynamic subtest: vcs1 [383.662319] Dynamic subtest vcs1: SUCCESS (0.001s) [383.672180] Starting dynamic subtest: vecs0 [383.673405] Dynamic subtest vecs0: SUCCESS (0.000s) [383.682592] Starting dynamic subtest: vecs1 [383.683522] Dynamic subtest vecs1: SUCCESS (0.000s) [383.693470] Starting dynamic subtest: ccs0 [383.694581] Dynamic subtest ccs0: SUCCESS (0.000s) [383.695689] Subtest init-wait: SUCCESS (0.011s) [383.741435] [059/130] (639s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [383.959487] Starting subtest: extended-modeset-hang-oldfb-with-reset [383.960414] Starting dynamic subtest: pipe-A [394.680888] Dynamic subtest pipe-A: SUCCESS (10.719s) [394.698848] Starting dynamic subtest: pipe-D [405.383568] Dynamic subtest pipe-D: SUCCESS (10.698s) [405.387248] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.426s) [405.685226] [060/130] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [405.890910] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [405.892761] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [406.038225] [061/130] (617s left) gem_exec_schedule (manyslice) [406.132506] Starting subtest: manyslice [406.133502] Starting dynamic subtest: rcs0 [411.103410] Dynamic subtest rcs0: SUCCESS (4.970s) [411.114447] Starting dynamic subtest: bcs0 [416.075549] Dynamic subtest bcs0: SUCCESS (4.971s) [416.086126] Starting dynamic subtest: vcs0 [421.791033] Dynamic subtest vcs0: SUCCESS (5.713s) [421.810378] Starting dynamic subtest: vcs1 [426.986942] Dynamic subtest vcs1: SUCCESS (5.192s) [426.997560] Starting dynamic subtest: vecs0 [431.660953] Dynamic subtest vecs0: SUCCESS (4.673s) [431.673779] Starting dynamic subtest: vecs1 [436.858846] Dynamic subtest vecs1: SUCCESS (5.195s) [436.871520] Starting dynamic subtest: ccs0 [441.835032] Dynamic subtest ccs0: SUCCESS (4.974s) [441.836084] Subtest manyslice: SUCCESS (35.702s) [442.250610] [062/130] (580s left) gem_exec_params (invalid-ring) [442.328857] Starting subtest: invalid-ring [442.329851] Subtest invalid-ring: SUCCESS (0.000s) [442.502643] [063/130] (580s left) kms_vrr (max-min) [442.701988] Starting subtest: max-min [442.704842] Subtest max-min: SKIP (0.000s) [442.800787] [064/130] (580s left) gem_linear_blits (normal) [442.975816] Starting subtest: normal [451.207951] Subtest normal: SUCCESS (8.232s) [451.370188] [065/130] (572s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [451.612537] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [451.613457] Starting dynamic subtest: pipe-A-DP-4 [451.622159] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [451.632169] Starting dynamic subtest: pipe-B-DP-4 [451.640822] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [451.650760] Starting dynamic subtest: pipe-C-DP-4 [451.659226] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [451.669047] Starting dynamic subtest: pipe-D-DP-4 [451.677634] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [451.679313] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [452.037133] [066/130] (571s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [452.239590] Starting subtest: cursorB-vs-flipA-atomic-transitions [452.242750] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [452.339033] [067/130] (571s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [452.539652] Starting subtest: plane-downscale-factor-0-75-with-rotation [452.540448] Starting dynamic subtest: pipe-A [452.924847] Dynamic subtest pipe-A: SUCCESS (0.385s) [452.956995] Starting dynamic subtest: pipe-B [453.410613] Dynamic subtest pipe-B: SUCCESS (0.483s) [453.438372] Starting dynamic subtest: pipe-C [453.896604] Dynamic subtest pipe-C: SUCCESS (0.483s) [453.924560] Starting dynamic subtest: pipe-D [454.382281] Dynamic subtest pipe-D: SUCCESS (0.483s) [454.383360] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.844s) [454.718895] [068/130] (568s left) api_intel_bb (intel-bb-blit-none) [454.794432] Starting subtest: intel-bb-blit-none [455.486937] Subtest intel-bb-blit-none: SUCCESS (0.693s) [455.635091] [069/130] (568s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [455.841174] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [455.842994] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [455.962625] [070/130] (567s left) gem_exercise_blt (fast-copy) [456.043492] Starting subtest: fast-copy [456.044445] Starting dynamic subtest: linear-smem-smem [456.083594] Dynamic subtest linear-smem-smem: SUCCESS (0.040s) [456.094089] Starting dynamic subtest: linear-smem-lmem0 [456.099703] Dynamic subtest linear-smem-lmem0: SUCCESS (0.015s) [456.111543] Starting dynamic subtest: linear-lmem0-smem [456.210415] Dynamic subtest linear-lmem0-smem: SUCCESS (0.110s) [456.220315] Starting dynamic subtest: linear-lmem0-lmem0 [456.320982] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.109s) [456.331199] Starting dynamic subtest: xmajor-smem-smem [456.338217] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s) [456.349948] Starting dynamic subtest: xmajor-smem-lmem0 [456.353478] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.014s) [456.365168] Starting dynamic subtest: xmajor-lmem0-smem [456.464884] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.110s) [456.475119] Starting dynamic subtest: xmajor-lmem0-lmem0 [456.574722] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.109s) [456.586206] Starting dynamic subtest: tile4-smem-smem [456.590346] Dynamic subtest tile4-smem-smem: SUCCESS (0.015s) [456.601912] Starting dynamic subtest: tile4-smem-lmem0 [456.605656] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.014s) [456.617325] Starting dynamic subtest: tile4-lmem0-smem [456.717504] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.111s) [456.727584] Starting dynamic subtest: tile4-lmem0-lmem0 [456.829081] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.111s) [456.840819] Starting dynamic subtest: tile64-smem-smem [456.846294] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s) [456.857978] Starting dynamic subtest: tile64-smem-lmem0 [456.861596] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.014s) [456.873245] Starting dynamic subtest: tile64-lmem0-smem [456.973558] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.111s) [456.983832] Starting dynamic subtest: tile64-lmem0-lmem0 [457.082951] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.108s) [457.083913] Subtest fast-copy: SUCCESS (1.040s) [457.259782] [071/130] (566s left) kms_getfb (getfb2-into-addfb2) [457.332464] Starting subtest: getfb2-into-addfb2 [457.333430] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [457.504126] [072/130] (566s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs) [457.703669] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs [457.705461] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s) [457.983877] [073/130] (565s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [458.189077] Starting subtest: fbc-rgb565-draw-blt [463.117363] Subtest fbc-rgb565-draw-blt: SUCCESS (4.928s) [463.319693] [074/130] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [463.528427] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [463.530159] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [463.702602] [075/130] (560s left) gem_exec_balancer (waits) [463.785386] Starting subtest: waits [476.368090] Subtest waits: SUCCESS (12.582s) [476.757965] [076/130] (547s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [476.960426] Starting subtest: flip-vs-cursor-busy-crc-legacy [477.687173] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.726s) [477.964665] [077/130] (546s left) gem_mmap_gtt (cpuset-medium-copy) [478.045860] Subtest cpuset-medium-copy: SKIP (0.000s) [478.105601] [078/130] (546s left) kms_big_fb (linear-64bpp-rotate-270) [478.321328] Starting subtest: linear-64bpp-rotate-270 [478.384730] Subtest linear-64bpp-rotate-270: SKIP (0.063s) [478.598642] [079/130] (545s left) kms_content_protection (content-type-change) [478.852625] Starting subtest: content-type-change [479.432045] Subtest content-type-change: SKIP (0.577s) [479.813943] [080/130] (544s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [480.018363] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [480.023946] Starting dynamic subtest: A-DP4 [488.106252] Dynamic subtest A-DP4: SUCCESS (8.082s) [488.119145] Starting dynamic subtest: B-DP4 [496.118620] Dynamic subtest B-DP4: SUCCESS (8.010s) [496.130821] Starting dynamic subtest: C-DP4 [504.138723] Dynamic subtest C-DP4: SUCCESS (8.019s) [504.151254] Starting dynamic subtest: D-DP4 [512.149705] Dynamic subtest D-DP4: SUCCESS (8.009s) [512.150649] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.132s) [512.470491] [081/130] (512s left) kms_psr (psr-sprite-mmap-cpu) [512.671978] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [512.725498] [082/130] (511s left) gem_ccs (block-multicopy-compressed) [512.807583] Starting subtest: block-multicopy-compressed [512.809957] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy [512.847166] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.038s) [512.857430] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy [512.957135] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.109s) [512.968653] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy [512.972513] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s) [512.984131] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy [513.082773] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.109s) [513.094487] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy [513.098988] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.015s) [513.110545] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy [513.208574] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.108s) [513.220284] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy [513.225345] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s) [513.235510] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy [513.334588] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.108s) [513.335443] Subtest block-multicopy-compressed: SUCCESS (0.527s) [513.504107] [083/130] (511s left) kms_vblank (ts-continuation-idle) [513.706454] Starting subtest: ts-continuation-idle [513.707441] Starting dynamic subtest: pipe-A-DP-4 [514.031046] Dynamic subtest pipe-A-DP-4: SUCCESS (0.329s) [514.050369] Starting dynamic subtest: pipe-D-DP-4 [514.267460] Dynamic subtest pipe-D-DP-4: SUCCESS (0.232s) [514.268434] Subtest ts-continuation-idle: SUCCESS (0.568s) [514.509605] [084/130] (510s left) drm_fdinfo (busy-idle-check-all) [514.574981] Starting subtest: busy-idle-check-all [514.575977] Starting dynamic subtest: rcs0 [514.597736] Dynamic subtest rcs0: SKIP (0.021s) [514.608392] Starting dynamic subtest: bcs0 [514.610530] Dynamic subtest bcs0: SKIP (0.000s) [514.620658] Starting dynamic subtest: vcs0 [514.622770] Dynamic subtest vcs0: SKIP (0.000s) [514.632547] Starting dynamic subtest: vcs1 [514.634778] Dynamic subtest vcs1: SKIP (0.000s) [514.644779] Starting dynamic subtest: vecs0 [514.647020] Dynamic subtest vecs0: SKIP (0.000s) [514.657465] Starting dynamic subtest: vecs1 [514.659408] Dynamic subtest vecs1: SKIP (0.000s) [514.669090] Starting dynamic subtest: ccs0 [514.671133] Dynamic subtest ccs0: SKIP (0.001s) [514.673325] Subtest busy-idle-check-all: SKIP (0.031s) [514.712229] [085/130] (510s left) gem_exec_async (forked-writes) [514.819806] Starting subtest: forked-writes [514.820846] Starting dynamic subtest: rcs0 [514.887796] Dynamic subtest rcs0: SUCCESS (0.067s) [514.901122] Starting dynamic subtest: bcs0 [514.931526] Dynamic subtest bcs0: SUCCESS (0.043s) [514.944390] Starting dynamic subtest: vcs0 [514.974382] Dynamic subtest vcs0: SUCCESS (0.042s) [514.986389] Starting dynamic subtest: vcs1 [515.019495] Dynamic subtest vcs1: SUCCESS (0.044s) [515.032480] Starting dynamic subtest: vecs0 [515.062189] Dynamic subtest vecs0: SUCCESS (0.042s) [515.072578] Starting dynamic subtest: vecs1 [515.105749] Dynamic subtest vecs1: SUCCESS (0.042s) [515.116434] Starting dynamic subtest: ccs0 [515.148779] Dynamic subtest ccs0: SUCCESS (0.042s) [515.150179] Subtest forked-writes: SUCCESS (0.330s) [515.457801] [086/130] (509s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [515.661192] Starting subtest: fbcpsr-shrfb-scaledprimary [515.662989] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [515.819815] [087/130] (509s left) gem_cs_tlb (engines) [515.899477] Starting subtest: engines [515.900447] Starting dynamic subtest: rcs0 [518.053396] Dynamic subtest rcs0: SUCCESS (2.152s) [518.064564] Starting dynamic subtest: bcs0 [520.206438] Dynamic subtest bcs0: SUCCESS (2.152s) [520.216803] Starting dynamic subtest: vcs0 [522.361270] Dynamic subtest vcs0: SUCCESS (2.153s) [522.371641] Starting dynamic subtest: vcs1 [524.515261] Dynamic subtest vcs1: SUCCESS (2.153s) [524.525711] Starting dynamic subtest: vecs0 [526.668260] Dynamic subtest vecs0: SUCCESS (2.152s) [526.678751] Starting dynamic subtest: vecs1 [528.821905] Dynamic subtest vecs1: SUCCESS (2.152s) [528.832463] Starting dynamic subtest: ccs0 [530.975029] Dynamic subtest ccs0: SUCCESS (2.152s) [530.976194] Subtest engines: SUCCESS (15.075s) [531.095839] [088/130] (493s left) kms_flip (2x-flip-vs-suspend-interruptible) [531.299810] Starting subtest: 2x-flip-vs-suspend-interruptible [531.313584] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.013s) [531.422808] [089/130] (493s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [531.621681] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [531.622540] Starting dynamic subtest: pipe-A-DP-4 [531.632084] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [531.642468] Starting dynamic subtest: pipe-B-DP-4 [531.651977] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [531.662104] Starting dynamic subtest: pipe-C-DP-4 [531.671323] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [531.681337] Starting dynamic subtest: pipe-D-DP-4 [531.692438] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [531.694491] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s) [532.071793] [090/130] (493s left) gem_softpin (evict-snoop) [532.146710] Starting subtest: evict-snoop [532.148516] Subtest evict-snoop: SKIP (0.000s) [532.253885] [091/130] (492s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [532.464456] Starting subtest: yf-tiled-64bpp-rotate-270 [532.466273] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [532.618313] [092/130] (492s left) kms_3d [534.866624] [093/130] (490s left) gem_exec_params (dr4-dirt) [534.942946] Starting subtest: DR4-dirt [534.943968] Subtest DR4-dirt: SUCCESS (0.000s) [535.083983] [094/130] (490s left) i915_module_load (reload-no-display) [535.132076] Starting subtest: reload-no-display [539.188161] Subtest reload-no-display: SUCCESS (4.056s) [539.215006] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [539.217146] [095/130] (486s left) syncobj_timeline (wait-all-delayed-signal) [543.322018] Starting subtest: wait-all-delayed-signal [543.429828] Subtest wait-all-delayed-signal: SUCCESS (0.106s) [543.555797] [FACT syncobj_timeline (wait-all-delayed-signal)] new: kernel.kmod_is_loaded.amdgpu: true [543.555937] [FACT syncobj_timeline (wait-all-delayed-signal)] new: kernel.kmod_is_loaded.i915: true [543.556755] [FACT syncobj_timeline (wait-all-delayed-signal)] new: kernel.kmod_is_loaded.xe: true [543.558893] [096/130] (481s left) gem_partial_pwrite_pread (write-display) [543.643040] Subtest write-display: SKIP (0.000s) [543.716939] [097/130] (481s left) kms_prop_blob (blob-prop-lifetime) [543.790023] Starting subtest: blob-prop-lifetime [543.802450] Subtest blob-prop-lifetime: SUCCESS (0.012s) [543.919927] [098/130] (481s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [544.128405] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [545.376789] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.234s) [545.526086] [099/130] (480s left) kms_cursor_crc (cursor-random-256x256) [545.895341] Starting subtest: cursor-random-256x256 [545.900616] Starting dynamic subtest: pipe-A-DP-4 [550.334274] Dynamic subtest pipe-A-DP-4: SUCCESS (4.433s) [550.382164] Starting dynamic subtest: pipe-D-DP-4 [554.667421] Dynamic subtest pipe-D-DP-4: SUCCESS (4.294s) [554.668480] Subtest cursor-random-256x256: SUCCESS (8.772s) [555.061787] [100/130] (470s left) kms_invalid_mode (bad-vtotal) [555.261429] Starting subtest: bad-vtotal [555.262347] Starting dynamic subtest: pipe-A-DP-4 [555.344287] Dynamic subtest pipe-A-DP-4: SUCCESS (0.082s) [555.356861] Starting dynamic subtest: pipe-B-DP-4 [555.358096] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [555.368859] Starting dynamic subtest: pipe-C-DP-4 [555.370044] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [555.380615] Starting dynamic subtest: pipe-D-DP-4 [555.381590] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [555.382557] Subtest bad-vtotal: SUCCESS (0.092s) [555.586968] [101/130] (470s left) kms_draw_crc (fill-fb) [555.788334] Starting subtest: fill-fb [556.287860] Subtest fill-fb: SUCCESS (0.499s) [556.458135] [102/130] (469s left) gem_ppgtt (flink-and-close-vma-leak) [556.537962] Starting subtest: flink-and-close-vma-leak [556.600233] Subtest flink-and-close-vma-leak: SUCCESS (0.062s) [556.784271] [103/130] (469s left) kms_big_fb (linear-32bpp-rotate-0) [556.998445] Starting subtest: linear-32bpp-rotate-0 [558.738284] Subtest linear-32bpp-rotate-0: SUCCESS (1.738s) [558.911401] [104/130] (467s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [559.122046] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [559.123898] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [559.229406] [105/130] (466s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [559.430356] Starting subtest: cursorA-vs-flipB-varying-size [559.432161] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [559.511510] [106/130] (466s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [559.586347] Starting subtest: multi-wait-all-for-submit-available-signaled [559.587274] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [559.731152] [107/130] (466s left) gem_exec_reloc (basic-write-gtt) [559.811451] Subtest basic-write-gtt: SKIP (0.000s) [559.893789] [108/130] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [560.098796] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [560.100510] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [560.204111] [109/130] (465s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [560.408792] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [560.422963] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s) [560.520346] [110/130] (465s left) api_intel_bb (render) [560.593280] Starting subtest: render [560.594260] Starting dynamic subtest: render-none-512 [560.638376] Dynamic subtest render-none-512: SUCCESS (0.045s) [560.649665] Starting dynamic subtest: render-none-1024 [560.715646] Dynamic subtest render-none-1024: SUCCESS (0.076s) [560.725539] Starting dynamic subtest: render-x-512 [560.734512] Dynamic subtest render-x-512: SUCCESS (0.018s) [560.744295] Starting dynamic subtest: render-x-1024 [560.806433] Dynamic subtest render-x-1024: SUCCESS (0.071s) [560.816176] Starting dynamic subtest: render-y-512 [560.825243] Dynamic subtest render-y-512: SUCCESS (0.018s) [560.835136] Starting dynamic subtest: render-y-1024 [560.889186] Dynamic subtest render-y-1024: SUCCESS (0.063s) [560.890191] Subtest render: SUCCESS (0.297s) [560.988496] [111/130] (465s left) gem_exec_reloc (basic-write-wc) [561.074017] Subtest basic-write-wc: SKIP (0.000s) [561.181761] [112/130] (465s left) kms_chamelium_color (ctm-limited-range) [561.380250] Subtest ctm-limited-range: SKIP (0.000s) [561.441649] [113/130] (464s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [561.642470] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [561.643402] Starting dynamic subtest: pipe-A-valid-mode [564.116363] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.472s) [564.122136] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SUCCESS (2.476s) [564.387628] [114/130] (462s left) kms_psr (fbc-psr2-cursor-render) [564.591260] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [564.641659] [115/130] (461s left) kms_flip (2x-absolute-wf_vblank-interruptible) [564.848490] Starting subtest: 2x-absolute-wf_vblank-interruptible [564.862320] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.013s) [564.949225] [116/130] (461s left) gem_exec_create (basic) [565.032234] Starting subtest: basic [565.033202] Starting dynamic subtest: smem [567.134592] Dynamic subtest smem: SUCCESS (2.102s) [567.145676] Starting dynamic subtest: lmem0 [569.255653] Dynamic subtest lmem0: SUCCESS (2.120s) [569.256695] Subtest basic: SUCCESS (4.224s) [569.472985] [117/130] (457s left) gem_exec_store (basic) [569.552168] Starting subtest: basic [569.700733] Subtest basic: SUCCESS (0.148s) [569.995939] [118/130] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [570.208974] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [570.210755] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [570.359824] [119/130] (456s left) gem_userptr_blits (create-destroy-unsync) [570.442565] Subtest create-destroy-unsync: SKIP (0.000s) [570.652787] [120/130] (456s left) gem_mmap (basic) [570.722489] Subtest basic: SKIP (0.000s) [570.798499] [121/130] (456s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [570.869854] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [570.974650] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s) [571.120024] [122/130] (455s left) kms_pm_rpm (dpms-non-lpsp) [573.076652] Starting subtest: dpms-non-lpsp [573.260195] Subtest dpms-non-lpsp: SUCCESS (0.184s) [573.492587] [123/130] (453s left) kms_lease (page-flip-implicit-plane) [573.691803] Starting subtest: page-flip-implicit-plane [573.692720] Starting dynamic subtest: pipe-A-DP-4 [574.115966] Dynamic subtest pipe-A-DP-4: SUCCESS (0.423s) [574.130923] Starting dynamic subtest: pipe-B-DP-4 [574.441852] Dynamic subtest pipe-B-DP-4: SUCCESS (0.324s) [574.456462] Starting dynamic subtest: pipe-C-DP-4 [574.755192] Dynamic subtest pipe-C-DP-4: SUCCESS (0.311s) [574.766110] Starting dynamic subtest: pipe-D-DP-4 [575.063175] Dynamic subtest pipe-D-DP-4: SUCCESS (0.306s) [575.064092] Subtest page-flip-implicit-plane: SUCCESS (1.372s) [575.312490] [124/130] (451s left) perf (enable-disable) [575.651140] Starting subtest: enable-disable [575.652057] Starting dynamic subtest: 0-rcs0 [577.899920] Dynamic subtest 0-rcs0: SUCCESS (2.248s) [577.900937] Subtest enable-disable: SUCCESS (2.249s) [577.945791] [125/130] (449s left) gem_userptr_blits (invalid-mmap-offset-unsync) [578.030578] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [578.244455] [126/130] (448s left) kms_chamelium_hpd (hdmi-hpd) [578.529500] Subtest hdmi-hpd: SKIP (0.000s) [578.677321] [127/130] (448s left) kms_async_flips (async-flip-with-page-flip-events-atomic) [578.878681] Starting subtest: async-flip-with-page-flip-events-atomic [579.132210] Starting dynamic subtest: pipe-A-DP-4-4-mc-ccs [579.372689] Dynamic subtest pipe-A-DP-4-4-mc-ccs: SKIP (0.239s) [579.385036] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs-cc [579.534301] Dynamic subtest pipe-A-DP-4-4-rc-ccs-cc: SKIP (0.160s) [579.544738] Starting dynamic subtest: pipe-A-DP-4-4-rc-ccs [581.692457] Dynamic subtest pipe-A-DP-4-4-rc-ccs: SUCCESS (2.158s) [581.709389] Starting dynamic subtest: pipe-A-DP-4-4 [583.841974] Dynamic subtest pipe-A-DP-4-4: SUCCESS (2.147s) [583.856303] Starting dynamic subtest: pipe-A-DP-4-x [586.008473] Dynamic subtest pipe-A-DP-4-x: SUCCESS (2.165s) [586.019008] Starting dynamic subtest: pipe-A-DP-4-linear [588.177289] Dynamic subtest pipe-A-DP-4-linear: SUCCESS (2.167s) [588.393838] Starting dynamic subtest: pipe-B-DP-4-4-mc-ccs [588.592985] Dynamic subtest pipe-B-DP-4-4-mc-ccs: SKIP (0.208s) [588.604833] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs-cc [588.707233] Dynamic subtest pipe-B-DP-4-4-rc-ccs-cc: SKIP (0.113s) [588.717448] Starting dynamic subtest: pipe-B-DP-4-4-rc-ccs [590.848097] Dynamic subtest pipe-B-DP-4-4-rc-ccs: SUCCESS (2.141s) [590.858154] Starting dynamic subtest: pipe-B-DP-4-4 [592.998090] Dynamic subtest pipe-B-DP-4-4: SUCCESS (2.149s) [593.008808] Starting dynamic subtest: pipe-B-DP-4-x [595.148190] Dynamic subtest pipe-B-DP-4-x: SUCCESS (2.149s) [595.158726] Starting dynamic subtest: pipe-B-DP-4-linear [597.299273] Dynamic subtest pipe-B-DP-4-linear: SUCCESS (2.150s) [597.509060] Starting dynamic subtest: pipe-C-DP-4-4-mc-ccs [597.718428] Dynamic subtest pipe-C-DP-4-4-mc-ccs: SKIP (0.219s) [597.729344] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs-cc [597.851434] Dynamic subtest pipe-C-DP-4-4-rc-ccs-cc: SKIP (0.131s) [597.861927] Starting dynamic subtest: pipe-C-DP-4-4-rc-ccs [599.991583] Dynamic subtest pipe-C-DP-4-4-rc-ccs: SUCCESS (2.140s) [600.001819] Starting dynamic subtest: pipe-C-DP-4-4 [602.141926] Dynamic subtest pipe-C-DP-4-4: SUCCESS (2.149s) [602.152148] Starting dynamic subtest: pipe-C-DP-4-x [604.291838] Dynamic subtest pipe-C-DP-4-x: SUCCESS (2.149s) [604.302388] Starting dynamic subtest: pipe-C-DP-4-linear [606.426121] Dynamic subtest pipe-C-DP-4-linear: SUCCESS (2.133s) [606.611034] Starting dynamic subtest: pipe-D-DP-4-4-mc-ccs [606.824438] Dynamic subtest pipe-D-DP-4-4-mc-ccs: SKIP (0.228s) [606.835211] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs-cc [606.940256] Dynamic subtest pipe-D-DP-4-4-rc-ccs-cc: SKIP (0.114s) [606.950339] Starting dynamic subtest: pipe-D-DP-4-4-rc-ccs [609.080881] Dynamic subtest pipe-D-DP-4-4-rc-ccs: SUCCESS (2.140s) [609.091534] Starting dynamic subtest: pipe-D-DP-4-4 [611.230866] Dynamic subtest pipe-D-DP-4-4: SUCCESS (2.149s) [611.240895] Starting dynamic subtest: pipe-D-DP-4-x [613.388817] Dynamic subtest pipe-D-DP-4-x: SUCCESS (2.149s) [613.399077] Starting dynamic subtest: pipe-D-DP-4-linear [615.530592] Dynamic subtest pipe-D-DP-4-linear: SUCCESS (2.148s) [615.531942] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (36.652s) [615.945715] [128/130] (411s left) gem_sync (basic-each) [616.031250] Starting subtest: basic-each [618.245847] Subtest basic-each: SUCCESS (2.214s) [618.508680] [129/130] (408s left) gem_lmem_swapping (heavy-verify-multi) [621.268550] Starting subtest: heavy-verify-multi [621.269499] Starting dynamic subtest: lmem0 [634.102782] Dynamic subtest lmem0: SUCCESS (12.833s) [634.103706] Subtest heavy-verify-multi: SUCCESS (12.834s) [635.634825] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true [635.636830] [130/130] (391s left) kms_psr2_sf (pr-cursor-plane-update-sf) [637.191716] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [637.280134] [FACT kms_psr2_sf (pr-cursor-plane-update-sf)] new: kernel.kmod_is_loaded.i915: true [637.281422] Closing watchdogs Done.