[60.445996] Initializing watchdogs
[60.446062]   /dev/watchdog0
[60.460652] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.465343] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.468847] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.471686] [001/133] (960s left) kms_flip (2x-plain-flip-interruptible)
[60.572783] Starting subtest: 2x-plain-flip-interruptible
[60.584386] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[60.703280] [002/133] (960s left) kms_pm_rpm (modeset-non-lpsp-stress)
[62.242522] Starting subtest: modeset-non-lpsp-stress
[63.385581] Subtest modeset-non-lpsp-stress: SKIP (1.149s)
[63.755428] [003/133] (957s left) kms_plane_scaling (2x-scaler-multi-pipe)
[63.852668] Starting subtest: 2x-scaler-multi-pipe
[63.855200] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[63.949738] [004/133] (957s left) kms_vblank (query-busy)
[64.045753] Starting subtest: query-busy
[64.046763] Starting dynamic subtest: pipe-A-eDP-1
[65.938052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.899s)
[65.945069] Starting dynamic subtest: pipe-D-eDP-1
[68.490398] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[68.491158] Subtest query-busy: SUCCESS (4.459s)
[69.304452] [005/133] (951s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[69.428579] Starting subtest: 4-tiled-32bpp-rotate-270
[69.444879] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.023s)
[69.583135] [006/133] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[69.682982] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[69.684645] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[69.791855] [007/133] (951s left) kms_atomic_interruptible (atomic-setmode)
[69.879987] Starting subtest: atomic-setmode
[69.880855] Starting dynamic subtest: pipe-A-eDP-1
[76.767206] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.893s)
[76.768297] Subtest atomic-setmode: SUCCESS (6.895s)
[77.651381] [008/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[77.746812] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[77.748436] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[77.878399] [009/133] (943s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[77.973758] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[77.975381] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[78.092269] [010/133] (943s left) gem_mmap_gtt (basic-short)
[78.152969] Subtest basic-short: SKIP (0.000s)
[78.211905] [011/133] (943s left) i915_query (query-topology-coherent-slice-mask)
[78.265065] Starting subtest: query-topology-coherent-slice-mask
[78.266866] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[78.365167] [012/133] (942s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[78.470888] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[78.472892] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[78.545316] [013/133] (942s left) syncobj_wait (wait-all-complex)
[78.614036] Starting subtest: wait-all-complex
[78.836453] Subtest wait-all-complex: SUCCESS (0.213s)
[78.907557] [014/133] (942s left) prime_vgem (wait)
[79.021995] Starting subtest: wait
[79.022970] Starting dynamic subtest: rcs0
[79.078274] Dynamic subtest rcs0: SUCCESS (0.057s)
[79.083939] Starting dynamic subtest: bcs0
[79.164269] Dynamic subtest bcs0: SUCCESS (0.086s)
[79.169993] Starting dynamic subtest: vcs0
[79.209447] Dynamic subtest vcs0: SUCCESS (0.045s)
[79.214813] Starting dynamic subtest: vcs1
[79.255974] Dynamic subtest vcs1: SUCCESS (0.046s)
[79.261569] Starting dynamic subtest: vecs0
[79.300653] Dynamic subtest vecs0: SUCCESS (0.044s)
[79.306177] Starting dynamic subtest: ccs0
[79.345458] Dynamic subtest ccs0: SUCCESS (0.044s)
[79.346210] Subtest wait: SUCCESS (0.325s)
[79.474601] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[79.476245] [015/133] (941s left) kms_flip (absolute-wf_vblank-interruptible)
[79.582956] Starting subtest: absolute-wf_vblank-interruptible
[79.586139] Starting dynamic subtest: A-eDP1
[88.322053] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[88.330273] Starting dynamic subtest: B-eDP1
[97.057510] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[97.066233] Starting dynamic subtest: C-eDP1
[105.791020] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[105.800863] Starting dynamic subtest: D-eDP1
[114.491522] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[114.503456] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.908s)
[115.691673] [016/133] (905s left) sw_sync (sync_busy_fork)
[115.726062] Starting subtest: sync_busy_fork
[116.747942] Subtest sync_busy_fork: SUCCESS (1.012s)
[116.804371] [017/133] (904s left) i915_drm_fdinfo (virtual-busy-idle-all)
[116.839853] Starting subtest: virtual-busy-idle-all
[116.841740] Subtest virtual-busy-idle-all: SKIP (0.000s)
[116.915421] [018/133] (904s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[117.084461] Starting subtest: cursor-rapid-movement-64x64
[117.087956] Starting dynamic subtest: pipe-A-eDP-1
[117.629718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[117.656145] Starting dynamic subtest: pipe-D-eDP-1
[118.796595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[118.797568] Subtest cursor-rapid-movement-64x64: SUCCESS (1.712s)
[119.676035] [019/133] (901s left) kms_cursor_crc (cursor-suspend)
[119.820936] Starting subtest: cursor-suspend
[119.821997] Starting dynamic subtest: pipe-A-eDP-1
[154.771521] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.099s)
[154.778502] Starting dynamic subtest: pipe-D-eDP-1
[189.769601] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.573s)
[189.770458] Subtest cursor-suspend: SUCCESS (8.674s)
[195.663581] [020/133] (830s left) kms_psr (fbc-psr-cursor-plane-onoff)
[195.763127] Starting subtest: fbc-psr-cursor-plane-onoff
[195.764196] Starting dynamic subtest: eDP-1
[195.766153] Dynamic subtest eDP-1: SKIP (0.000s)
[195.775496] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[195.859582] [021/133] (830s left) kms_hdr (brightness-with-hdr)
[195.944417] Starting subtest: brightness-with-hdr
[195.946942] Subtest brightness-with-hdr: SKIP (0.000s)
[196.019573] [022/133] (830s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[196.395616] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[197.160481] [023/133] (829s left) i915_suspend (basic-s2idle-without-i915)
[197.194016] Starting subtest: basic-s2idle-without-i915
[218.731296] Subtest basic-s2idle-without-i915: SUCCESS (6.241s)
[222.889586] [024/133] (807s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[222.992851] Starting subtest: y-tiled-addfb-size-offset-overflow
[222.994696] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[223.105982] [025/133] (807s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[223.193946] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[223.194889] Starting dynamic subtest: pipe-A-eDP-1
[223.198424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.208518] Starting dynamic subtest: pipe-B-eDP-1
[223.212400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.220236] Starting dynamic subtest: pipe-C-eDP-1
[223.224165] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.233424] Starting dynamic subtest: pipe-D-eDP-1
[223.236716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.238247] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[225.406652] [026/133] (805s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[225.503279] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[225.504250] Starting dynamic subtest: pipe-A-default-mode
[228.208583] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[228.209464] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.749s)
[229.057076] [027/133] (801s left) gem_userptr_blits (stress-mm-invalidate-close)
[229.140511] Starting subtest: stress-mm-invalidate-close
[231.310584] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[231.409212] [028/133] (799s left) gem_userptr_blits (relocations)
[231.462379] Starting subtest: relocations
[231.464021] Subtest relocations: SKIP (0.001s)
[231.601585] [029/133] (799s left) syncobj_eventfd (timeline-wait-signaled)
[231.645383] Starting subtest: timeline-wait-signaled
[231.646434] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[231.769682] [030/133] (799s left) kms_rotation_crc (exhaust-fences)
[231.868432] Starting subtest: exhaust-fences
[231.870195] Subtest exhaust-fences: SKIP (0.000s)
[231.946182] [031/133] (799s left) kms_addfb_basic (addfb25-4-tiled)
[232.039822] Starting subtest: addfb25-4-tiled
[232.040719] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[232.156194] [032/133] (798s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[232.270759] Starting subtest: cursorB-vs-flipA-legacy
[232.273575] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[232.410256] [033/133] (798s left) gem_partial_pwrite_pread (reads-display)
[232.473510] Subtest reads-display: SKIP (0.000s)
[232.554486] [034/133] (798s left) gem_softpin (evict-active-interruptible)
[232.602062] Starting subtest: evict-active-interruptible
[232.607121] Subtest evict-active-interruptible: SUCCESS (0.005s)
[232.769742] [035/133] (798s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[232.862900] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[232.864622] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[232.939658] [036/133] (798s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[233.034244] Starting subtest: fb-8bpc-vs-panel-8bpc
[233.035176] Starting dynamic subtest: pipe-A-eDP-1
[234.470649] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s)
[234.471516] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.445s)
[235.272975] [037/133] (795s left) syncobj_timeline (wait-all-snapshot)
[235.325744] Starting subtest: wait-all-snapshot
[235.407343] Subtest wait-all-snapshot: SUCCESS (0.082s)
[235.489992] [038/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[235.584548] Starting subtest: fbcpsr-2p-rte
[235.586175] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[235.695011] [039/133] (795s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[235.784245] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[235.785307] Starting dynamic subtest: pipe-A-eDP-1
[236.012162] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.218s)
[236.019231] Starting dynamic subtest: pipe-B-eDP-1
[237.306837] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.300s)
[237.314145] Starting dynamic subtest: pipe-C-eDP-1
[238.501568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[238.508695] Starting dynamic subtest: pipe-D-eDP-1
[239.720716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[239.721626] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.941s)
[240.961077] [040/133] (790s left) sw_sync (sync_busy_fork_unixsocket)
[240.994332] Starting subtest: sync_busy_fork_unixsocket
[241.002414] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[241.059927] [041/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[241.164433] Starting subtest: psr-2p-primscrn-cur-indfb-move
[241.166202] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[241.271120] [042/133] (790s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[241.360905] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[241.362549] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[241.441493] [043/133] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[241.526200] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[241.527903] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[241.648985] [044/133] (789s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[241.752810] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[242.774487] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.024s)
[242.925809] [045/133] (788s left) kms_vblank (ts-continuation-modeset-hang)
[243.032710] Starting subtest: ts-continuation-modeset-hang
[243.033694] Starting dynamic subtest: pipe-A-eDP-1
[269.435771] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.409s)
[269.444309] Starting dynamic subtest: pipe-D-eDP-1
[294.394531] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[294.395410] Subtest ts-continuation-modeset-hang: SUCCESS (51.369s)
[295.272272] [046/133] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[295.376324] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[295.378061] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.501490] [047/133] (736s left) gem_spin_batch (engines)
[295.562705] Starting subtest: engines
[295.563698] Starting dynamic subtest: rcs0
[298.810534] Dynamic subtest rcs0: SUCCESS (3.236s)
[298.819692] Starting dynamic subtest: bcs0
[302.085001] Dynamic subtest bcs0: SUCCESS (3.237s)
[302.094226] Starting dynamic subtest: vcs0
[305.318647] Dynamic subtest vcs0: SUCCESS (3.232s)
[305.327972] Starting dynamic subtest: vcs1
[308.512842] Dynamic subtest vcs1: SUCCESS (3.237s)
[308.522030] Starting dynamic subtest: vecs0
[311.754981] Dynamic subtest vecs0: SUCCESS (3.233s)
[311.763834] Starting dynamic subtest: ccs0
[315.028453] Dynamic subtest ccs0: SUCCESS (3.236s)
[315.029413] Subtest engines: SUCCESS (19.424s)
[315.260834] [048/133] (716s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[315.326056] Subtest no-spare-fences-busy: SKIP (0.000s)
[315.406879] [049/133] (716s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[315.465449] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[315.466847] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[315.583567] [050/133] (716s left) gem_exec_schedule (submit-golden-slice)
[315.667715] Starting subtest: submit-golden-slice
[315.668616] Starting dynamic subtest: rcs0
[315.722805] Dynamic subtest rcs0: SUCCESS (0.055s)
[315.733532] Starting dynamic subtest: bcs0
[315.768700] Dynamic subtest bcs0: SUCCESS (0.046s)
[315.777609] Starting dynamic subtest: vcs0
[315.825122] Dynamic subtest vcs0: SUCCESS (0.056s)
[315.834200] Starting dynamic subtest: vcs1
[315.890477] Dynamic subtest vcs1: SUCCESS (0.064s)
[315.898346] Starting dynamic subtest: vecs0
[315.936764] Dynamic subtest vecs0: SUCCESS (0.045s)
[315.943945] Starting dynamic subtest: ccs0
[315.974212] Dynamic subtest ccs0: SUCCESS (0.038s)
[315.975473] Subtest submit-golden-slice: SUCCESS (0.308s)
[317.740827] [051/133] (713s left) perf (oa-formats)
[317.864371] Starting subtest: oa-formats
[317.865193] Starting dynamic subtest: 0-rcs0
[317.878496] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[317.885558] Starting dynamic subtest: 1-vcs1
[317.900722] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[317.901639] Subtest oa-formats: SUCCESS (0.037s)
[317.945982] [052/133] (713s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[318.032414] Starting subtest: plane-all-modeset-transition-fencing
[318.034113] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[318.111108] [053/133] (713s left) api_intel_allocator (open-vm)
[318.166921] Starting subtest: open-vm
[318.168276] Subtest open-vm: SUCCESS (0.003s)
[318.299834] [054/133] (713s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[318.381579] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[318.382418] Starting dynamic subtest: pipe-A-eDP-1
[319.220414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.836s)
[319.227226] Starting dynamic subtest: pipe-B-eDP-1
[320.773582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.552s)
[320.780475] Starting dynamic subtest: pipe-C-eDP-1
[322.271056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s)
[322.279987] Starting dynamic subtest: pipe-D-eDP-1
[323.807711] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.536s)
[323.808603] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.423s)
[324.982576] [055/133] (706s left) kms_panel_fitting (legacy)
[325.087746] Starting subtest: legacy
[325.088684] Starting dynamic subtest: pipe-A-eDP-1
[325.634193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[325.663282] Starting dynamic subtest: pipe-B-eDP-1
[327.308977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.654s)
[327.337386] Starting dynamic subtest: pipe-C-eDP-1
[328.861603] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.533s)
[328.888276] Starting dynamic subtest: pipe-D-eDP-1
[330.357767] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.476s)
[330.358768] Subtest legacy: SUCCESS (5.270s)
[331.621207] [056/133] (700s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[331.717792] Starting subtest: psr-rgb101010-draw-mmap-wc
[338.773226] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.055s)
[338.914310] [057/133] (692s left) gem_wait (busy)
[338.975586] Starting subtest: busy
[338.976513] Starting dynamic subtest: all-engines
[340.596834] Dynamic subtest all-engines: SUCCESS (1.611s)
[340.606222] Starting dynamic subtest: rcs0
[341.129695] Dynamic subtest rcs0: SUCCESS (0.540s)
[341.138839] Starting dynamic subtest: bcs0
[341.669090] Dynamic subtest bcs0: SUCCESS (0.539s)
[341.676801] Starting dynamic subtest: vcs0
[343.606965] Dynamic subtest vcs0: SUCCESS (1.926s)
[343.615638] Starting dynamic subtest: vcs1
[345.589286] Dynamic subtest vcs1: SUCCESS (1.980s)
[345.598151] Starting dynamic subtest: vecs0
[347.636938] Dynamic subtest vecs0: SUCCESS (2.045s)
[347.646350] Starting dynamic subtest: ccs0
[348.171648] Dynamic subtest ccs0: SUCCESS (0.541s)
[348.172734] Subtest busy: SUCCESS (9.196s)
[348.370285] [058/133] (683s left) perf_pmu (module-unload)
[348.456124] Starting subtest: module-unload
[355.173528] Subtest module-unload: FAIL (6.681s)
[355.194002] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[355.194726] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[355.196294] [059/133] (676s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[356.767255] Starting subtest: multi-wait-for-submit-available-signaled
[356.768212] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[356.864880] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[356.866305] [FACT syncobj_timeline (multi-wait-for-submit-available-signaled)] new: kernel.kmod_is_loaded.i915: true
[356.869541] [060/133] (675s left) i915_pm_rc6_residency (rc6-fence)
[356.937590] Starting subtest: rc6-fence
[356.975590] Starting dynamic subtest: gt0
[369.310534] Dynamic subtest gt0: SUCCESS (12.329s)
[369.319497] Starting dynamic subtest: gt1
[385.590686] Dynamic subtest gt1: SUCCESS (16.277s)
[385.592070] Subtest rc6-fence: SUCCESS (28.650s)
[385.665665] [061/133] (646s left) kms_plane_alpha_blend (alpha-transparent-fb)
[385.777593] Starting subtest: alpha-transparent-fb
[386.073855] Starting dynamic subtest: pipe-A-eDP-1
[386.727636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.654s)
[386.734098] Starting dynamic subtest: pipe-D-eDP-1
[388.082070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[388.082844] Subtest alpha-transparent-fb: SUCCESS (2.306s)
[388.972490] [062/133] (643s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[389.071792] Starting subtest: yf-tiled-64bpp-rotate-270
[389.073622] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[389.204212] [063/133] (642s left) perf (buffer-fill)
[389.323224] Starting subtest: buffer-fill
[389.324251] Starting dynamic subtest: 0-rcs0
[391.580009] Dynamic subtest 0-rcs0: SUCCESS (2.257s)
[391.587962] Starting dynamic subtest: 1-vcs1
[396.031258] Dynamic subtest 1-vcs1: SUCCESS (4.441s)
[396.032658] Subtest buffer-fill: SUCCESS (6.700s)
[396.066014] [064/133] (636s left) gen9_exec_parse (unaligned-access)
[396.116270] Subtest unaligned-access: SKIP (0.000s)
[396.183174] [065/133] (635s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[396.277181] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[396.279021] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[396.388825] [066/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[396.488114] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[396.489831] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[396.610178] [067/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[396.703208] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[396.704990] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[396.806213] [068/133] (635s left) gem_mmap_gtt (big-bo)
[396.860216] Subtest big-bo: SKIP (0.000s)
[396.918203] [069/133] (635s left) kms_lease (multimaster-lease)
[397.024303] Starting subtest: multimaster-lease
[397.028326] Subtest multimaster-lease: SUCCESS (0.004s)
[397.155679] [070/133] (635s left) gem_exec_params (cliprects_ptr-dirt)
[397.210459] Starting subtest: cliprects_ptr-dirt
[397.211327] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[397.325791] [071/133] (635s left) kms_chamelium_audio (dp-audio)
[397.702941] Subtest dp-audio: SKIP (0.000s)
[398.473875] [072/133] (633s left) kms_atomic (plane-overlay-legacy)
[398.565504] Starting subtest: plane-overlay-legacy
[398.566466] Starting dynamic subtest: pipe-A-eDP-1
[398.989624] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[398.990471] Subtest plane-overlay-legacy: SUCCESS (0.425s)
[399.853683] [073/133] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[399.943895] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[399.944736] Starting dynamic subtest: pipe-A-eDP-1
[399.952810] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.963845] Starting dynamic subtest: pipe-B-eDP-1
[399.972658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.981074] Starting dynamic subtest: pipe-C-eDP-1
[399.988941] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.995262] Starting dynamic subtest: pipe-D-eDP-1
[400.003681] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[400.005397] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[402.185929] [074/133] (630s left) gem_exec_reloc (basic-write-cpu)
[402.239598] Subtest basic-write-cpu: SKIP (0.000s)
[402.299422] [075/133] (630s left) gem_ctx_isolation (preservation-s3)
[402.363996] Starting subtest: preservation-S3
[402.365235] Starting dynamic subtest: rcs0
[419.340403] Dynamic subtest rcs0: SUCCESS (1.716s)
[419.349918] Starting dynamic subtest: bcs0
[436.324139] Dynamic subtest bcs0: SUCCESS (1.703s)
[436.333304] Starting dynamic subtest: vcs0
[453.334350] Dynamic subtest vcs0: SUCCESS (3.300s)
[453.342084] Starting dynamic subtest: vcs1
[471.338612] Dynamic subtest vcs1: SUCCESS (4.979s)
[471.346171] Starting dynamic subtest: vecs0
[489.341184] Dynamic subtest vecs0: SUCCESS (4.990s)
[489.348860] Starting dynamic subtest: ccs0
[507.341018] Dynamic subtest ccs0: SUCCESS (3.233s)
[507.342029] Subtest preservation-S3: SUCCESS (19.927s)
[513.621585] [076/133] (524s left) kms_psr (pr-primary-mmap-gtt)
[513.725134] Starting subtest: pr-primary-mmap-gtt
[513.727452] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[513.802847] [077/133] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[513.900533] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[536.692558] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.032s)
[536.858630] [078/133] (501s left) gem_ringfill (engines-basic)
[542.646730] Starting subtest: engines-basic
[542.647941] Starting dynamic subtest: rcs0
[542.700162] Dynamic subtest rcs0: SUCCESS (0.060s)
[542.712151] Starting dynamic subtest: bcs0
[542.745158] Dynamic subtest bcs0: SUCCESS (0.043s)
[542.755259] Starting dynamic subtest: vcs0
[542.788342] Dynamic subtest vcs0: SUCCESS (0.041s)
[542.798452] Starting dynamic subtest: vcs1
[542.833408] Dynamic subtest vcs1: SUCCESS (0.043s)
[542.845368] Starting dynamic subtest: vecs0
[542.876898] Dynamic subtest vecs0: SUCCESS (0.041s)
[542.887972] Starting dynamic subtest: ccs0
[542.921813] Dynamic subtest ccs0: SUCCESS (0.044s)
[542.924462] Subtest engines-basic: SUCCESS (0.285s)
[543.009962] [079/133] (495s left) gem_exec_fence (keep-in-fence)
[543.191749] Starting subtest: keep-in-fence
[543.192631] Starting dynamic subtest: rcs0
[543.243172] Dynamic subtest rcs0: SUCCESS (0.058s)
[543.254154] Starting dynamic subtest: bcs0
[543.297385] Dynamic subtest bcs0: SUCCESS (0.052s)
[543.309227] Starting dynamic subtest: vcs0
[544.695163] Dynamic subtest vcs0: SUCCESS (1.388s)
[544.703815] Starting dynamic subtest: vcs1
[546.678069] Dynamic subtest vcs1: SUCCESS (1.983s)
[546.686538] Starting dynamic subtest: vecs0
[548.662074] Dynamic subtest vecs0: SUCCESS (1.984s)
[548.670669] Starting dynamic subtest: ccs0
[548.879817] Dynamic subtest ccs0: SUCCESS (0.226s)
[548.881319] Subtest keep-in-fence: SUCCESS (5.705s)
[550.756410] [080/133] (487s left) syncobj_timeline (etime-single-wait-submitted)
[550.803276] Starting subtest: etime-single-wait-submitted
[550.912184] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[550.995838] [081/133] (487s left) fbdev (write)
[551.029750] Starting subtest: write
[551.403360] Subtest write: SUCCESS (0.363s)
[551.462555] [082/133] (487s left) gem_ctx_shared (create-shared-gtt)
[551.530879] Starting subtest: create-shared-gtt
[553.729518] Subtest create-shared-gtt: SUCCESS (2.154s)
[554.084517] [083/133] (484s left) kms_frontbuffer_tracking (basic)
[554.185869] Starting subtest: basic
[557.431608] Subtest basic: SUCCESS (3.249s)
[557.588767] [084/133] (481s left) gem_exec_balancer (bonded-semaphore)
[557.649434] Starting subtest: bonded-semaphore
[557.651203] Subtest bonded-semaphore: SKIP (0.000s)
[557.966830] [085/133] (480s left) kms_chamelium_edid (hdmi-edid-read)
[558.349589] Subtest hdmi-edid-read: SKIP (0.000s)
[559.119521] [086/133] (479s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[559.207857] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[566.025665] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.823s)
[566.194080] [087/133] (472s left) gem_exec_capture (capture-invisible)
[566.250118] Starting subtest: capture-invisible
[566.251058] Starting dynamic subtest: smem0
[566.252854] Dynamic subtest smem0: SKIP (0.000s)
[566.254585] Subtest capture-invisible: SKIP (0.001s)
[566.387868] [088/133] (472s left) kms_dsc (dsc-with-output-formats-with-bpc)
[566.491075] Starting subtest: dsc-with-output-formats-with-bpc
[566.520024] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[566.570711] [089/133] (472s left) api_intel_bb (purge-bb)
[566.633834] Starting subtest: purge-bb
[566.636959] Subtest purge-bb: SUCCESS (0.004s)
[566.785103] [090/133] (472s left) kms_flip (flip-vs-suspend-interruptible)
[566.887034] Starting subtest: flip-vs-suspend-interruptible
[566.889528] Starting dynamic subtest: A-eDP1
[601.315612] Dynamic subtest A-eDP1: SUCCESS (4.297s)
[601.329411] Starting dynamic subtest: B-eDP1
[635.318038] Dynamic subtest B-eDP1: SUCCESS (4.175s)
[635.330113] Starting dynamic subtest: C-eDP1
[669.323292] Dynamic subtest C-eDP1: SUCCESS (4.185s)
[669.337815] Starting dynamic subtest: D-eDP1
[703.320653] Dynamic subtest D-eDP1: SUCCESS (4.172s)
[703.325970] Subtest flip-vs-suspend-interruptible: SUCCESS (16.841s)
[709.655066] [091/133] (334s left) gem_shrink (reclaim)
[709.709681] Starting subtest: reclaim
[712.157528] Subtest reclaim: SUCCESS (2.459s)
[712.262601] [092/133] (331s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[712.374540] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[712.375387] Starting dynamic subtest: pipe-A-eDP-1
[718.197363] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.932s)
[718.206091] Starting dynamic subtest: pipe-B-eDP-1
[724.776867] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.634s)
[724.777694] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.569s)
[725.660143] [093/133] (318s left) kms_flip (flip-vs-fences)
[725.757747] Starting subtest: flip-vs-fences
[725.759541] Subtest flip-vs-fences: SKIP (0.000s)
[725.901060] [094/133] (318s left) kms_content_protection (srm)
[726.053681] Starting subtest: srm
[726.057272] Subtest srm: SKIP (0.002s)
[726.218526] [095/133] (318s left) kms_color (degamma)
[726.314184] Starting subtest: degamma
[726.315330] Starting dynamic subtest: pipe-A-eDP-1
[727.042742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[727.050494] Starting dynamic subtest: pipe-B-eDP-1
[728.474204] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[728.481747] Starting dynamic subtest: pipe-C-eDP-1
[729.851263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[729.859200] Starting dynamic subtest: pipe-D-eDP-1
[731.178265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[731.179039] Subtest degamma: SUCCESS (4.880s)
[731.974132] [096/133] (312s left) kms_atomic_transition (plane-toggle-modeset-transition)
[732.063433] Starting subtest: plane-toggle-modeset-transition
[732.064262] Starting dynamic subtest: pipe-A-eDP-1
[744.840829] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.788s)
[744.852483] Starting dynamic subtest: pipe-B-eDP-1
[757.264264] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.417s)
[757.268209] Subtest plane-toggle-modeset-transition: SUCCESS (25.211s)
[758.082533] [097/133] (286s left) prime_mmap (test_aperture_limit)
[758.143467] Starting subtest: test_aperture_limit
[758.144582] Starting dynamic subtest: test_aperture_limit-smem
[758.152055] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[758.154212] Subtest test_aperture_limit: SKIP (0.009s)
[758.230905] [098/133] (286s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[758.323796] Starting subtest: fbc-psr2-primary-mmap-gtt
[758.324936] Starting dynamic subtest: eDP-1
[758.326789] Dynamic subtest eDP-1: SKIP (0.000s)
[758.328577] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[758.406113] [099/133] (285s left) gem_pxp (reject-modify-context-protection-off-1)
[758.526626] Starting subtest: reject-modify-context-protection-off-1
[758.528004] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[758.641395] [100/133] (285s left) vgem_basic (bad-handle)
[758.671670] Starting subtest: bad-handle
[758.672785] Subtest bad-handle: SUCCESS (0.000s)
[758.735358] [101/133] (285s left) kms_psr (psr2-dpms)
[758.831726] Starting subtest: psr2-dpms
[758.832594] Starting dynamic subtest: eDP-1
[761.698987] Dynamic subtest eDP-1: SUCCESS (2.867s)
[761.699861] Subtest psr2-dpms: SUCCESS (2.868s)
[762.581361] [102/133] (281s left) core_setmaster (master-drop-set-user)
[762.674295] Starting subtest: master-drop-set-user
[762.687464] Subtest master-drop-set-user: SUCCESS (0.015s)
[762.732692] [103/133] (281s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[762.815454] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[762.817108] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[762.928572] [104/133] (281s left) gem_exec_fence (syncobj-wait)
[763.366727] Starting subtest: syncobj-wait
[765.294491] Subtest syncobj-wait: SUCCESS (1.918s)
[765.667195] [105/133] (278s left) gem_close_race (multigpu-basic-threads)
[765.738297] Starting subtest: multigpu-basic-threads
[765.740178] Subtest multigpu-basic-threads: SKIP (0.000s)
[766.001497] [106/133] (278s left) gem_exec_schedule (preemptive-hang)
[766.163970] Starting subtest: preemptive-hang
[766.165522] Starting dynamic subtest: rcs0
[775.416953] Dynamic subtest rcs0: SUCCESS (9.255s)
[775.429217] Starting dynamic subtest: bcs0
[784.430842] Dynamic subtest bcs0: SUCCESS (9.014s)
[784.440282] Starting dynamic subtest: vcs0
[793.393661] Dynamic subtest vcs0: SUCCESS (8.965s)
[793.403008] Starting dynamic subtest: vcs1
[802.416566] Dynamic subtest vcs1: SUCCESS (9.026s)
[802.424829] Starting dynamic subtest: vecs0
[811.441518] Dynamic subtest vecs0: SUCCESS (9.021s)
[811.452042] Starting dynamic subtest: ccs0
[820.400548] Dynamic subtest ccs0: SUCCESS (8.955s)
[820.401514] Subtest preemptive-hang: SUCCESS (54.243s)
[820.664119] [107/133] (223s left) gem_mmap_wc (write-wc-read-gtt)
[820.720024] Subtest write-wc-read-gtt: SKIP (0.000s)
[820.783455] [108/133] (223s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[820.875017] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[828.259233] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.383s)
[828.404712] [109/133] (216s left) gem_lmem_swapping (massive-random)
[828.443570] Subtest massive-random: SKIP (0.000s)
[828.485621] [110/133] (216s left) gem_exec_async (forked-writes)
[828.555679] Starting subtest: forked-writes
[828.556688] Starting dynamic subtest: rcs0
[828.582464] Dynamic subtest rcs0: SUCCESS (0.027s)
[828.591962] Starting dynamic subtest: bcs0
[828.606064] Dynamic subtest bcs0: SUCCESS (0.023s)
[828.617207] Starting dynamic subtest: vcs0
[828.627380] Dynamic subtest vcs0: SUCCESS (0.021s)
[828.636066] Starting dynamic subtest: vcs1
[828.650846] Dynamic subtest vcs1: SUCCESS (0.022s)
[828.658952] Starting dynamic subtest: vecs0
[828.673508] Dynamic subtest vecs0: SUCCESS (0.022s)
[828.682993] Starting dynamic subtest: ccs0
[828.697631] Dynamic subtest ccs0: SUCCESS (0.023s)
[828.698482] Subtest forked-writes: SUCCESS (0.142s)
[828.954995] [111/133] (215s left) gem_exec_params (secure-non-master)
[829.015633] Starting subtest: secure-non-master
[829.017446] Subtest secure-non-master: SKIP (0.000s)
[829.137695] [112/133] (215s left) kms_invalid_mode (uint-max-clock)
[829.222495] Starting subtest: uint-max-clock
[829.223363] Starting dynamic subtest: pipe-A-eDP-1
[829.505321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[829.514159] Starting dynamic subtest: pipe-B-eDP-1
[829.515028] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[829.522245] Starting dynamic subtest: pipe-C-eDP-1
[829.523086] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[829.530399] Starting dynamic subtest: pipe-D-eDP-1
[829.531175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[829.532048] Subtest uint-max-clock: SUCCESS (0.289s)
[830.333459] [113/133] (214s left) perf (invalid-create-userspace-config)
[830.439250] Starting subtest: invalid-create-userspace-config
[830.440165] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[830.472227] [114/133] (214s left) gem_mmap_offset (mmap-unmap)
[830.515835] Starting subtest: mmap-unmap
[830.516767] Starting dynamic subtest: smem0
[854.345248] Dynamic subtest smem0: SUCCESS (23.821s)
[854.346418] Subtest mmap-unmap: SUCCESS (23.823s)
[854.498962] [115/133] (190s left) gem_exec_suspend (basic-s0)
[854.561945] Starting subtest: basic-S0
[854.563037] Starting dynamic subtest: smem
[875.861916] Dynamic subtest smem: SUCCESS (6.694s)
[875.863582] Subtest basic-S0: SUCCESS (6.696s)
[881.052523] [116/133] (168s left) prime_self_import (basic-with_one_bo)
[881.085388] Starting subtest: basic-with_one_bo
[881.118346] Subtest basic-with_one_bo: SUCCESS (0.034s)
[881.249362] [117/133] (168s left) kms_cursor_crc (cursor-onscreen-max-size)
[881.554712] Starting subtest: cursor-onscreen-max-size
[881.557344] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[881.730884] [118/133] (168s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[881.832522] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[881.834130] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[881.935613] [119/133] (168s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[882.015116] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[882.016046] Starting dynamic subtest: pipe-A
[882.343928] Dynamic subtest pipe-A: SUCCESS (0.338s)
[882.351460] Starting dynamic subtest: pipe-B
[883.759377] Dynamic subtest pipe-B: SUCCESS (1.448s)
[883.767233] Starting dynamic subtest: pipe-C
[885.175596] Dynamic subtest pipe-C: SUCCESS (1.444s)
[885.184927] Starting dynamic subtest: pipe-D
[886.578743] Dynamic subtest pipe-D: SUCCESS (1.426s)
[886.579669] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.660s)
[887.763246] [120/133] (162s left) kms_addfb_basic (small-bo)
[887.858279] Starting subtest: small-bo
[887.859185] Subtest small-bo: SUCCESS (0.000s)
[887.971121] [121/133] (162s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[888.057623] Starting subtest: fbc-rgb101010-draw-mmap-wc
[892.610505] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.596s)
[893.717375] [122/133] (156s left) kms_psr (psr-primary-blt)
[893.809535] Starting subtest: psr-primary-blt
[893.810409] Starting dynamic subtest: eDP-1
[895.502607] Dynamic subtest eDP-1: SUCCESS (1.701s)
[895.503742] Subtest psr-primary-blt: SUCCESS (1.703s)
[896.372009] [123/133] (153s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[896.459493] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[896.460283] Starting dynamic subtest: pipe-A-eDP-1
[896.581772] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[896.591206] Starting dynamic subtest: pipe-B-eDP-1
[897.733621] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s)
[897.735431] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.280s)
[899.030067] [124/133] (151s left) kms_pm_rpm (basic-rte)
[899.059282] Starting subtest: basic-rte
[902.403443] Subtest basic-rte: SUCCESS (3.355s)
[904.215550] [125/133] (146s left) gen9_exec_parse (batch-without-end)
[904.279231] Subtest batch-without-end: SKIP (0.000s)
[904.357004] [126/133] (145s left) gem_workarounds (basic-read-fd)
[904.423011] Starting subtest: basic-read-fd
[904.434062] Subtest basic-read-fd: SUCCESS (0.011s)
[904.595403] [127/133] (145s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[904.681007] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[904.682588] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[904.764224] [128/133] (145s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[904.861553] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[904.863333] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[904.988925] [129/133] (145s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[905.089513] Starting subtest: x-tiled-16bpp-rotate-0
[906.345507] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.258s)
[906.488254] [130/133] (143s left) gem_lmem_swapping (random-engines)
[906.528400] Subtest random-engines: SKIP (0.000s)
[906.568926] [131/133] (143s left) perf (global-sseu-config)
[906.653548] Starting subtest: global-sseu-config
[906.655534] Subtest global-sseu-config: SKIP (0.000s)
[906.696967] [132/133] (143s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[906.790937] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[907.605191] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[907.762541] [133/133] (142s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[907.821708] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[907.822604] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[907.938133] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_atomic_interruptible
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: sw_sync
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_hdr
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: i915_suspend
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: syncobj_eventfd
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_dither
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: gem_fenced_exec_thrash
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_panel_fitting
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_wait
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: i915_pm_rc6_residency
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_chamelium_audio
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: gem_ctx_isolation
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ringfill
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_capture
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_shrink
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_content_protection
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: prime_mmap
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: core_setmaster
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: gem_close_race
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: gem_exec_async
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: gem_exec_suspend
results: parsing output: 115/ for test: prime_self_import
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_workarounds
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_wait
Done.